builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1498958791.27 results: success (0) revision: f71131f619f24d9cc2e6441d886c6d626fffc6d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:31.271096) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:31.271997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:31.272267) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:31.335742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:31.336075) ========= 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=923d835db2ba3686ebe126b700000192-1498952097.417011-475883730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-01 18:26:31-- 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% 40.1M=0s 2017-07-01 18:26:31 (40.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.188555 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:31.577156) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:31.577451) ========= 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=923d835db2ba3686ebe126b700000192-1498952097.417011-475883730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.089954 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:31.678778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:31.679137) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f71131f619f24d9cc2e6441d886c6d626fffc6d4 --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 f71131f619f24d9cc2e6441d886c6d626fffc6d4 --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=923d835db2ba3686ebe126b700000192-1498952097.417011-475883730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-01 18:26:31,866 truncating revision to first 12 chars 2017-07-01 18:26:31,866 Setting DEBUG logging. 2017-07-01 18:26:31,866 attempt 1/10 2017-07-01 18:26:31,866 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f71131f619f2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-01 18:26:32,173 unpacking tar archive at: mozilla-central-f71131f619f2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615017 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:32.313699) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:32.314006) ========= script_repo_revision: f71131f619f24d9cc2e6441d886c6d626fffc6d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:32.314385) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:32.314706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-01 18:26:32.322931) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-07-01 18:26:32.323284) ========= /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=923d835db2ba3686ebe126b700000192-1498952097.417011-475883730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:26:32 INFO - MultiFileLogger online at 20170701 18:26:32 in /builds/slave/test 18:26:32 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 18:26:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:26:32 INFO - {'append_to_log': False, 18:26:32 INFO - 'base_work_dir': '/builds/slave/test', 18:26:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:26:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:26:32 INFO - 'branch': 'Firefox-Non-PGO', 18:26:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:26:32 INFO - 'code_coverage': False, 18:26:32 INFO - 'config_files': ('talos/linux_config.py',), 18:26:32 INFO - 'default_actions': ('clobber', 18:26:32 INFO - 'read-buildbot-config', 18:26:32 INFO - 'download-and-extract', 18:26:32 INFO - 'populate-webroot', 18:26:32 INFO - 'create-virtualenv', 18:26:32 INFO - 'install', 18:26:32 INFO - 'setup-mitmproxy', 18:26:32 INFO - 'run-tests'), 18:26:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:26:32 INFO - 'disable_ccov_upload': False, 18:26:32 INFO - 'download_minidump_stackwalk': True, 18:26:32 INFO - 'download_symbols': 'ondemand', 18:26:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:26:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:26:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:26:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:26:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:26:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:26:32 INFO - 'gecko_profile': False, 18:26:32 INFO - 'gecko_profile_interval': 0, 18:26:32 INFO - 'installer_path': 'installer.exe', 18:26:32 INFO - 'log_level': 'info', 18:26:32 INFO - 'log_name': 'talos', 18:26:32 INFO - 'log_to_console': True, 18:26:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:26:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:26:32 INFO - 'opt_config_files': (), 18:26:32 INFO - 'pip_index': False, 18:26:32 INFO - 'suite': 'dromaeojs-e10s', 18:26:32 INFO - 'system_bits': '32', 18:26:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:26:32 INFO - 'title': 'talos-linux64-ix-007', 18:26:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:26:32 INFO - 'use_talos_json': True, 18:26:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:26:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:26:32 INFO - 'work_dir': 'build'} 18:26:32 INFO - [mozharness: 2017-07-02 01:26:32.734616Z] Running clobber step. 18:26:32 INFO - Running pre-action listener: _resource_record_pre_action 18:26:32 INFO - Running main action method: clobber 18:26:32 INFO - rmtree: /builds/slave/test/build 18:26:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:26:34 INFO - Running post-action listener: _resource_record_post_action 18:26:34 INFO - [mozharness: 2017-07-02 01:26:34.779744Z] Finished clobber step (success) 18:26:34 INFO - [mozharness: 2017-07-02 01:26:34.779845Z] Running read-buildbot-config step. 18:26:34 INFO - Running pre-action listener: _resource_record_pre_action 18:26:34 INFO - Running main action method: read_buildbot_config 18:26:34 INFO - Using buildbot properties: 18:26:34 INFO - { 18:26:34 INFO - "project": "", 18:26:34 INFO - "product": "firefox", 18:26:34 INFO - "who": "philringnalda@gmail.com", 18:26:34 INFO - "installer_path": "public/build/target.tar.bz2", 18:26:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:26:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:26:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:26:34 INFO - "stage_platform": "linux64", 18:26:34 INFO - "basedir": "/builds/slave/test", 18:26:34 INFO - "buildnumber": 989, 18:26:34 INFO - "platform": "ubuntu64_hw", 18:26:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:26:34 INFO - "slavebuilddir": "test", 18:26:34 INFO - "taskId": "bY-DPjz1R-iTPBH0_QvhHA", 18:26:34 INFO - "branch": "mozilla-central", 18:26:34 INFO - "script_repo_revision": "production", 18:26:34 INFO - "revision": "f71131f619f24d9cc2e6441d886c6d626fffc6d4", 18:26:34 INFO - "slavename": "talos-linux64-ix-007", 18:26:34 INFO - "repo_path": "mozilla-central" 18:26:34 INFO - } 18:26:34 INFO - Finding installer, test and symbols from parent task. 18:26:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bY-DPjz1R-iTPBH0_QvhHA'}, attempt #1 18:26:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bY-DPjz1R-iTPBH0_QvhHA'}, attempt #1 18:26:35 INFO - Task dependencies: dRaCMvOKTPSLvRajFdoGaw 18:26:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw'}, attempt #1 18:26:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.tar.bz2 18:26:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/test_packages.json 18:26:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.crashreporter-symbols.zip 18:26:36 INFO - Running post-action listener: _resource_record_post_action 18:26:36 INFO - [mozharness: 2017-07-02 01:26:36.130118Z] Finished read-buildbot-config step (success) 18:26:36 INFO - [mozharness: 2017-07-02 01:26:36.130340Z] Running download-and-extract step. 18:26:36 INFO - Running pre-action listener: _resource_record_pre_action 18:26:36 INFO - Running main action method: download_and_extract 18:26:36 INFO - mkdir: /builds/slave/test/build/tests 18:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:36 INFO - trying https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.test_packages.json 18:26:36 INFO - Downloading https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:26:36 INFO - Downloaded 989 bytes. 18:26:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:26:36 INFO - Using the following test package requirements: 18:26:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:26:36 INFO - u'common': [u'target.common.tests.zip'], 18:26:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:26:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:26:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:26:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:26:36 INFO - u'mozbase': [u'target.common.tests.zip'], 18:26:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:26:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:26:36 INFO - u'web-platform': [u'target.common.tests.zip', 18:26:36 INFO - u'target.web-platform.tests.tar.gz'], 18:26:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:26:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:26:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.common.tests.zip 18:26:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:26:36 INFO - Fetch https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.common.tests.zip into memory 18:26:37 INFO - Content-Length response header: 67761677 18:26:37 INFO - Bytes received: 67761677 18:26:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:26:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.common.tests.zip 18:26:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:26:49 INFO - Fetch https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.common.tests.zip into memory 18:26:50 INFO - Content-Length response header: 67761677 18:26:50 INFO - Bytes received: 67761677 18:27:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.talos.tests.zip 18:27:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:27:02 INFO - Fetch https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.talos.tests.zip into memory 18:27:03 INFO - Content-Length response header: 14442174 18:27:03 INFO - Bytes received: 14442174 18:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:03 INFO - trying https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.tar.bz2 18:27:03 INFO - Downloading https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:27:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:27:06 INFO - Downloaded 61889735 bytes. 18:27:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.tar.bz2 18:27:06 INFO - mkdir: /builds/slave/test/properties 18:27:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:27:06 INFO - Writing to file /builds/slave/test/properties/build_url 18:27:06 INFO - Contents: 18:27:06 INFO - build_url:https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.tar.bz2 18:27:06 INFO - Running post-action listener: _resource_record_post_action 18:27:06 INFO - Running post-action listener: set_extra_try_arguments 18:27:06 INFO - [mozharness: 2017-07-02 01:27:06.088110Z] Finished download-and-extract step (success) 18:27:06 INFO - [mozharness: 2017-07-02 01:27:06.088337Z] Running populate-webroot step. 18:27:06 INFO - Running pre-action listener: _resource_record_pre_action 18:27:06 INFO - Running main action method: populate_webroot 18:27:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:27:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:27:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:27:06 INFO - '--tppagecycles', 18:27:06 INFO - '7'], 18:27:06 INFO - 'tests': ['tsvgm']}}, 18:27:06 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:27:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:27:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:27:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:27:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:27:06 INFO - 'talos_options': ['--disable-e10s'], 18:27:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:27:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:27:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:27:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:27:06 INFO - 'talos_options': ['--disable-e10s'], 18:27:06 INFO - 'tests': ['damp', 'tps']}, 18:27:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:27:06 INFO - 'tests': ['damp', 'tps']}, 18:27:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:27:06 INFO - 'tests': ['dromaeo_dom']}, 18:27:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:27:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:27:06 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:27:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:27:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:27:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:27:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:27:06 INFO - 'tests': ['a11yr', 18:27:06 INFO - 'ts_paint', 18:27:06 INFO - 'tpaint', 18:27:06 INFO - 'sessionrestore', 18:27:06 INFO - 'sessionrestore_no_auto_restore', 18:27:06 INFO - 'tabpaint']}, 18:27:06 INFO - 'other-e10s': {'tests': ['a11yr', 18:27:06 INFO - 'ts_paint', 18:27:06 INFO - 'tpaint', 18:27:06 INFO - 'sessionrestore', 18:27:06 INFO - 'sessionrestore_no_auto_restore', 18:27:06 INFO - 'tabpaint']}, 18:27:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:27:06 INFO - 'ts_paint', 18:27:06 INFO - 'tpaint', 18:27:06 INFO - 'sessionrestore', 18:27:06 INFO - 'sessionrestore_no_auto_restore', 18:27:06 INFO - 'tabpaint']}, 18:27:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:27:06 INFO - 'ts_paint', 18:27:06 INFO - 'tpaint', 18:27:06 INFO - 'sessionrestore', 18:27:06 INFO - 'sessionrestore_no_auto_restore', 18:27:06 INFO - 'tabpaint']}, 18:27:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:27:06 INFO - 'tests': ['a11yr', 18:27:06 INFO - 'ts_paint', 18:27:06 INFO - 'tpaint', 18:27:06 INFO - 'sessionrestore', 18:27:06 INFO - 'sessionrestore_no_auto_restore', 18:27:06 INFO - 'tabpaint']}, 18:27:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:27:06 INFO - 'tests': ['a11yr', 18:27:06 INFO - 'ts_paint', 18:27:06 INFO - 'tpaint', 18:27:06 INFO - 'sessionrestore', 18:27:06 INFO - 'sessionrestore_no_auto_restore', 18:27:06 INFO - 'tabpaint']}, 18:27:06 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:27:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:27:06 INFO - 'bloom_basic_ref']}, 18:27:06 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:27:06 INFO - 'talos_options': ['--mitmproxy', 18:27:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:27:06 INFO - '--firstNonBlankPaint'], 18:27:06 INFO - 'tests': ['quantum_pageload_google', 18:27:06 INFO - 'quantum_pageload_youtube', 18:27:06 INFO - 'quantum_pageload_amazon', 18:27:06 INFO - 'quantum_pageload_facebook']}, 18:27:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:27:06 INFO - 'tests': ['tsvgx', 18:27:06 INFO - 'tsvgr_opacity', 18:27:06 INFO - 'tart', 18:27:06 INFO - 'tscrollx', 18:27:06 INFO - 'cart', 18:27:06 INFO - 'tsvg_static']}, 18:27:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:27:06 INFO - 'tsvgr_opacity', 18:27:06 INFO - 'tart', 18:27:06 INFO - 'tscrollx', 18:27:06 INFO - 'cart', 18:27:06 INFO - 'tsvg_static']}, 18:27:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:27:06 INFO - 'talos_options': ['--disable-e10s'], 18:27:06 INFO - 'tests': ['tp5o']}, 18:27:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:27:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:27:06 INFO - 'talos_options': ['--disable-e10s', 18:27:06 INFO - '--xperf_path', 18:27:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:27:06 INFO - 'tests': ['tp5n']}, 18:27:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:27:06 INFO - 'talos_options': ['--xperf_path', 18:27:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:27:06 INFO - 'tests': ['tp5n']}}, 18:27:06 INFO - 'talos.zip': {'path': '', 18:27:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:27:06 INFO - Running post-action listener: _resource_record_post_action 18:27:06 INFO - [mozharness: 2017-07-02 01:27:06.106040Z] Finished populate-webroot step (success) 18:27:06 INFO - [mozharness: 2017-07-02 01:27:06.106130Z] Running create-virtualenv step. 18:27:06 INFO - Running pre-action listener: _resource_record_pre_action 18:27:06 INFO - Running main action method: create_virtualenv 18:27:06 INFO - Creating virtualenv /builds/slave/test/build/venv 18:27:06 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 18:27:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:27:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:27:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:27:06 INFO - Using real prefix '/usr' 18:27:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:27:06 INFO - Installing distribute.............................................................................................................................................................................................done. 18:27:08 INFO - Installing pip.................done. 18:27:08 INFO - Return code: 0 18:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:27:09 INFO - Reading from file tmpfile_stdout 18:27:09 INFO - Output received: 18:27:09 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) 18:27:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:27:09 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')]} 18:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:09 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')]} 18:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:09 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 0xab61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24980>, '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 0xe25730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25bc0>, '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': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', '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 18:27:09 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 18:27:09 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 18:27:09 INFO - Using env: {'DISPLAY': ':0', 18:27:09 INFO - 'HOME': '/home/cltbld', 18:27:09 INFO - 'LANG': 'en_US.UTF-8', 18:27:09 INFO - 'LANGUAGE': 'en_US:en', 18:27:09 INFO - 'LOGNAME': 'cltbld', 18:27:09 INFO - 'MAIL': '/var/mail/cltbld', 18:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:09 INFO - 'MOZ_NO_REMOTE': '1', 18:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:09 INFO - 'NO_EM_RESTART': '1', 18:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:09 INFO - 'PWD': '/builds/slave/test', 18:27:09 INFO - 'SHELL': '/bin/bash', 18:27:09 INFO - 'SHLVL': '1', 18:27:09 INFO - 'TERM': 'linux', 18:27:09 INFO - 'TMOUT': '86400', 18:27:09 INFO - 'USER': 'cltbld', 18:27:09 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', 18:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:09 INFO - '_': '/tools/buildbot/bin/python'} 18:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:09 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 18:27:09 INFO - Cleaning up... 18:27:09 INFO - Return code: 0 18:27:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:27:09 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')]} 18:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:09 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')]} 18:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:09 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 0xab61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24980>, '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 0xe25730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25bc0>, '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': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', '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 18:27:09 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 18:27:09 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 18:27:09 INFO - Using env: {'DISPLAY': ':0', 18:27:09 INFO - 'HOME': '/home/cltbld', 18:27:09 INFO - 'LANG': 'en_US.UTF-8', 18:27:09 INFO - 'LANGUAGE': 'en_US:en', 18:27:09 INFO - 'LOGNAME': 'cltbld', 18:27:09 INFO - 'MAIL': '/var/mail/cltbld', 18:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:09 INFO - 'MOZ_NO_REMOTE': '1', 18:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:09 INFO - 'NO_EM_RESTART': '1', 18:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:09 INFO - 'PWD': '/builds/slave/test', 18:27:09 INFO - 'SHELL': '/bin/bash', 18:27:09 INFO - 'SHLVL': '1', 18:27:09 INFO - 'TERM': 'linux', 18:27:09 INFO - 'TMOUT': '86400', 18:27:09 INFO - 'USER': 'cltbld', 18:27:09 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', 18:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:09 INFO - '_': '/tools/buildbot/bin/python'} 18:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:09 INFO - Downloading/unpacking psutil>=3.1.1 18:27:09 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 18:27:09 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 18:27:09 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 18:27:09 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 18:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:27:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:27:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:27:10 INFO - Installing collected packages: psutil 18:27:10 INFO - Running setup.py install for psutil 18:27:10 INFO - building 'psutil._psutil_linux' extension 18:27:10 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 18:27:11 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 18:27:11 INFO - building 'psutil._psutil_posix' extension 18:27:11 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 18:27:11 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 18:27:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:27:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:27:11 INFO - Successfully installed psutil 18:27:11 INFO - Cleaning up... 18:27:11 INFO - Return code: 0 18:27:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:27: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')]} 18:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27: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')]} 18:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:11 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 0xab61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24980>, '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 0xe25730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25bc0>, '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': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', '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 18:27:11 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 18:27:11 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 18:27:11 INFO - Using env: {'DISPLAY': ':0', 18:27:11 INFO - 'HOME': '/home/cltbld', 18:27:12 INFO - 'LANG': 'en_US.UTF-8', 18:27:12 INFO - 'LANGUAGE': 'en_US:en', 18:27:12 INFO - 'LOGNAME': 'cltbld', 18:27:12 INFO - 'MAIL': '/var/mail/cltbld', 18:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:12 INFO - 'MOZ_NO_REMOTE': '1', 18:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:12 INFO - 'NO_EM_RESTART': '1', 18:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:12 INFO - 'PWD': '/builds/slave/test', 18:27:12 INFO - 'SHELL': '/bin/bash', 18:27:12 INFO - 'SHLVL': '1', 18:27:12 INFO - 'TERM': 'linux', 18:27:12 INFO - 'TMOUT': '86400', 18:27:12 INFO - 'USER': 'cltbld', 18:27:12 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', 18:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:12 INFO - '_': '/tools/buildbot/bin/python'} 18:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:27:12 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 18:27:12 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 18:27:12 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 18:27:12 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 18:27:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:27:13 INFO - Installing collected packages: mozsystemmonitor 18:27:13 INFO - Running setup.py install for mozsystemmonitor 18:27:13 INFO - Successfully installed mozsystemmonitor 18:27:13 INFO - Cleaning up... 18:27:13 INFO - Return code: 0 18:27:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:13 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 0xab61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24980>, '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 0xe25730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25bc0>, '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': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', '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 18:27:13 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 18:27:13 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 18:27:13 INFO - Using env: {'DISPLAY': ':0', 18:27:13 INFO - 'HOME': '/home/cltbld', 18:27:13 INFO - 'LANG': 'en_US.UTF-8', 18:27:13 INFO - 'LANGUAGE': 'en_US:en', 18:27:13 INFO - 'LOGNAME': 'cltbld', 18:27:13 INFO - 'MAIL': '/var/mail/cltbld', 18:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:13 INFO - 'MOZ_NO_REMOTE': '1', 18:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:13 INFO - 'NO_EM_RESTART': '1', 18:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:13 INFO - 'PWD': '/builds/slave/test', 18:27:13 INFO - 'SHELL': '/bin/bash', 18:27:13 INFO - 'SHLVL': '1', 18:27:13 INFO - 'TERM': 'linux', 18:27:13 INFO - 'TMOUT': '86400', 18:27:13 INFO - 'USER': 'cltbld', 18:27:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', 18:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:13 INFO - '_': '/tools/buildbot/bin/python'} 18:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:13 INFO - Downloading/unpacking jsonschema==2.5.1 18:27:13 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 18:27:13 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 18:27:13 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 18:27:13 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 18:27:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:27:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:27:14 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 18:27:14 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 18:27:14 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 18:27:14 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 18:27:14 INFO - Downloading functools32-3.2.3-2.tar.gz 18:27:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:27:14 INFO - warning: no files found matching '*.txt' 18:27:14 INFO - no previously-included directories found matching 'build' 18:27:14 INFO - no previously-included directories found matching 'dist' 18:27:14 INFO - no previously-included directories found matching '.git*' 18:27:14 INFO - Installing collected packages: jsonschema, functools32 18:27:15 INFO - Running setup.py install for functools32 18:27:15 INFO - warning: no files found matching '*.txt' 18:27:15 INFO - no previously-included directories found matching 'build' 18:27:15 INFO - no previously-included directories found matching 'dist' 18:27:15 INFO - no previously-included directories found matching '.git*' 18:27:15 INFO - Successfully installed jsonschema functools32 18:27:15 INFO - Cleaning up... 18:27:15 INFO - Return code: 0 18:27:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:15 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 0xab61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24980>, '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 0xe25730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25bc0>, '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': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', '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 18:27:15 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 18:27:15 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 18:27:15 INFO - Using env: {'DISPLAY': ':0', 18:27:15 INFO - 'HOME': '/home/cltbld', 18:27:15 INFO - 'LANG': 'en_US.UTF-8', 18:27:15 INFO - 'LANGUAGE': 'en_US:en', 18:27:15 INFO - 'LOGNAME': 'cltbld', 18:27:15 INFO - 'MAIL': '/var/mail/cltbld', 18:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:15 INFO - 'MOZ_NO_REMOTE': '1', 18:27:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:15 INFO - 'NO_EM_RESTART': '1', 18:27:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:15 INFO - 'PWD': '/builds/slave/test', 18:27:15 INFO - 'SHELL': '/bin/bash', 18:27:15 INFO - 'SHLVL': '1', 18:27:15 INFO - 'TERM': 'linux', 18:27:15 INFO - 'TMOUT': '86400', 18:27:15 INFO - 'USER': 'cltbld', 18:27:15 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', 18:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:15 INFO - '_': '/tools/buildbot/bin/python'} 18:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:27:15 INFO - Cleaning up... 18:27:15 INFO - Return code: 0 18:27:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:15 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 0xab61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24980>, '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 0xe25730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25bc0>, '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': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', '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 18:27:15 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 18:27:15 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 18:27:15 INFO - Using env: {'DISPLAY': ':0', 18:27:15 INFO - 'HOME': '/home/cltbld', 18:27:15 INFO - 'LANG': 'en_US.UTF-8', 18:27:15 INFO - 'LANGUAGE': 'en_US:en', 18:27:15 INFO - 'LOGNAME': 'cltbld', 18:27:15 INFO - 'MAIL': '/var/mail/cltbld', 18:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:15 INFO - 'MOZ_NO_REMOTE': '1', 18:27:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:15 INFO - 'NO_EM_RESTART': '1', 18:27:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:15 INFO - 'PWD': '/builds/slave/test', 18:27:15 INFO - 'SHELL': '/bin/bash', 18:27:15 INFO - 'SHLVL': '1', 18:27:15 INFO - 'TERM': 'linux', 18:27:15 INFO - 'TMOUT': '86400', 18:27:15 INFO - 'USER': 'cltbld', 18:27:15 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', 18:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:15 INFO - '_': '/tools/buildbot/bin/python'} 18:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:15 INFO - Downloading/unpacking blobuploader==1.2.4 18:27:15 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 18:27:15 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 18:27:15 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 18:27:15 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 18:27:16 INFO - Downloading blobuploader-1.2.4.tar.gz 18:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:27:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:27:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:27:17 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 18:27:17 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 18:27:17 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 18:27:17 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 18:27:17 INFO - Downloading docopt-0.6.1.tar.gz 18:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:27:17 INFO - Installing collected packages: blobuploader, requests, docopt 18:27:17 INFO - Running setup.py install for blobuploader 18:27:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:27:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:27:17 INFO - Running setup.py install for requests 18:27:17 INFO - Running setup.py install for docopt 18:27:17 INFO - Successfully installed blobuploader requests docopt 18:27:17 INFO - Cleaning up... 18:27:17 INFO - Return code: 0 18:27:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:17 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')]} 18:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:17 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')]} 18:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:17 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 0xab61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24980>, '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 0xe25730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25bc0>, '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': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', '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 18:27:17 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 18:27:17 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 18:27:17 INFO - Using env: {'DISPLAY': ':0', 18:27:17 INFO - 'HOME': '/home/cltbld', 18:27:17 INFO - 'LANG': 'en_US.UTF-8', 18:27:17 INFO - 'LANGUAGE': 'en_US:en', 18:27:17 INFO - 'LOGNAME': 'cltbld', 18:27:17 INFO - 'MAIL': '/var/mail/cltbld', 18:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:17 INFO - 'MOZ_NO_REMOTE': '1', 18:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:17 INFO - 'NO_EM_RESTART': '1', 18:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:17 INFO - 'PWD': '/builds/slave/test', 18:27:17 INFO - 'SHELL': '/bin/bash', 18:27:17 INFO - 'SHLVL': '1', 18:27:17 INFO - 'TERM': 'linux', 18:27:17 INFO - 'TMOUT': '86400', 18:27:17 INFO - 'USER': 'cltbld', 18:27:17 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', 18:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:17 INFO - '_': '/tools/buildbot/bin/python'} 18:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:27:18 INFO - Running setup.py (path:/tmp/pip-yzGR2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:27:18 INFO - Running setup.py (path:/tmp/pip-tCjmlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:27:18 INFO - Running setup.py (path:/tmp/pip-1OVRq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:27:18 INFO - Running setup.py (path:/tmp/pip-EqYT_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:27:18 INFO - Running setup.py (path:/tmp/pip-gU9xiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:27:18 INFO - Running setup.py (path:/tmp/pip-KJbMUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:27:18 INFO - Running setup.py (path:/tmp/pip-7eNknC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:27:18 INFO - Running setup.py (path:/tmp/pip-9W28WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:27:18 INFO - Running setup.py (path:/tmp/pip-s0wvno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:27:18 INFO - Running setup.py (path:/tmp/pip-LrDCrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:27:18 INFO - Running setup.py (path:/tmp/pip-6yFmI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:27:18 INFO - Running setup.py (path:/tmp/pip-XqG5En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:27:18 INFO - Running setup.py (path:/tmp/pip-rSdzNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:27:19 INFO - Running setup.py (path:/tmp/pip-ajzXdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:19 INFO - Running setup.py (path:/tmp/pip-d9uHoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:27:19 INFO - Running setup.py (path:/tmp/pip-ZaUBIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:27:19 INFO - Running setup.py (path:/tmp/pip-di71kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:27:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:27:19 INFO - Running setup.py install for manifestparser 18:27:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Running setup.py install for mozcrash 18:27:19 INFO - Running setup.py install for mozdebug 18:27:19 INFO - Running setup.py install for mozdevice 18:27:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Running setup.py install for mozfile 18:27:19 INFO - Running setup.py install for mozhttpd 18:27:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Running setup.py install for mozinfo 18:27:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:27:20 INFO - Running setup.py install for mozInstall 18:27:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:27:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:27:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:27:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:27:20 INFO - Running setup.py install for mozleak 18:27:20 INFO - Running setup.py install for mozlog 18:27:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:27:20 INFO - Running setup.py install for moznetwork 18:27:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:27:20 INFO - Running setup.py install for mozprocess 18:27:20 INFO - Running setup.py install for mozprofile 18:27:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:27:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:27:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:27:20 INFO - Running setup.py install for mozrunner 18:27:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:27:20 INFO - Running setup.py install for mozscreenshot 18:27:20 INFO - Running setup.py install for moztest 18:27:21 INFO - Running setup.py install for mozversion 18:27:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:27:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:27:21 INFO - Cleaning up... 18:27:21 INFO - Return code: 0 18:27:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:21 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 0xab61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24980>, '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 0xe25730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25bc0>, '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': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', '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 18:27:21 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 18:27:21 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 18:27:21 INFO - Using env: {'DISPLAY': ':0', 18:27:21 INFO - 'HOME': '/home/cltbld', 18:27:21 INFO - 'LANG': 'en_US.UTF-8', 18:27:21 INFO - 'LANGUAGE': 'en_US:en', 18:27:21 INFO - 'LOGNAME': 'cltbld', 18:27:21 INFO - 'MAIL': '/var/mail/cltbld', 18:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:21 INFO - 'MOZ_NO_REMOTE': '1', 18:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:21 INFO - 'NO_EM_RESTART': '1', 18:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:21 INFO - 'PWD': '/builds/slave/test', 18:27:21 INFO - 'SHELL': '/bin/bash', 18:27:21 INFO - 'SHLVL': '1', 18:27:21 INFO - 'TERM': 'linux', 18:27:21 INFO - 'TMOUT': '86400', 18:27:21 INFO - 'USER': 'cltbld', 18:27:21 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', 18:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:21 INFO - '_': '/tools/buildbot/bin/python'} 18:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:27:21 INFO - Running setup.py (path:/tmp/pip-h5i7uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:27:21 INFO - Running setup.py (path:/tmp/pip-xDtkb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:27:21 INFO - Running setup.py (path:/tmp/pip-kWBaGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:27:21 INFO - Running setup.py (path:/tmp/pip-iUbq4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:27:21 INFO - Running setup.py (path:/tmp/pip-2wpHvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:27:21 INFO - Running setup.py (path:/tmp/pip-0S1KH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:27:21 INFO - Running setup.py (path:/tmp/pip-yyQZkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:27:21 INFO - Running setup.py (path:/tmp/pip-C4EUiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:27:21 INFO - Running setup.py (path:/tmp/pip-HfIYMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:27:21 INFO - Running setup.py (path:/tmp/pip-s6znP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:27:22 INFO - Running setup.py (path:/tmp/pip-AK9ZXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:27:22 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)) 18:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:27:22 INFO - Running setup.py (path:/tmp/pip-xsEgvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:27:22 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)) 18:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:27:22 INFO - Running setup.py (path:/tmp/pip-t1rymJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:27:22 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)) 18:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:27:22 INFO - Running setup.py (path:/tmp/pip-zNrzME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:27:22 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)) 18:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:22 INFO - Running setup.py (path:/tmp/pip-d7MWus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:22 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)) 18:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:27:22 INFO - Running setup.py (path:/tmp/pip-uxEKaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:27:22 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)) 18:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:27:22 INFO - Running setup.py (path:/tmp/pip-Ry9zmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:27:22 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)) 18:27:22 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)) 18:27:22 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)) 18:27:22 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)) 18:27:22 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)) 18:27:22 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)) 18:27:22 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)) 18:27:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:23 INFO - Downloading blessings-1.6.tar.gz 18:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:27:23 INFO - Installing collected packages: blessings 18:27:23 INFO - Running setup.py install for blessings 18:27:23 INFO - Successfully installed blessings 18:27:23 INFO - Cleaning up... 18:27:23 INFO - Return code: 0 18:27:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:27:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:27:24 INFO - Reading from file tmpfile_stdout 18:27:24 INFO - Current package versions: 18:27:24 INFO - argparse == 1.2.1 18:27:24 INFO - blessings == 1.6 18:27:24 INFO - blobuploader == 1.2.4 18:27:24 INFO - docopt == 0.6.1 18:27:24 INFO - functools32 == 3.2.3-2 18:27:24 INFO - jsonschema == 2.5.1 18:27:24 INFO - manifestparser == 1.1 18:27:24 INFO - mozInstall == 1.13 18:27:24 INFO - mozcrash == 1.0 18:27:24 INFO - mozdebug == 0.1 18:27:24 INFO - mozdevice == 0.51 18:27:24 INFO - mozfile == 1.2 18:27:24 INFO - mozhttpd == 0.7 18:27:24 INFO - mozinfo == 0.10 18:27:24 INFO - mozleak == 0.1 18:27:24 INFO - mozlog == 3.5 18:27:24 INFO - moznetwork == 0.27 18:27:24 INFO - mozprocess == 0.25 18:27:24 INFO - mozprofile == 0.28 18:27:24 INFO - mozrunner == 6.13 18:27:24 INFO - mozscreenshot == 0.1 18:27:24 INFO - mozsystemmonitor == 0.3 18:27:24 INFO - moztest == 0.8 18:27:24 INFO - mozversion == 1.4 18:27:24 INFO - psutil == 3.1.1 18:27:24 INFO - requests == 1.2.3 18:27:24 INFO - wsgiref == 0.1.2 18:27:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:24 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 0xab61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24980>, '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 0xe25730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25bc0>, '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': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', '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 18:27:24 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 18:27:24 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 18:27:24 INFO - Using env: {'DISPLAY': ':0', 18:27:24 INFO - 'HOME': '/home/cltbld', 18:27:24 INFO - 'LANG': 'en_US.UTF-8', 18:27:24 INFO - 'LANGUAGE': 'en_US:en', 18:27:24 INFO - 'LOGNAME': 'cltbld', 18:27:24 INFO - 'MAIL': '/var/mail/cltbld', 18:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:24 INFO - 'MOZ_NO_REMOTE': '1', 18:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:24 INFO - 'NO_EM_RESTART': '1', 18:27:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:24 INFO - 'PWD': '/builds/slave/test', 18:27:24 INFO - 'SHELL': '/bin/bash', 18:27:24 INFO - 'SHLVL': '1', 18:27:24 INFO - 'TERM': 'linux', 18:27:24 INFO - 'TMOUT': '86400', 18:27:24 INFO - 'USER': 'cltbld', 18:27:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', 18:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:24 INFO - '_': '/tools/buildbot/bin/python'} 18:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:25 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:27:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:27:25 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)) 18:27:25 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)) 18:27:25 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)) 18:27:25 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)) 18:27:25 INFO - Installing collected packages: marionette-driver, simplejson 18:27:25 INFO - Running setup.py install for marionette-driver 18:27:26 INFO - Running setup.py install for simplejson 18:27:26 INFO - building 'simplejson._speedups' extension 18:27:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 18:27:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 18:27:27 INFO - Successfully installed marionette-driver simplejson 18:27:27 INFO - Cleaning up... 18:27:27 INFO - Return code: 0 18:27:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:27 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 0xab61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24980>, '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 0xe25730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25bc0>, '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': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', '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 18:27:27 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 18:27:27 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 18:27:27 INFO - Using env: {'DISPLAY': ':0', 18:27:27 INFO - 'HOME': '/home/cltbld', 18:27:27 INFO - 'LANG': 'en_US.UTF-8', 18:27:27 INFO - 'LANGUAGE': 'en_US:en', 18:27:27 INFO - 'LOGNAME': 'cltbld', 18:27:27 INFO - 'MAIL': '/var/mail/cltbld', 18:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:27 INFO - 'MOZ_NO_REMOTE': '1', 18:27:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:27 INFO - 'NO_EM_RESTART': '1', 18:27:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:27 INFO - 'PWD': '/builds/slave/test', 18:27:27 INFO - 'SHELL': '/bin/bash', 18:27:27 INFO - 'SHLVL': '1', 18:27:27 INFO - 'TERM': 'linux', 18:27:27 INFO - 'TMOUT': '86400', 18:27:27 INFO - 'USER': 'cltbld', 18:27:27 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', 18:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:27 INFO - '_': '/tools/buildbot/bin/python'} 18:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:27:27 INFO - Cleaning up... 18:27:27 INFO - Return code: 0 18:27:27 INFO - Running post-action listener: _resource_record_post_action 18:27:27 INFO - Running post-action listener: _start_resource_monitoring 18:27:27 INFO - Starting resource monitoring. 18:27:27 INFO - [mozharness: 2017-07-02 01:27:27.407478Z] Finished create-virtualenv step (success) 18:27:27 INFO - [mozharness: 2017-07-02 01:27:27.408462Z] Running install step. 18:27:27 INFO - Running pre-action listener: _resource_record_pre_action 18:27:27 INFO - Running main action method: install 18:27:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:27:27 INFO - Reading from file tmpfile_stdout 18:27:27 INFO - Detecting whether we're running mozinstall >=1.0... 18:27:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:27:27 INFO - Reading from file tmpfile_stdout 18:27:27 INFO - Output received: 18:27:27 INFO - Usage: mozinstall [options] installer 18:27:27 INFO - Options: 18:27:27 INFO - -h, --help show this help message and exit 18:27:27 INFO - -d DEST, --destination=DEST 18:27:27 INFO - Directory to install application into. [default: 18:27:27 INFO - "/builds/slave/test"] 18:27:27 INFO - --app=APP Application being installed. [default: firefox] 18:27:27 INFO - mkdir: /builds/slave/test/build/application 18:27:27 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'] 18:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:27:45 INFO - Reading from file tmpfile_stdout 18:27:45 INFO - Output received: 18:27:45 INFO - /builds/slave/test/build/application/firefox/firefox 18:27:45 INFO - Running post-action listener: _resource_record_post_action 18:27:45 INFO - [mozharness: 2017-07-02 01:27:45.735464Z] Finished install step (success) 18:27:45 INFO - [mozharness: 2017-07-02 01:27:45.735584Z] Running setup-mitmproxy step. 18:27:45 INFO - Running pre-action listener: _resource_record_pre_action 18:27:45 INFO - Running main action method: setup_mitmproxy 18:27:45 INFO - Skipping: mitmproxy is not required 18:27:45 INFO - Running post-action listener: _resource_record_post_action 18:27:45 INFO - [mozharness: 2017-07-02 01:27:45.736107Z] Finished setup-mitmproxy step (success) 18:27:45 INFO - [mozharness: 2017-07-02 01:27:45.736210Z] Running run-tests step. 18:27:45 INFO - Running pre-action listener: _resource_record_pre_action 18:27:45 INFO - Running pre-action listener: _set_gcov_prefix 18:27:45 INFO - Running main action method: run_tests 18:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:27:45 INFO - Python 2.7.3 18:27:45 INFO - Return code: 0 18:27:45 INFO - grabbing minidump binary from tooltool 18:27: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')]} 18:27:45 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 0xe24980>, '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 0xe25730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25bc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:27:45 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 18:27:45 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 18:27:45 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 18:27:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:27:45 INFO - Return code: 0 18:27:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:27:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:27:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:27:45 INFO - ENV: RUST_BACKTRACE is now 1 18:27:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:27:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:27:45 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/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 18:27:45 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/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 18:27:45 INFO - Using env: {'DISPLAY': ':0', 18:27:45 INFO - 'HOME': '/home/cltbld', 18:27:45 INFO - 'LANG': 'en_US.UTF-8', 18:27:45 INFO - 'LANGUAGE': 'en_US:en', 18:27:45 INFO - 'LOGNAME': 'cltbld', 18:27:45 INFO - 'MAIL': '/var/mail/cltbld', 18:27:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:27:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:45 INFO - 'MOZ_NO_REMOTE': '1', 18:27:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:45 INFO - 'NO_EM_RESTART': '1', 18:27:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:45 INFO - 'PWD': '/builds/slave/test', 18:27:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:27:45 INFO - 'RUST_BACKTRACE': '1', 18:27:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:27:45 INFO - 'SHELL': '/bin/bash', 18:27:45 INFO - 'SHLVL': '1', 18:27:45 INFO - 'TERM': 'linux', 18:27:45 INFO - 'TMOUT': '86400', 18:27:45 INFO - 'USER': 'cltbld', 18:27:45 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498952097.417011-475883730', 18:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:45 INFO - '_': '/tools/buildbot/bin/python'} 18:27:45 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/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 18:27:46 INFO - mozversion application_buildid: 20170702003450 18:27:46 INFO - mozversion application_changeset: f71131f619f24d9cc2e6441d886c6d626fffc6d4 18:27:46 INFO - mozversion application_display_name: Nightly 18:27:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:27:46 INFO - mozversion application_name: Firefox 18:27:46 INFO - mozversion application_remotingname: firefox 18:27:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:27:46 INFO - mozversion application_vendor: Mozilla 18:27:46 INFO - mozversion application_version: 56.0a1 18:27:46 INFO - mozversion platform_buildid: 20170702003450 18:27:46 INFO - mozversion platform_changeset: f71131f619f24d9cc2e6441d886c6d626fffc6d4 18:27:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:27:46 INFO - mozversion platform_version: 56.0a1 18:27:46 INFO - using testdate: 1498958866 18:27:46 INFO - actual date: 1498958866 18:27:46 INFO - starting webserver on 'localhost:58393' 18:27:46 INFO - SUITE-START | Running 2 tests 18:27:46 INFO - TEST-START | dromaeo_css 18:27:46 INFO - Initialising browser for dromaeo_css test... 18:27:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58393/getInfo.html -profile /tmp/tmp1FJ2jl/profile 18:27:46 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox http://localhost:58393/getInfo.html) 18:27:53 INFO - TEST-INFO | 3316: exit 0 18:27:53 INFO - Browser initialized. 18:27:53 INFO - Running cycle 1/1 for dromaeo_css test... 18:27:53 INFO - TEST-INFO | started process 3517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1FJ2jl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:28:05 INFO - PID 3517 | RSS: Main: 172740608 18:28:05 INFO - PID 3517 | 18:31:08 INFO - PID 3517 | Cycle 1(1): loaded http://localhost:58393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58393/tests/dromaeo/cssquery-ext.html) 18:31:10 INFO - PID 3517 | RSS: Main: 176746496 18:31:10 INFO - PID 3517 | 18:34:12 INFO - PID 3517 | Cycle 1(1): loaded http://localhost:58393/tests/dromaeo/cssquery-ext.html (next: http://localhost:58393/tests/dromaeo/cssquery-jquery.html) 18:34:13 INFO - PID 3517 | RSS: Main: 174194688 18:34:13 INFO - PID 3517 | 18:37:14 INFO - PID 3517 | Cycle 1(1): loaded http://localhost:58393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58393/tests/dromaeo/cssquery-mootools.html) 18:37:15 INFO - PID 3517 | RSS: Main: 176541696 18:37:15 INFO - PID 3517 | 18:40:17 INFO - PID 3517 | Cycle 1(1): loaded http://localhost:58393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58393/tests/dromaeo/cssquery-prototype.html) 18:40:17 INFO - PID 3517 | RSS: Main: 175767552 18:40:17 INFO - PID 3517 | 18:43:20 INFO - PID 3517 | Cycle 1(1): loaded http://localhost:58393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58393/tests/dromaeo/cssquery-yui.html) 18:43:20 INFO - PID 3517 | RSS: Main: 175640576 18:43:20 INFO - PID 3517 | 18:46:22 INFO - PID 3517 | Cycle 1(1): loaded http://localhost:58393/tests/dromaeo/cssquery-yui.html (next: http://localhost:58393/tests/dromaeo/cssquery-dojo.html) 18:46:23 INFO - PID 3517 | RSS: Main: 178012160 18:46:23 INFO - PID 3517 | 18:46:23 INFO - PID 3517 | __start_tp_report 18:46:23 INFO - PID 3517 | _x_x_mozilla_page_load 18:46:23 INFO - PID 3517 | _x_x_mozilla_page_load_details 18:46:23 INFO - PID 3517 | |i|pagename|runs| 18:46:23 INFO - PID 3517 | |0;dojo.html;3068.2482791716034;3103.1776579206507;3120.8439578021107;3134.7022032906875;3140.466120759471;6044.607100538462;6058.636481811089;6100.572959892804;6121.0262130507535;6131.601445906013;6070.817875463732;6076.544259180557;6112.290716697417;6123.953766440811;6131.3562075982045;5622.32532096149;5627.761892383669;5671.234383358255;5684.459976302265;5752.827415177551;5749.913751293734;5753.942460575383;5765.394633563478;5766.279215098113;5782.508486778608;5571.66570005801;5584.91622625661;5597.832065038056;5644.802431914904;5704.857378565527;5556.666600004012;5582.441755824426;5626.831195064114;5627.071533197018;5673.63121397112;5575.69333686647;5610.354809196954;5668.31980162379;5672.574556908248;5720.713964301768;6071;6082.543809214282;6092.603980741238;6109.480694141003;6109.541784366146;6638.037484564711;6697.966510167418;6700.731970721165;6709.2284387295595;6724.798256052326;6499.155109835739;6602.504812139109;6762.289959554225;6762.864742705118;6784.253732089466;6090.23872015998;6141.539384546177;6151.323354431009;6196.132541444202;6201.534884883652;6815.93184068153;6888.483363747739;6928.826779330456;6944.201416837027;6958.582485050913;6408.871822563523;6490.4807615390655;6504.804855854332;6518.641474718936;6559.540832141704;6443.259025212067;6521;6566.704498297492;6576.5067619928695;6578.8355291118105;6630.569013014235;6660.100886380276;6674;6696.966515167393;6698.4641228701585;6657.267700552935;6686.966565167143;6700.83247918806;6714.630695311805;6716.798496045127;5304.230886521433;5371.194320851825;5375.462453754593;5405.405405405402;5453.809116680897;4583.152116858392;4600.378948841863;4673.696209746356;4677.134730074947;4697.553732395417;5830.62100963436;5849.210356601804;5863.3257175424515;5876.177335173079;5888.175655408247;6708.83227919306;6708.966455167693;6721.596704197764;6728.091707619506;6745.831354216184;5810.6513609183585;5826.475617194473;5833.82498525045;5839.445252700986;5848.473637372657;5747.540196784247;5860.355360910296;5868.911966320508;5890.646561206341;5919.852003699942;6456.451201647913;6495.837604059841;6516.641584712696;6519.608823470607;6522.15212022453;6741.056252124608;6750.763723269662;6752.426043786137;6758.797236082925;6766.4248538874745;6464.321246269262;6501.577397469149;6512.990486474604;6518.869622607616;6524.412802847766;6356.237251529846;6483.124778155077;6557.8670492587735;6579.342065793382;6584.637844918576;6576.079348891255;6632.502562307943;6735.831604209934;6755.4257888080065;6761.729530818712;6393.584417012879;6476.870462590816;6487.091807147098;6494.058361537456;6507.219133703797;6350.555461117678;6351.809445716636;6380.234371875405;6384.329645387354;6460.806175814733;6171.537134714825;6261.092141639528;6304.905426418516;6305.211848518935;6350.936490635035;6408.519361047846;6442.806715798533;6449.677516124081;6584.637844918576;6593.505487088391;6278.748850045947;6325.335839736761;6338.176037115146;6381.1704478417505;6385.553011289165 18:46:23 INFO - PID 3517 | |1;ext.html;807.6325272001241;845.7040035987409;872.2760109109439;897.3494216692899;898.1916275352187;41217.3817392739;41919.16161676772;41990.580094199046;42009.15981680364;42181.367279490834;39136.41295380572;39321.606783932155;39350.606493935054;39371.40942885859;39402.60597394032;6818.386345228941;6954;6954;6991.68537415815;6999.2650771669005;6905.965470172642;7012.754553590626;7026.297370262984;7057.788266351992;7061.329173728487;7026.964865175667;7043.506954513186;7046.154461464632;7046.964765176167;7050.82372940678;6960.095187625601;6968.686409111602;7019.5086343955945;7029;7057.223705392403;6315.684215789238;6363.140975968231;6367;6368.586041907308;6371.426571608577;34848;35051.824740876385;35121.12197195065;35168.47247291293;35224.11939701502;3324.750643701732;3337.8497967591516;3369.444041733111;3462.8961131166106;3471;30673.69326306753;30704.69295307063;30822.691773082206;30884;30949.535756963665;4709.9764501177615;4865.70805751656;4897.804087836482;4900.289458028602;4973.4280557735965;188483;190900;190989.9999999986;191157;191712;42815.35776963348;49946.500534994186;50156.498435015186;50753.49246507488;50824.74587627038;52950;52957.2056419154;52994;53033;53044;15703.921480392524;15790.36838526469;15815.446459373867;15886.52340429789;15890.60273493172;12425.565105221274;12495.875041249654;12542.874571254171;12553.748925021448;12563.309018004098;14848.886333525028;14878.809695224356;14903;14926.552203433914;14976.326065327086;5709.05800542914;5743.334433014379;5956.583039187302;5973.970130149409;5989.730462129215;965.4352203960622;975.4147511493047;980.4656462228103;1005.9497025148713;1017.9643712470028;22811.201607943975;23050.308490745305;23197.188098416475;23242.53514929692;23443;1074.9032587067202;1090.1006669497538;1098.5825386353135;1103.089950790601;1116.4808364110727;11614.883851161549;11862.703432414259;11908.46411911466;12175.14773965814;12390.442430090667;221463;223065;225285;225850;225882;52754.20868686973;52887.20669189965;52981.7350913243;53293.733531332095;53606.73196633992;1393.3799459240743;1444.9711005779825;1461.5323096609195;1468.8457711940307;1475.2549962268986;21528.677069843652;22406.88796556007;22434.77565224327;22629;23070;37865.62134378731;37900.81049594845;37988.81005595065;38036;38116.04709882275;178909;181083.0945845315;182097;182204;182226;32569.837150814095;32623.510647339834;32641.836790815894;32882;36454.27091458209;38725.6127438722;38782.806085970515;42539;42857.57142428536;44687.55312446834;31341.686583133876;31653.20866978344;32723.67276327206;32777;33578;32261;32335;32520.186995325304;32579.67420325861;32737.50893736548;35853.49025568185;35916;35950.10124746902;35964.10089747777;36171.27657446889;34004.48993265053;34349.65650343464;34571;34737.65262347344;35090.122746931534;23791.881040594686;24518.63222051635;24703.997771277394;24852.627210591494;25291.620625690997 18:46:23 INFO - PID 3517 | |2;jquery.html;558.9217509548662;575.4964406144621;577.6216578141319;591.7514643849581;596.1951365656363;21463.248786292483;22048.228312009083;22286.331410057683;22328.330150095484;22391.888040559814;24045.038198472084;24881.25356239311;26090.869545652244;26166.6075008875;26648.73351266487;6391.936080639181;6528.804135875931;6538.444232240242;6549.738010479575;6553.705083271264;6463.74145034198;6519.348065193491;6545.214574251097;6557.213134423876;6559.3112723164095;6198;6521.152250207467;6539.280679125316;6791.796246112624;6819.556728812611;6707.463402927754;6824.55640383376;6824.727010919557;6840.794776156723;6852.28051054642;6703.597784132968;6704.229013663394;6711.060451536789;6711.228208755958;6731.966340168267;27557;30068.8496557518;30172.54741178884;30790.846045769853;30801.845990769903;1996.610660921121;2022.6662600670873;2029.9289524866558;2037.2767667478129;2040.7551093868683;19600.80399196004;19864;19864;19955.102020409115;19965.00174991259;2385.926333150072;2403.171030485306;2404;2411.5900296949562;2480.900763969439;130736.3463182678;135653.3217333917;135882.32058839643;136353.3182334092;136604;20027.869015626613;20820.687689684666;21214.46963825886;21525.78474215269;21705.45736356572;43472.78263608662;43684.59734714558;43767;43951.78024109923;44134.77932610316;11068.723281918017;11136.164787640959;11459.140564457699;11502.88497115018;11549.538018479167;9337.71986840396;9356.655619789208;9436;9481.288903332277;9511;10583.364998100138;11006.697990602786;11270.7182320441;11365.715857103638;11383.487743051583;3660.8352624131976;3747.1194269346684;3788.5453745550712;3855.7108216883844;4175.519815221289;916.9633214671472;933.50524222161;946.5220063867703;948.2935213266161;971.7522031881825;18531.07344632763;18681.15934782938;18735.34426295073;18744.53138671544;18854.622907541772;1011.9443430611387;1019.2814066083541;1028.681108856257;1029.6653587583914;1039.7608550033535;10057.29598928068;10307.484625768831;10417.5832966682;10430.539724438584;10537.89462105369;430706;457683;461450;463224;527812;102126.48936755268;105312;105658.4717076425;105979;106321;1190.9642710718692;1202.939853007346;1253.993730031344;1256.1081632041353;1261.0857128581704;19267.843929364284;19630.214791408183;19770;19815.900920495304;19922.203111875362;51182;51210.23184652159;51755.22367164571;52203.73898130485;52762;65015;67831.66084169547;68018;68156.318436815;70417;12531.561395351118;12555.246685198917;12893.806592901301;12964.027697922505;13121.803172952605;14041.719165616834;14105.858941410865;18323.633527329646;18571.90714046475;19904.70142947886;15477.458288959833;15562.221888905284;15590.37638494493;15595.922020389826;15734.68530629358;13254.204747715168;13661.316934153452;14234.14595124296;14258.71482570322;14429.639259018608;15859.603509912344;16052.518424447286;16068.839311607202;16118.758218626495;16176.595585109995;12628.810567841307;12790.168639038433;12823.42294596764;12826;12829.486820527074;15336.539903802905;15384.461543845911;15484.845151548341;15513.91402601807;15908.284127214072 18:46:23 INFO - PID 3517 | |3;mootools.html;1353.5803900790754;1408.2184387664845;1408.619672688374;1417.2134465371714;1435.7630990886498;12651.620451386461;13375.331233438314;13384.063115581914;13408.731825363488;13431.66420839477;13710.45158193671;14295.714085718279;14311.141331520115;14322.498712545063;14354.497592584261;2566.4610431809297;2599.987000064997;2609.673790776153;2633.6839579250423;2634.776044036259;2561.4620929604807;2627.8948842046293;2633.1573896353175;2633.894644214229;2639.986800065997;2347.507023525062;2584.4185058361904;2595.0268649256527;2600.6749156355454;2612.1249381457233;2362.681038059866;2634.604809278614;2641.2340421277804;2645.378336091017;2645.7618814306807;2595.1436026111337;2599.77810429098;2621.3184572011223;2623.291711237955;2624.593188055854;13912.93043534786;14095.718085638333;14108.294585270696;14129.08160969544;14152.92923535386;7311.195768465464;7604.80987975305;7672.194419585919;7672.65473053714;7673.808154796119;4803.327534145223;4853.538913803183;5086.059079070384;5181.637285390024;5242.947570524322;1770.1768677564994;1791.3998810398532;1823.015571591339;1877.0614692653674;1884.4629280654947;22547.661785073236;22721.65917511222;22798.54402911949;22806;22837.771622283897;6239.500839932794;6265.498760099181;6273.749050038039;6314.715837787218;6365.840853978595;15396.23018849053;15409.537713868602;15504.379824807107;15532.145731984849;15533.533993980198;7176.569405835562;7286;7317.853642927218;7337.229590892879;7346.191918888918;6630.701618427182;6734.494912881553;6754.3245675433045;6881.002254673144;6934.791956241321;4711.246200607886;4814.711117332971;4835.758212089381;4845.830395936126;4920;1323.9404226809816;1324.8940084793194;1328.4818920620964;1342.4361768057245;1349.5883755454681;870.4342177584621;871.7951281448854;902.3277658144724;905.3029167541089;918.8437965545874;7146.571205727673;7196.316349946851;7247.456440766963;7814.648340824563;8038.276555109951;717.4762423430925;725.9346658800733;734.7575300150937;742.9702811887572;753.3972821742584;4625.32932724753;5094.286799848024;5114.872128196825;5135.229715542699;5220.7128607926925;17756.733648995276;18369.90815045943;18627.906860465882;18670.159842807105;18782.718259226123;18201.362952296608;18636.254549818128;19230.423087307405;19279.22883084689;19400.320988765325;9721.46531940736;9959.452230127412;9977.80044399108;10024.94738052494;10111.898881011242;7570.205128461433;8144.59277036134;8234.094249632415;8364.3726720495;8394.45436046655;15988.680226395174;16120.677586447971;16665.166741662626;16832.663346733243;16968.321267149175;15898.68202635964;16059.839401606301;16954.660906781548;17000.914995424944;17136.828631713524;10716.839247411139;11225.214235003798;11272.436378181223;11277.71805704864;11288.435578220891;12397.318147501974;12463.376831158586;12537.561185358469;12570.685732856751;12596.811047834473;10234.590616375262;10271;10401.115905148146;10427.582896684047;10569.841452378067;9651;9915;9926.354786938826;10028.147607453448;10066.647667331608;8647.87028194565;8803.031666516807;8822.2060014599;9071.546422678708;9332.16010559053;6394.296627370893;6709.161354830646;7037.753678621224;7046.4010559101;7195.100612423447;7223.602701851449;7302.744403945836;7402.037735094404;7447.776566702791;7515.511491753018 18:46:23 INFO - PID 3517 | |4;prototype.html;492.13744903902165;495.0543675778678;518.4841083122293;520.5679286192461;524.4729047307455;6055.2430946131735;6172.845678858025;6176.351483094278;6186.845328866781;6201.844953876155;5925.407459254073;6013.1581578579035;6018.909716354258;6103.1455596216565;6172.9074063889075;4901.1177987962155;4918.45896951336;4928.654994150393;4929;4962.5533701966815;4946.629002824802;4961.776720047606;4995.600351971833;5011.849644510652;5021.196608542634;4794.9760251198695;4968.608789538935;4972.8508144755715;4984.102861484931;4990.875228119308;4805.855824325241;4897.583705385046;4907.337509436216;4968;4996.325496058058;4407.603315701603;4411.779411029435;4414.602685758265;4440.533743956903;4453.554644535553;5934.5252379809945;5961.135635332853;5984.162217289583;5995.430434108753;6077.301110372276;5620.690862002588;5651.011073062239;5682;5730.398308177623;5751.7699292028265;6527.640979746112;6569.67151642416;6570.63861487618;6610.239822420435;6610.537262391635;4860.246661767432;4864.391951006124;4875.683080599785;4896.779644915988;4903.926441103386;6776.2546119927265;6799.52403331767;6802.7619033334095;6819.522633415663;6924.619145946971;4974.825881094144;5007.349044624176;5016.849494515171;5021.447640759514;5050.292958985745;5080.974595127074;5086;5087.3386459759995;5098.209777484496;5116.027954688598;5677.318721753416;5720.599558030981;5732.140178973187;5732.398098199712;5747.4252574742195;6471.546991710629;6475.870482590321;6535.607863528204;6549.639769812611;6596.439302659328;1709.5213340264745;1740.6518696260798;1745.9563510912076;1754.1317048061037;1758.797738260091;1204.6325870609373;1211.7637060773066;1218.256863313378;1235.2773627428055;1240.8697086805937;5755.712214389264;5762.538996880239;5775.335836378787;5777.711114444261;5853.765849366063;6527.510436717265;6615.17310336208;6660.467162626978;6674.666266686646;6754.534594872935;5734.569907256972;5763.279590051244;5804.535637149018;5817.505512031525;5875.148103525051;3500.8774692885627;3539.5752509698486;3545.432730763117;3580.549877299698;3592.173800026009;6439.484841212692;6450.838729031811;6474.028895665688;6509.349065093453;6527.8694426111215;6768.796936091925;6781.711474819768;6833.521653484208;6838.7264509419065;6857.451403887677;6438.77464288757;6461.741530338828;6479.384458476531;6536.24833144185;6544.934550654528;6565.618706366321;6580.934190658032;6597;6611.396788750047;6630.370114839083;6050.21347224858;6399.536178571377;6482.611043337415;6522.173791338433;6639.867202656016;6431.84839428686;6434.581752186093;6482;6536.607803531613;6567.573107747981;4916.950830491793;4933.432655244693;4938.209886418156;4941.036497882878;4947;6547.70535325902;6630.469562434897;6652.135222421054;6701.497387696039;6748.493862960199;6118.877622447615;6210.627362358273;6387.425131738166;6387.91405461082;6429.132067170872;6277.466415354564;6341.429271365415;6414;6422.518311126778;6435.613863168225;6353.714082866374;6358.237011558643;6366.427021568081;6415.935840641534;6431.935680643133;6464.191976003;6511.804645860631;6515.068219301428;6521.282658907421;6559.967200163968;6276.838784824822;6305.464035556845;6309.400606942333;6335.239771227482;6399.3600639937495 18:46:23 INFO - PID 3517 | |5;yui.html;912.9726108216752;921.7741653294944;932.0306880843923;940.2337095267357;950.7242899559128;17955.82044179558;18266;18878.33925812597;18892.527686807836;18902.14940327685;16487.505374838773;16675.83324166758;16717.83282167178;19252.614947701037;21329.786702132973;1035.8808736995247;1067.3009178987775;1067.6690226029916;1069.5828626835541;1069.8020866139789;1046.0271947089204;1053.367979212474;1053.7207639975375;1053.9104176145038;1062.8990245926664;1076.7954088723156;1110.2006555280186;1111.4609414433994;1112.777444511101;1113.5434471866536;1020.607066279484;1065.5364916261412;1083.0793825248554;1084.4740300954031;1091.0562363555546;790.7943934576994;791.9683212671487;792.3581898662102;792.6155814429997;794.4240425691386;18551.53621159482;18743.062846857603;19241.13414896333;19253.711194332096;19265.13306901193;19935.202591896308;20015;20494.282700105425;20580.27969021077;20738.585228295502;15939.92030039854;15950.202489875459;15975.84024159755;15987.920060399623;16056;3414.7609667323295;3439.7592168548213;3505.737069719781;3662.7252956028406;3679.6688298053305;100640.49679751555;102465;103486;107897.46051269773;108010;15474.767878481833;15704.136272504893;15764.290606922486;15949.122798245975;16070.517884463485;27604.309892252855;28588.714112859023;28923.132306030853;29040.709592904223;29471.26321841971;8850.247728942983;8878.911210887938;8925.955370223108;8926.464412135292;8972;3675.3016926783826;3760.8871733848027;3819.656230939229;3827.655511003967;3887.378019516864;4833.903321933612;4908.312836202935;4918.434380046269;4932.728699921467;4964.379452568429;1000.279798545061;1028.2647906746713;1037;1041.063043261056;1046.2519298701466;688.1535711075405;693.628908533932;705.7812078255757;721.6680327049615;722.6242353975903;10865.891341086646;11039.613613523488;11433.714157146138;11781.288893998362;12374.319412432402;627.075064280183;640.2924768131242;648.9480841532666;662.4634046422317;664.1001443044702;4712.575868171881;4893.8988727536735;4913.287573301851;4921.311016457699;4925.13810083234;102495;104138;105469.47265263778;105988.08815931891;109870.45064774626;84068.57965710254;88624.11375886288;88812.5559372199;89257;89829.55085224532;76432;79167.8124828128;80074;81149;82847.17152828515;9615.375000625218;12102.939485302517;12151.696207594881;12186.817197741864;12431.927882239517;28407.147785566467;32805.67194328122;33771.83114084414;35073;35512.822435887654;58318.7084064577;61129;62403;63395;63658.68170659117;18455.815441845945;18543.443696689123;18669;19060.428187154408;19198.424047278604;19335;19701.70447443261;20076.89961550183;20142.697859531825;20268.89865550663;17759.11204439747;18095.276188952295;18562;18668.7199692002;18734;18793.248270069045;19411.805881941;19424.320148794723;19702.014899254693;19775.703364449833;15773.921130394274;16412;17806.554836129202;17970.460886173434;18316.450506484827;11287.717807054889;11346.432678366215;12028.75942481128;12141.453634586642;12507.624771256877;11625.88374116248;12007;12593.685157871127;13053.34733263352;13100.541481048118 18:46:23 INFO - PID 3517 | __end_tp_report 18:46:23 INFO - PID 3517 | __start_cc_report 18:46:23 INFO - PID 3517 | _x_x_mozilla_cycle_collect,354 18:46:23 INFO - PID 3517 | __end_cc_report 18:46:23 INFO - PID 3517 | __startTimestamp1498959982997__endTimestamp 18:46:23 INFO - PID 3517 | 18:46:23 INFO - PID 3517 | ------- Summary: start ------- 18:46:23 INFO - PID 3517 | Number of tests: 6 18:46:23 INFO - PID 3517 | 18:46:23 INFO - PID 3517 | [#0] dojo.html Cycles:165 Average:6115.18 Median:6350.56 stddev:725.65 (11.4%) stddev-sans-first:687.39 18:46:23 INFO - PID 3517 | Values: 3068.2 3103.2 3120.8 3134.7 3140.5 6044.6 6058.6 6100.6 6121.0 6131.6 6070.8 6076.5 6112.3 6124.0 6131.4 5622.3 5627.8 5671.2 5684.5 5752.8 5749.9 5753.9 5765.4 5766.3 5782.5 5571.7 5584.9 5597.8 5644.8 5704.9 5556.7 5582.4 5626.8 5627.1 5673.6 5575.7 5610.4 5668.3 5672.6 5720.7 6071.0 6082.5 6092.6 6109.5 6109.5 6638.0 6698.0 6700.7 6709.2 6724.8 6499.2 6602.5 6762.3 6762.9 6784.3 6090.2 6141.5 6151.3 6196.1 6201.5 6815.9 6888.5 6928.8 6944.2 6958.6 6408.9 6490.5 6504.8 6518.6 6559.5 6443.3 6521.0 6566.7 6576.5 6578.8 6630.6 6660.1 6674.0 6697.0 6698.5 6657.3 6687.0 6700.8 6714.6 6716.8 5304.2 5371.2 5375.5 5405.4 5453.8 4583.2 4600.4 4673.7 4677.1 4697.6 5830.6 5849.2 5863.3 5876.2 5888.2 6708.8 6709.0 6721.6 6728.1 6745.8 5810.7 5826.5 5833.8 5839.4 5848.5 5747.5 5860.4 5868.9 5890.6 5919.9 6456.5 6495.8 6516.6 6519.6 6522.2 6741.1 6750.8 6752.4 6758.8 6766.4 6464.3 6501.6 6513.0 6518.9 6524.4 6356.2 6483.1 6557.9 6579.3 6584.6 6576.1 6632.5 6735.8 6755.4 6761.7 6393.6 6476.9 6487.1 6494.1 6507.2 6350.6 6351.8 6380.2 6384.3 6460.8 6171.5 6261.1 6304.9 6305.2 6350.9 6408.5 6442.8 6449.7 6584.6 6593.5 6278.7 6325.3 6338.2 6381.2 6385.6 18:46:23 INFO - PID 3517 | 18:46:23 INFO - PID 3517 | [#1] ext.html Cycles:180 Average:36805.89 Median:34949.91 stddev:51755.28 (148.1%) stddev-sans-first:51829.88 18:46:23 INFO - PID 3517 | Values: 807.6 845.7 872.3 897.3 898.2 41217.4 41919.2 41990.6 42009.2 42181.4 39136.4 39321.6 39350.6 39371.4 39402.6 6818.4 6954.0 6954.0 6991.7 6999.3 6906.0 7012.8 7026.3 7057.8 7061.3 7027.0 7043.5 7046.2 7047.0 7050.8 6960.1 6968.7 7019.5 7029.0 7057.2 6315.7 6363.1 6367.0 6368.6 6371.4 34848.0 35051.8 35121.1 35168.5 35224.1 3324.8 3337.8 3369.4 3462.9 3471.0 30673.7 30704.7 30822.7 30884.0 30949.5 4710.0 4865.7 4897.8 4900.3 4973.4 188483.0 190900.0 190990.0 191157.0 191712.0 42815.4 49946.5 50156.5 50753.5 50824.7 52950.0 52957.2 52994.0 53033.0 53044.0 15703.9 15790.4 15815.4 15886.5 15890.6 12425.6 12495.9 12542.9 12553.7 12563.3 14848.9 14878.8 14903.0 14926.6 14976.3 5709.1 5743.3 5956.6 5974.0 5989.7 965.4 975.4 980.5 1005.9 1018.0 22811.2 23050.3 23197.2 23242.5 23443.0 1074.9 1090.1 1098.6 1103.1 1116.5 11614.9 11862.7 11908.5 12175.1 12390.4 221463.0 223065.0 225285.0 225850.0 225882.0 52754.2 52887.2 52981.7 53293.7 53606.7 1393.4 1445.0 1461.5 1468.8 1475.3 21528.7 22406.9 22434.8 22629.0 23070.0 37865.6 37900.8 37988.8 38036.0 38116.0 178909.0 181083.1 182097.0 182204.0 182226.0 32569.8 32623.5 32641.8 32882.0 36454.3 38725.6 38782.8 42539.0 42857.6 44687.6 31341.7 31653.2 32723.7 32777.0 33578.0 32261.0 32335.0 32520.2 32579.7 32737.5 35853.5 35916.0 35950.1 35964.1 36171.3 34004.5 34349.7 34571.0 34737.7 35090.1 23791.9 24518.6 24704.0 24852.6 25291.6 18:46:23 INFO - PID 3517 | 18:46:23 INFO - PID 3517 | [#2] jquery.html Cycles:180 Average:33884.21 Median:11430.72 stddev:78969.31 (690.9%) stddev-sans-first:79151.20 18:46:23 INFO - PID 3517 | Values: 558.9 575.5 577.6 591.8 596.2 21463.2 22048.2 22286.3 22328.3 22391.9 24045.0 24881.3 26090.9 26166.6 26648.7 6391.9 6528.8 6538.4 6549.7 6553.7 6463.7 6519.3 6545.2 6557.2 6559.3 6198.0 6521.2 6539.3 6791.8 6819.6 6707.5 6824.6 6824.7 6840.8 6852.3 6703.6 6704.2 6711.1 6711.2 6732.0 27557.0 30068.8 30172.5 30790.8 30801.8 1996.6 2022.7 2029.9 2037.3 2040.8 19600.8 19864.0 19864.0 19955.1 19965.0 2385.9 2403.2 2404.0 2411.6 2480.9 130736.3 135653.3 135882.3 136353.3 136604.0 20027.9 20820.7 21214.5 21525.8 21705.5 43472.8 43684.6 43767.0 43951.8 44134.8 11068.7 11136.2 11459.1 11502.9 11549.5 9337.7 9356.7 9436.0 9481.3 9511.0 10583.4 11006.7 11270.7 11365.7 11383.5 3660.8 3747.1 3788.5 3855.7 4175.5 917.0 933.5 946.5 948.3 971.8 18531.1 18681.2 18735.3 18744.5 18854.6 1011.9 1019.3 1028.7 1029.7 1039.8 10057.3 10307.5 10417.6 10430.5 10537.9 430706.0 457683.0 461450.0 463224.0 527812.0 102126.5 105312.0 105658.5 105979.0 106321.0 1191.0 1202.9 1254.0 1256.1 1261.1 19267.8 19630.2 19770.0 19815.9 19922.2 51182.0 51210.2 51755.2 52203.7 52762.0 65015.0 67831.7 68018.0 68156.3 70417.0 12531.6 12555.2 12893.8 12964.0 13121.8 14041.7 14105.9 18323.6 18571.9 19904.7 15477.5 15562.2 15590.4 15595.9 15734.7 13254.2 13661.3 14234.1 14258.7 14429.6 15859.6 16052.5 16068.8 16118.8 16176.6 12628.8 12790.2 12823.4 12826.0 12829.5 15336.5 15384.5 15484.8 15513.9 15908.3 18:46:23 INFO - PID 3517 | 18:46:23 INFO - PID 3517 | [#3] mootools.html Cycles:180 Average:8473.25 Median:2616.72 stddev:5788.72 (221.2%) stddev-sans-first:5780.23 18:46:23 INFO - PID 3517 | Values: 1353.6 1408.2 1408.6 1417.2 1435.8 12651.6 13375.3 13384.1 13408.7 13431.7 13710.5 14295.7 14311.1 14322.5 14354.5 2566.5 2600.0 2609.7 2633.7 2634.8 2561.5 2627.9 2633.2 2633.9 2640.0 2347.5 2584.4 2595.0 2600.7 2612.1 2362.7 2634.6 2641.2 2645.4 2645.8 2595.1 2599.8 2621.3 2623.3 2624.6 13912.9 14095.7 14108.3 14129.1 14152.9 7311.2 7604.8 7672.2 7672.7 7673.8 4803.3 4853.5 5086.1 5181.6 5242.9 1770.2 1791.4 1823.0 1877.1 1884.5 22547.7 22721.7 22798.5 22806.0 22837.8 6239.5 6265.5 6273.7 6314.7 6365.8 15396.2 15409.5 15504.4 15532.1 15533.5 7176.6 7286.0 7317.9 7337.2 7346.2 6630.7 6734.5 6754.3 6881.0 6934.8 4711.2 4814.7 4835.8 4845.8 4920.0 1323.9 1324.9 1328.5 1342.4 1349.6 870.4 871.8 902.3 905.3 918.8 7146.6 7196.3 7247.5 7814.6 8038.3 717.5 725.9 734.8 743.0 753.4 4625.3 5094.3 5114.9 5135.2 5220.7 17756.7 18369.9 18627.9 18670.2 18782.7 18201.4 18636.3 19230.4 19279.2 19400.3 9721.5 9959.5 9977.8 10024.9 10111.9 7570.2 8144.6 8234.1 8364.4 8394.5 15988.7 16120.7 16665.2 16832.7 16968.3 15898.7 16059.8 16954.7 17000.9 17136.8 10716.8 11225.2 11272.4 11277.7 11288.4 12397.3 12463.4 12537.6 12570.7 12596.8 10234.6 10271.0 10401.1 10427.6 10569.8 9651.0 9915.0 9926.4 10028.1 10066.6 8647.9 8803.0 8822.2 9071.5 9332.2 6394.3 6709.2 7037.8 7046.4 7195.1 7223.6 7302.7 7402.0 7447.8 7515.5 18:46:23 INFO - PID 3517 | 18:46:23 INFO - PID 3517 | [#4] prototype.html Cycles:180 Average:5465.89 Median:6016.03 stddev:1524.17 (25.3%) stddev-sans-first:1482.02 18:46:23 INFO - PID 3517 | Values: 492.1 495.1 518.5 520.6 524.5 6055.2 6172.8 6176.4 6186.8 6201.8 5925.4 6013.2 6018.9 6103.1 6172.9 4901.1 4918.5 4928.7 4929.0 4962.6 4946.6 4961.8 4995.6 5011.8 5021.2 4795.0 4968.6 4972.9 4984.1 4990.9 4805.9 4897.6 4907.3 4968.0 4996.3 4407.6 4411.8 4414.6 4440.5 4453.6 5934.5 5961.1 5984.2 5995.4 6077.3 5620.7 5651.0 5682.0 5730.4 5751.8 6527.6 6569.7 6570.6 6610.2 6610.5 4860.2 4864.4 4875.7 4896.8 4903.9 6776.3 6799.5 6802.8 6819.5 6924.6 4974.8 5007.3 5016.8 5021.4 5050.3 5081.0 5086.0 5087.3 5098.2 5116.0 5677.3 5720.6 5732.1 5732.4 5747.4 6471.5 6475.9 6535.6 6549.6 6596.4 1709.5 1740.7 1746.0 1754.1 1758.8 1204.6 1211.8 1218.3 1235.3 1240.9 5755.7 5762.5 5775.3 5777.7 5853.8 6527.5 6615.2 6660.5 6674.7 6754.5 5734.6 5763.3 5804.5 5817.5 5875.1 3500.9 3539.6 3545.4 3580.5 3592.2 6439.5 6450.8 6474.0 6509.3 6527.9 6768.8 6781.7 6833.5 6838.7 6857.5 6438.8 6461.7 6479.4 6536.2 6544.9 6565.6 6580.9 6597.0 6611.4 6630.4 6050.2 6399.5 6482.6 6522.2 6639.9 6431.8 6434.6 6482.0 6536.6 6567.6 4917.0 4933.4 4938.2 4941.0 4947.0 6547.7 6630.5 6652.1 6701.5 6748.5 6118.9 6210.6 6387.4 6387.9 6429.1 6277.5 6341.4 6414.0 6422.5 6435.6 6353.7 6358.2 6366.4 6415.9 6431.9 6464.2 6511.8 6515.1 6521.3 6560.0 6276.8 6305.5 6309.4 6335.2 6399.4 18:46:23 INFO - PID 3517 | 18:46:23 INFO - PID 3517 | [#5] yui.html Cycles:180 Average:21813.09 Median:19246.87 stddev:28616.79 (148.7%) stddev-sans-first:28654.04 18:46:23 INFO - PID 3517 | Values: 913.0 921.8 932.0 940.2 950.7 17955.8 18266.0 18878.3 18892.5 18902.1 16487.5 16675.8 16717.8 19252.6 21329.8 1035.9 1067.3 1067.7 1069.6 1069.8 1046.0 1053.4 1053.7 1053.9 1062.9 1076.8 1110.2 1111.5 1112.8 1113.5 1020.6 1065.5 1083.1 1084.5 1091.1 790.8 792.0 792.4 792.6 794.4 18551.5 18743.1 19241.1 19253.7 19265.1 19935.2 20015.0 20494.3 20580.3 20738.6 15939.9 15950.2 15975.8 15987.9 16056.0 3414.8 3439.8 3505.7 3662.7 3679.7 100640.5 102465.0 103486.0 107897.5 108010.0 15474.8 15704.1 15764.3 15949.1 16070.5 27604.3 28588.7 28923.1 29040.7 29471.3 8850.2 8878.9 8926.0 8926.5 8972.0 3675.3 3760.9 3819.7 3827.7 3887.4 4833.9 4908.3 4918.4 4932.7 4964.4 1000.3 1028.3 1037.0 1041.1 1046.3 688.2 693.6 705.8 721.7 722.6 10865.9 11039.6 11433.7 11781.3 12374.3 627.1 640.3 648.9 662.5 664.1 4712.6 4893.9 4913.3 4921.3 4925.1 102495.0 104138.0 105469.5 105988.1 109870.5 84068.6 88624.1 88812.6 89257.0 89829.6 76432.0 79167.8 80074.0 81149.0 82847.2 9615.4 12102.9 12151.7 12186.8 12431.9 28407.1 32805.7 33771.8 35073.0 35512.8 58318.7 61129.0 62403.0 63395.0 63658.7 18455.8 18543.4 18669.0 19060.4 19198.4 19335.0 19701.7 20076.9 20142.7 20268.9 17759.1 18095.3 18562.0 18668.7 18734.0 18793.2 19411.8 19424.3 19702.0 19775.7 15773.9 16412.0 17806.6 17970.5 18316.5 11287.7 11346.4 12028.8 12141.5 12507.6 11625.9 12007.0 12593.7 13053.3 13100.5 18:46:23 INFO - PID 3517 | -------- Summary: end -------- 18:46:23 INFO - PID 3517 | 18:46:23 INFO - TEST-INFO | 3517: exit 0 18:46:23 INFO - TEST-OK | dromaeo_css | took 1117332ms 18:46:23 INFO - TEST-START | kraken 18:46:23 INFO - Initialising browser for kraken test... 18:46:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58393/getInfo.html -profile /tmp/tmpB7lwxl/profile 18:46:23 INFO - TEST-INFO | started process 3918 (/builds/slave/test/build/application/firefox/firefox http://localhost:58393/getInfo.html) 18:46:29 INFO - TEST-INFO | 3918: exit 0 18:46:29 INFO - Browser initialized. 18:46:29 INFO - Running cycle 1/1 for kraken test... 18:46:29 INFO - TEST-INFO | started process 4126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB7lwxl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:46:40 INFO - PID 4126 | RSS: Main: 169271296 18:46:40 INFO - PID 4126 | 18:46:43 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58393/tests/kraken/driver.html?testName=audio-beat-detection) 18:46:44 INFO - PID 4126 | RSS: Main: 173903872 18:46:44 INFO - PID 4126 | 18:46:46 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58393/tests/kraken/driver.html?testName=audio-dft) 18:46:47 INFO - PID 4126 | RSS: Main: 174112768 18:46:47 INFO - PID 4126 | 18:46:50 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58393/tests/kraken/driver.html?testName=audio-fft) 18:46:51 INFO - PID 4126 | RSS: Main: 169873408 18:46:51 INFO - PID 4126 | 18:46:53 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58393/tests/kraken/driver.html?testName=audio-oscillator) 18:46:53 INFO - PID 4126 | RSS: Main: 170311680 18:46:53 INFO - PID 4126 | 18:46:55 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:46:56 INFO - PID 4126 | RSS: Main: 170643456 18:46:56 INFO - PID 4126 | 18:46:59 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58393/tests/kraken/driver.html?testName=imaging-darkroom) 18:47:00 INFO - PID 4126 | RSS: Main: 173957120 18:47:00 INFO - PID 4126 | 18:47:03 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58393/tests/kraken/driver.html?testName=imaging-desaturate) 18:47:04 INFO - PID 4126 | RSS: Main: 175112192 18:47:04 INFO - PID 4126 | 18:47:06 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58393/tests/kraken/driver.html?testName=json-parse-financial) 18:47:07 INFO - PID 4126 | RSS: Main: 174305280 18:47:07 INFO - PID 4126 | 18:47:09 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:47:09 INFO - PID 4126 | RSS: Main: 174059520 18:47:09 INFO - PID 4126 | 18:47:11 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:47:12 INFO - PID 4126 | RSS: Main: 174088192 18:47:12 INFO - PID 4126 | 18:47:14 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:47:14 INFO - PID 4126 | RSS: Main: 174231552 18:47:14 INFO - PID 4126 | 18:47:17 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:47:18 INFO - PID 4126 | RSS: Main: 174084096 18:47:18 INFO - PID 4126 | 18:47:21 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:47:21 INFO - PID 4126 | RSS: Main: 174198784 18:47:21 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | Cycle 1(1): loaded http://localhost:58393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58393/tests/kraken/driver.html?testName=ai-astar) 18:47:23 INFO - PID 4126 | RSS: Main: 175497216 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | __start_tp_report 18:47:23 INFO - PID 4126 | _x_x_mozilla_page_load 18:47:23 INFO - PID 4126 | _x_x_mozilla_page_load_details 18:47:23 INFO - PID 4126 | |i|pagename|runs| 18:47:23 INFO - PID 4126 | |0;ai-astar;101;109;109;109;109;111;109;109;109;108 18:47:23 INFO - PID 4126 | |1;audio-beat-detection;157;124;145;178;121;149;155;121;180;120 18:47:23 INFO - PID 4126 | |2;audio-dft;165;164;164;165;163;169;163;170;168;165 18:47:23 INFO - PID 4126 | |3;audio-fft;74;75;75;167;75;76;75;75;98;75 18:47:23 INFO - PID 4126 | |4;audio-oscillator;84;83;136;83;81;83;130;83;83;128 18:47:23 INFO - PID 4126 | |5;imaging-gaussian-blur;114;114;114;113;114;114;114;114;116;114 18:47:23 INFO - PID 4126 | |6;imaging-darkroom;149;150;151;149;149;151;150;149;150;152 18:47:23 INFO - PID 4126 | |7;imaging-desaturate;96;94;95;94;94;94;94;93;94;94 18:47:23 INFO - PID 4126 | |8;json-parse-financial;56;55;55;56;55;57;59;58;55;55 18:47:23 INFO - PID 4126 | |9;json-stringify-tinderbox;54;54;53;53;54;54;54;54;53;55 18:47:23 INFO - PID 4126 | |10;stanford-crypto-aes;77;77;77;77;77;76;77;78;76;89 18:47:23 INFO - PID 4126 | |11;stanford-crypto-ccm;132;132;127;138;125;130;127;126;137;149 18:47:23 INFO - PID 4126 | |12;stanford-crypto-pbkdf2;182;185;179;178;180;191;182;178;182;182 18:47:23 INFO - PID 4126 | |13;stanford-crypto-sha256-iterative;70;78;69;69;71;68;67;69;68;67 18:47:23 INFO - PID 4126 | __end_tp_report 18:47:23 INFO - PID 4126 | __start_cc_report 18:47:23 INFO - PID 4126 | _x_x_mozilla_cycle_collect,935 18:47:23 INFO - PID 4126 | __end_cc_report 18:47:23 INFO - PID 4126 | __startTimestamp1498960043606__endTimestamp 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | ------- Summary: start ------- 18:47:23 INFO - PID 4126 | Number of tests: 14 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:2.67 (2.4%) stddev-sans-first:0.78 18:47:23 INFO - PID 4126 | Values: 101.0 109.0 109.0 109.0 109.0 111.0 109.0 109.0 109.0 108.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:152.00 stddev:23.07 (15.2%) stddev-sans-first:24.06 18:47:23 INFO - PID 4126 | Values: 157.0 124.0 145.0 178.0 121.0 149.0 155.0 121.0 180.0 120.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:2.50 (1.5%) stddev-sans-first:2.65 18:47:23 INFO - PID 4126 | Values: 165.0 164.0 164.0 165.0 163.0 169.0 163.0 170.0 168.0 165.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#3] audio-fft Cycles:10 Average:86.50 Median:75.00 stddev:29.20 (38.9%) stddev-sans-first:30.62 18:47:23 INFO - PID 4126 | Values: 74.0 75.0 75.0 167.0 75.0 76.0 75.0 75.0 98.0 75.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:83.00 stddev:23.51 (28.3%) stddev-sans-first:24.43 18:47:23 INFO - PID 4126 | Values: 84.0 83.0 136.0 83.0 81.0 83.0 130.0 83.0 83.0 128.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 18:47:23 INFO - PID 4126 | Values: 114.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 116.0 114.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 18:47:23 INFO - PID 4126 | Values: 149.0 150.0 151.0 149.0 149.0 151.0 150.0 149.0 150.0 152.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.50 18:47:23 INFO - PID 4126 | Values: 96.0 94.0 95.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.45 (2.6%) stddev-sans-first:1.54 18:47:23 INFO - PID 4126 | Values: 56.0 55.0 55.0 56.0 55.0 57.0 59.0 58.0 55.0 55.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 18:47:23 INFO - PID 4126 | Values: 54.0 54.0 53.0 53.0 54.0 54.0 54.0 54.0 53.0 55.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.00 stddev:3.87 (5.0%) stddev-sans-first:4.09 18:47:23 INFO - PID 4126 | Values: 77.0 77.0 77.0 77.0 77.0 76.0 77.0 78.0 76.0 89.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:132.00 stddev:7.36 (5.6%) stddev-sans-first:7.81 18:47:23 INFO - PID 4126 | Values: 132.0 132.0 127.0 138.0 125.0 130.0 127.0 126.0 137.0 149.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:182.00 stddev:3.87 (2.1%) stddev-sans-first:4.11 18:47:23 INFO - PID 4126 | Values: 182.0 185.0 179.0 178.0 180.0 191.0 182.0 178.0 182.0 182.0 18:47:23 INFO - PID 4126 | 18:47:23 INFO - PID 4126 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.00 stddev:3.20 (4.6%) stddev-sans-first:3.40 18:47:23 INFO - PID 4126 | Values: 70.0 78.0 69.0 69.0 71.0 68.0 67.0 69.0 68.0 67.0 18:47:23 INFO - PID 4126 | -------- Summary: end -------- 18:47:23 INFO - PID 4126 | 18:47:24 INFO - TEST-INFO | 4126: exit 0 18:47:24 INFO - TEST-OK | kraken | took 60876ms 18:47:24 INFO - SUITE-END | took 1178s 18:47:24 INFO - Completed test suite (00:19:38) 18:47:24 INFO - javascript benchmark 18:47:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8322.971958998196, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.2482791716034, 3103.1776579206507, 3120.8439578021107, 3134.7022032906875, 3140.466120759471, 6044.607100538462, 6058.636481811089, 6100.572959892804, 6121.0262130507535, 6131.601445906013, 6070.817875463732, 6076.544259180557, 6112.290716697417, 6123.953766440811, 6131.3562075982045, 5622.32532096149, 5627.761892383669, 5671.234383358255, 5684.459976302265, 5752.827415177551, 5749.913751293734, 5753.942460575383, 5765.394633563478, 5766.279215098113, 5782.508486778608, 5571.66570005801, 5584.91622625661, 5597.832065038056, 5644.802431914904, 5704.857378565527, 5556.666600004012, 5582.441755824426, 5626.831195064114, 5627.071533197018, 5673.63121397112, 5575.69333686647, 5610.354809196954, 5668.31980162379, 5672.574556908248, 5720.713964301768, 6071.0, 6082.543809214282, 6092.603980741238, 6109.480694141003, 6109.541784366146, 6638.037484564711, 6697.966510167418, 6700.731970721165, 6709.2284387295595, 6724.798256052326, 6499.155109835739, 6602.504812139109, 6762.289959554225, 6762.864742705118, 6784.253732089466, 6090.23872015998, 6141.539384546177, 6151.323354431009, 6196.132541444202, 6201.534884883652, 6815.93184068153, 6888.483363747739, 6928.826779330456, 6944.201416837027, 6958.582485050913, 6408.871822563523, 6490.4807615390655, 6504.804855854332, 6518.641474718936, 6559.540832141704, 6443.259025212067, 6521.0, 6566.704498297492, 6576.5067619928695, 6578.8355291118105, 6630.569013014235, 6660.100886380276, 6674.0, 6696.966515167393, 6698.4641228701585, 6657.267700552935, 6686.966565167143, 6700.83247918806, 6714.630695311805, 6716.798496045127, 5304.230886521433, 5371.194320851825, 5375.462453754593, 5405.405405405402, 5453.809116680897, 4583.152116858392, 4600.378948841863, 4673.696209746356, 4677.134730074947, 4697.553732395417, 5830.62100963436, 5849.210356601804, 5863.3257175424515, 5876.177335173079, 5888.175655408247, 6708.83227919306, 6708.966455167693, 6721.596704197764, 6728.091707619506, 6745.831354216184, 5810.6513609183585, 5826.475617194473, 5833.82498525045, 5839.445252700986, 5848.473637372657, 5747.540196784247, 5860.355360910296, 5868.911966320508, 5890.646561206341, 5919.852003699942, 6456.451201647913, 6495.837604059841, 6516.641584712696, 6519.608823470607, 6522.15212022453, 6741.056252124608, 6750.763723269662, 6752.426043786137, 6758.797236082925, 6766.4248538874745, 6464.321246269262, 6501.577397469149, 6512.990486474604, 6518.869622607616, 6524.412802847766, 6356.237251529846, 6483.124778155077, 6557.8670492587735, 6579.342065793382, 6584.637844918576, 6576.079348891255, 6632.502562307943, 6735.831604209934, 6755.4257888080065, 6761.729530818712, 6393.584417012879, 6476.870462590816, 6487.091807147098, 6494.058361537456, 6507.219133703797, 6350.555461117678, 6351.809445716636, 6380.234371875405, 6384.329645387354, 6460.806175814733, 6171.537134714825, 6261.092141639528, 6304.905426418516, 6305.211848518935, 6350.936490635035, 6408.519361047846, 6442.806715798533, 6449.677516124081, 6584.637844918576, 6593.505487088391, 6278.748850045947, 6325.335839736761, 6338.176037115146, 6381.1704478417505, 6385.553011289165], "value": 6060.305453773194, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.6325272001241, 845.7040035987409, 872.2760109109439, 897.3494216692899, 898.1916275352187, 41217.3817392739, 41919.16161676772, 41990.580094199046, 42009.15981680364, 42181.367279490834, 39136.41295380572, 39321.606783932155, 39350.606493935054, 39371.40942885859, 39402.60597394032, 6818.386345228941, 6954.0, 6954.0, 6991.68537415815, 6999.2650771669005, 6905.965470172642, 7012.754553590626, 7026.297370262984, 7057.788266351992, 7061.329173728487, 7026.964865175667, 7043.506954513186, 7046.154461464632, 7046.964765176167, 7050.82372940678, 6960.095187625601, 6968.686409111602, 7019.5086343955945, 7029.0, 7057.223705392403, 6315.684215789238, 6363.140975968231, 6367.0, 6368.586041907308, 6371.426571608577, 34848.0, 35051.824740876385, 35121.12197195065, 35168.47247291293, 35224.11939701502, 3324.750643701732, 3337.8497967591516, 3369.444041733111, 3462.8961131166106, 3471.0, 30673.69326306753, 30704.69295307063, 30822.691773082206, 30884.0, 30949.535756963665, 4709.9764501177615, 4865.70805751656, 4897.804087836482, 4900.289458028602, 4973.4280557735965, 188483.0, 190900.0, 190989.9999999986, 191157.0, 191712.0, 42815.35776963348, 49946.500534994186, 50156.498435015186, 50753.49246507488, 50824.74587627038, 52950.0, 52957.2056419154, 52994.0, 53033.0, 53044.0, 15703.921480392524, 15790.36838526469, 15815.446459373867, 15886.52340429789, 15890.60273493172, 12425.565105221274, 12495.875041249654, 12542.874571254171, 12553.748925021448, 12563.309018004098, 14848.886333525028, 14878.809695224356, 14903.0, 14926.552203433914, 14976.326065327086, 5709.05800542914, 5743.334433014379, 5956.583039187302, 5973.970130149409, 5989.730462129215, 965.4352203960622, 975.4147511493047, 980.4656462228103, 1005.9497025148713, 1017.9643712470028, 22811.201607943975, 23050.308490745305, 23197.188098416475, 23242.53514929692, 23443.0, 1074.9032587067202, 1090.1006669497538, 1098.5825386353135, 1103.089950790601, 1116.4808364110727, 11614.883851161549, 11862.703432414259, 11908.46411911466, 12175.14773965814, 12390.442430090667, 221463.0, 223065.0, 225285.0, 225850.0, 225882.0, 52754.20868686973, 52887.20669189965, 52981.7350913243, 53293.733531332095, 53606.73196633992, 1393.3799459240743, 1444.9711005779825, 1461.5323096609195, 1468.8457711940307, 1475.2549962268986, 21528.677069843652, 22406.88796556007, 22434.77565224327, 22629.0, 23070.0, 37865.62134378731, 37900.81049594845, 37988.81005595065, 38036.0, 38116.04709882275, 178909.0, 181083.0945845315, 182097.0, 182204.0, 182226.0, 32569.837150814095, 32623.510647339834, 32641.836790815894, 32882.0, 36454.27091458209, 38725.6127438722, 38782.806085970515, 42539.0, 42857.57142428536, 44687.55312446834, 31341.686583133876, 31653.20866978344, 32723.67276327206, 32777.0, 33578.0, 32261.0, 32335.0, 32520.186995325304, 32579.67420325861, 32737.50893736548, 35853.49025568185, 35916.0, 35950.10124746902, 35964.10089747777, 36171.27657446889, 34004.48993265053, 34349.65650343464, 34571.0, 34737.65262347344, 35090.122746931534, 23791.881040594686, 24518.63222051635, 24703.997771277394, 24852.627210591494, 25291.620625690997], "value": 16764.632728502314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.9217509548662, 575.4964406144621, 577.6216578141319, 591.7514643849581, 596.1951365656363, 21463.248786292483, 22048.228312009083, 22286.331410057683, 22328.330150095484, 22391.888040559814, 24045.038198472084, 24881.25356239311, 26090.869545652244, 26166.6075008875, 26648.73351266487, 6391.936080639181, 6528.804135875931, 6538.444232240242, 6549.738010479575, 6553.705083271264, 6463.74145034198, 6519.348065193491, 6545.214574251097, 6557.213134423876, 6559.3112723164095, 6198.0, 6521.152250207467, 6539.280679125316, 6791.796246112624, 6819.556728812611, 6707.463402927754, 6824.55640383376, 6824.727010919557, 6840.794776156723, 6852.28051054642, 6703.597784132968, 6704.229013663394, 6711.060451536789, 6711.228208755958, 6731.966340168267, 27557.0, 30068.8496557518, 30172.54741178884, 30790.846045769853, 30801.845990769903, 1996.610660921121, 2022.6662600670873, 2029.9289524866558, 2037.2767667478129, 2040.7551093868683, 19600.80399196004, 19864.0, 19864.0, 19955.102020409115, 19965.00174991259, 2385.926333150072, 2403.171030485306, 2404.0, 2411.5900296949562, 2480.900763969439, 130736.3463182678, 135653.3217333917, 135882.32058839643, 136353.3182334092, 136604.0, 20027.869015626613, 20820.687689684666, 21214.46963825886, 21525.78474215269, 21705.45736356572, 43472.78263608662, 43684.59734714558, 43767.0, 43951.78024109923, 44134.77932610316, 11068.723281918017, 11136.164787640959, 11459.140564457699, 11502.88497115018, 11549.538018479167, 9337.71986840396, 9356.655619789208, 9436.0, 9481.288903332277, 9511.0, 10583.364998100138, 11006.697990602786, 11270.7182320441, 11365.715857103638, 11383.487743051583, 3660.8352624131976, 3747.1194269346684, 3788.5453745550712, 3855.7108216883844, 4175.519815221289, 916.9633214671472, 933.50524222161, 946.5220063867703, 948.2935213266161, 971.7522031881825, 18531.07344632763, 18681.15934782938, 18735.34426295073, 18744.53138671544, 18854.622907541772, 1011.9443430611387, 1019.2814066083541, 1028.681108856257, 1029.6653587583914, 1039.7608550033535, 10057.29598928068, 10307.484625768831, 10417.5832966682, 10430.539724438584, 10537.89462105369, 430706.0, 457683.0, 461450.0, 463224.0, 527812.0, 102126.48936755268, 105312.0, 105658.4717076425, 105979.0, 106321.0, 1190.9642710718692, 1202.939853007346, 1253.993730031344, 1256.1081632041353, 1261.0857128581704, 19267.843929364284, 19630.214791408183, 19770.0, 19815.900920495304, 19922.203111875362, 51182.0, 51210.23184652159, 51755.22367164571, 52203.73898130485, 52762.0, 65015.0, 67831.66084169547, 68018.0, 68156.318436815, 70417.0, 12531.561395351118, 12555.246685198917, 12893.806592901301, 12964.027697922505, 13121.803172952605, 14041.719165616834, 14105.858941410865, 18323.633527329646, 18571.90714046475, 19904.70142947886, 15477.458288959833, 15562.221888905284, 15590.37638494493, 15595.922020389826, 15734.68530629358, 13254.204747715168, 13661.316934153452, 14234.14595124296, 14258.71482570322, 14429.639259018608, 15859.603509912344, 16052.518424447286, 16068.839311607202, 16118.758218626495, 16176.595585109995, 12628.810567841307, 12790.168639038433, 12823.42294596764, 12826.0, 12829.486820527074, 15336.539903802905, 15384.461543845911, 15484.845151548341, 15513.91402601807, 15908.284127214072], "value": 12051.63679073031, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.5803900790754, 1408.2184387664845, 1408.619672688374, 1417.2134465371714, 1435.7630990886498, 12651.620451386461, 13375.331233438314, 13384.063115581914, 13408.731825363488, 13431.66420839477, 13710.45158193671, 14295.714085718279, 14311.141331520115, 14322.498712545063, 14354.497592584261, 2566.4610431809297, 2599.987000064997, 2609.673790776153, 2633.6839579250423, 2634.776044036259, 2561.4620929604807, 2627.8948842046293, 2633.1573896353175, 2633.894644214229, 2639.986800065997, 2347.507023525062, 2584.4185058361904, 2595.0268649256527, 2600.6749156355454, 2612.1249381457233, 2362.681038059866, 2634.604809278614, 2641.2340421277804, 2645.378336091017, 2645.7618814306807, 2595.1436026111337, 2599.77810429098, 2621.3184572011223, 2623.291711237955, 2624.593188055854, 13912.93043534786, 14095.718085638333, 14108.294585270696, 14129.08160969544, 14152.92923535386, 7311.195768465464, 7604.80987975305, 7672.194419585919, 7672.65473053714, 7673.808154796119, 4803.327534145223, 4853.538913803183, 5086.059079070384, 5181.637285390024, 5242.947570524322, 1770.1768677564994, 1791.3998810398532, 1823.015571591339, 1877.0614692653674, 1884.4629280654947, 22547.661785073236, 22721.65917511222, 22798.54402911949, 22806.0, 22837.771622283897, 6239.500839932794, 6265.498760099181, 6273.749050038039, 6314.715837787218, 6365.840853978595, 15396.23018849053, 15409.537713868602, 15504.379824807107, 15532.145731984849, 15533.533993980198, 7176.569405835562, 7286.0, 7317.853642927218, 7337.229590892879, 7346.191918888918, 6630.701618427182, 6734.494912881553, 6754.3245675433045, 6881.002254673144, 6934.791956241321, 4711.246200607886, 4814.711117332971, 4835.758212089381, 4845.830395936126, 4920.0, 1323.9404226809816, 1324.8940084793194, 1328.4818920620964, 1342.4361768057245, 1349.5883755454681, 870.4342177584621, 871.7951281448854, 902.3277658144724, 905.3029167541089, 918.8437965545874, 7146.571205727673, 7196.316349946851, 7247.456440766963, 7814.648340824563, 8038.276555109951, 717.4762423430925, 725.9346658800733, 734.7575300150937, 742.9702811887572, 753.3972821742584, 4625.32932724753, 5094.286799848024, 5114.872128196825, 5135.229715542699, 5220.7128607926925, 17756.733648995276, 18369.90815045943, 18627.906860465882, 18670.159842807105, 18782.718259226123, 18201.362952296608, 18636.254549818128, 19230.423087307405, 19279.22883084689, 19400.320988765325, 9721.46531940736, 9959.452230127412, 9977.80044399108, 10024.94738052494, 10111.898881011242, 7570.205128461433, 8144.59277036134, 8234.094249632415, 8364.3726720495, 8394.45436046655, 15988.680226395174, 16120.677586447971, 16665.166741662626, 16832.663346733243, 16968.321267149175, 15898.68202635964, 16059.839401606301, 16954.660906781548, 17000.914995424944, 17136.828631713524, 10716.839247411139, 11225.214235003798, 11272.436378181223, 11277.71805704864, 11288.435578220891, 12397.318147501974, 12463.376831158586, 12537.561185358469, 12570.685732856751, 12596.811047834473, 10234.590616375262, 10271.0, 10401.115905148146, 10427.582896684047, 10569.841452378067, 9651.0, 9915.0, 9926.354786938826, 10028.147607453448, 10066.647667331608, 8647.87028194565, 8803.031666516807, 8822.2060014599, 9071.546422678708, 9332.16010559053, 6394.296627370893, 6709.161354830646, 7037.753678621224, 7046.4010559101, 7195.100612423447, 7223.602701851449, 7302.744403945836, 7402.037735094404, 7447.776566702791, 7515.511491753018], "value": 6163.593469941683, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.13744903902165, 495.0543675778678, 518.4841083122293, 520.5679286192461, 524.4729047307455, 6055.2430946131735, 6172.845678858025, 6176.351483094278, 6186.845328866781, 6201.844953876155, 5925.407459254073, 6013.1581578579035, 6018.909716354258, 6103.1455596216565, 6172.9074063889075, 4901.1177987962155, 4918.45896951336, 4928.654994150393, 4929.0, 4962.5533701966815, 4946.629002824802, 4961.776720047606, 4995.600351971833, 5011.849644510652, 5021.196608542634, 4794.9760251198695, 4968.608789538935, 4972.8508144755715, 4984.102861484931, 4990.875228119308, 4805.855824325241, 4897.583705385046, 4907.337509436216, 4968.0, 4996.325496058058, 4407.603315701603, 4411.779411029435, 4414.602685758265, 4440.533743956903, 4453.554644535553, 5934.5252379809945, 5961.135635332853, 5984.162217289583, 5995.430434108753, 6077.301110372276, 5620.690862002588, 5651.011073062239, 5682.0, 5730.398308177623, 5751.7699292028265, 6527.640979746112, 6569.67151642416, 6570.63861487618, 6610.239822420435, 6610.537262391635, 4860.246661767432, 4864.391951006124, 4875.683080599785, 4896.779644915988, 4903.926441103386, 6776.2546119927265, 6799.52403331767, 6802.7619033334095, 6819.522633415663, 6924.619145946971, 4974.825881094144, 5007.349044624176, 5016.849494515171, 5021.447640759514, 5050.292958985745, 5080.974595127074, 5086.0, 5087.3386459759995, 5098.209777484496, 5116.027954688598, 5677.318721753416, 5720.599558030981, 5732.140178973187, 5732.398098199712, 5747.4252574742195, 6471.546991710629, 6475.870482590321, 6535.607863528204, 6549.639769812611, 6596.439302659328, 1709.5213340264745, 1740.6518696260798, 1745.9563510912076, 1754.1317048061037, 1758.797738260091, 1204.6325870609373, 1211.7637060773066, 1218.256863313378, 1235.2773627428055, 1240.8697086805937, 5755.712214389264, 5762.538996880239, 5775.335836378787, 5777.711114444261, 5853.765849366063, 6527.510436717265, 6615.17310336208, 6660.467162626978, 6674.666266686646, 6754.534594872935, 5734.569907256972, 5763.279590051244, 5804.535637149018, 5817.505512031525, 5875.148103525051, 3500.8774692885627, 3539.5752509698486, 3545.432730763117, 3580.549877299698, 3592.173800026009, 6439.484841212692, 6450.838729031811, 6474.028895665688, 6509.349065093453, 6527.8694426111215, 6768.796936091925, 6781.711474819768, 6833.521653484208, 6838.7264509419065, 6857.451403887677, 6438.77464288757, 6461.741530338828, 6479.384458476531, 6536.24833144185, 6544.934550654528, 6565.618706366321, 6580.934190658032, 6597.0, 6611.396788750047, 6630.370114839083, 6050.21347224858, 6399.536178571377, 6482.611043337415, 6522.173791338433, 6639.867202656016, 6431.84839428686, 6434.581752186093, 6482.0, 6536.607803531613, 6567.573107747981, 4916.950830491793, 4933.432655244693, 4938.209886418156, 4941.036497882878, 4947.0, 6547.70535325902, 6630.469562434897, 6652.135222421054, 6701.497387696039, 6748.493862960199, 6118.877622447615, 6210.627362358273, 6387.425131738166, 6387.91405461082, 6429.132067170872, 6277.466415354564, 6341.429271365415, 6414.0, 6422.518311126778, 6435.613863168225, 6353.714082866374, 6358.237011558643, 6366.427021568081, 6415.935840641534, 6431.935680643133, 6464.191976003, 6511.804645860631, 6515.068219301428, 6521.282658907421, 6559.967200163968, 6276.838784824822, 6305.464035556845, 6309.400606942333, 6335.239771227482, 6399.3600639937495], "value": 5017.796904456481, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.9726108216752, 921.7741653294944, 932.0306880843923, 940.2337095267357, 950.7242899559128, 17955.82044179558, 18266.0, 18878.33925812597, 18892.527686807836, 18902.14940327685, 16487.505374838773, 16675.83324166758, 16717.83282167178, 19252.614947701037, 21329.786702132973, 1035.8808736995247, 1067.3009178987775, 1067.6690226029916, 1069.5828626835541, 1069.8020866139789, 1046.0271947089204, 1053.367979212474, 1053.7207639975375, 1053.9104176145038, 1062.8990245926664, 1076.7954088723156, 1110.2006555280186, 1111.4609414433994, 1112.777444511101, 1113.5434471866536, 1020.607066279484, 1065.5364916261412, 1083.0793825248554, 1084.4740300954031, 1091.0562363555546, 790.7943934576994, 791.9683212671487, 792.3581898662102, 792.6155814429997, 794.4240425691386, 18551.53621159482, 18743.062846857603, 19241.13414896333, 19253.711194332096, 19265.13306901193, 19935.202591896308, 20015.0, 20494.282700105425, 20580.27969021077, 20738.585228295502, 15939.92030039854, 15950.202489875459, 15975.84024159755, 15987.920060399623, 16056.0, 3414.7609667323295, 3439.7592168548213, 3505.737069719781, 3662.7252956028406, 3679.6688298053305, 100640.49679751555, 102465.0, 103486.0, 107897.46051269773, 108010.0, 15474.767878481833, 15704.136272504893, 15764.290606922486, 15949.122798245975, 16070.517884463485, 27604.309892252855, 28588.714112859023, 28923.132306030853, 29040.709592904223, 29471.26321841971, 8850.247728942983, 8878.911210887938, 8925.955370223108, 8926.464412135292, 8972.0, 3675.3016926783826, 3760.8871733848027, 3819.656230939229, 3827.655511003967, 3887.378019516864, 4833.903321933612, 4908.312836202935, 4918.434380046269, 4932.728699921467, 4964.379452568429, 1000.279798545061, 1028.2647906746713, 1037.0, 1041.063043261056, 1046.2519298701466, 688.1535711075405, 693.628908533932, 705.7812078255757, 721.6680327049615, 722.6242353975903, 10865.891341086646, 11039.613613523488, 11433.714157146138, 11781.288893998362, 12374.319412432402, 627.075064280183, 640.2924768131242, 648.9480841532666, 662.4634046422317, 664.1001443044702, 4712.575868171881, 4893.8988727536735, 4913.287573301851, 4921.311016457699, 4925.13810083234, 102495.0, 104138.0, 105469.47265263778, 105988.08815931891, 109870.45064774626, 84068.57965710254, 88624.11375886288, 88812.5559372199, 89257.0, 89829.55085224532, 76432.0, 79167.8124828128, 80074.0, 81149.0, 82847.17152828515, 9615.375000625218, 12102.939485302517, 12151.696207594881, 12186.817197741864, 12431.927882239517, 28407.147785566467, 32805.67194328122, 33771.83114084414, 35073.0, 35512.822435887654, 58318.7084064577, 61129.0, 62403.0, 63395.0, 63658.68170659117, 18455.815441845945, 18543.443696689123, 18669.0, 19060.428187154408, 19198.424047278604, 19335.0, 19701.70447443261, 20076.89961550183, 20142.697859531825, 20268.89865550663, 17759.11204439747, 18095.276188952295, 18562.0, 18668.7199692002, 18734.0, 18793.248270069045, 19411.805881941, 19424.320148794723, 19702.014899254693, 19775.703364449833, 15773.921130394274, 16412.0, 17806.554836129202, 17970.460886173434, 18316.450506484827, 11287.717807054889, 11346.432678366215, 12028.75942481128, 12141.453634586642, 12507.624771256877, 11625.88374116248, 12007.0, 12593.685157871127, 13053.34733263352, 13100.541481048118], "value": 8777.319832629002, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 109.0, 109.0, 109.0, 111.0, 109.0, 109.0, 109.0, 108.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 145.0, 178.0, 121.0, 149.0, 155.0, 121.0, 180.0, 120.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 165.0, 163.0, 169.0, 163.0, 170.0, 168.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 167.0, 75.0, 76.0, 75.0, 75.0, 98.0, 75.0], "value": 86.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 136.0, 83.0, 81.0, 83.0, 130.0, 83.0, 83.0, 128.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 116.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 151.0, 149.0, 149.0, 151.0, 150.0, 149.0, 150.0, 152.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 55.0, 57.0, 59.0, 58.0, 55.0, 55.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 55.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 77.0, 77.0, 76.0, 77.0, 78.0, 76.0, 89.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 127.0, 138.0, 125.0, 130.0, 127.0, 126.0, 137.0, 149.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 179.0, 178.0, 180.0, 191.0, 182.0, 178.0, 182.0, 182.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 69.0, 69.0, 71.0, 68.0, 67.0, 69.0, 68.0, 67.0], "value": 69.6, "unit": "score"}]}]} 18:47:24 INFO - Return code: 0 18:47:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:47:24 INFO - # TBPL SUCCESS # 18:47:24 INFO - Running post-action listener: _package_coverage_data 18:47:24 INFO - Running post-action listener: _resource_record_post_action 18:47:24 INFO - [mozharness: 2017-07-02 01:47:24.910414Z] Finished run-tests step (success) 18:47:24 INFO - Running post-run listener: _resource_record_post_run 18:47:24 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 5644288; Write bytes: 444506112; Read time: 1484; Write time: 343732 18:47:24 INFO - TinderboxPrint: CPU usage
13.1% 18:47:24 INFO - TinderboxPrint: I/O read bytes / time
5,644,288 / 1,484 18:47:24 INFO - TinderboxPrint: I/O write bytes / time
444,506,112 / 343,732 18:47:24 INFO - TinderboxPrint: CPU idle
8,294.3 (86.9%) 18:47:24 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 18:47:24 INFO - TinderboxPrint: Swap in / out
0 / 0 18:47:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 113659904; Read time: 0; Write time: 94512 18:47:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:47:25 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 3272704; Write bytes: 330846208; Read time: 1136; Write time: 249220 18:47:25 INFO - Running post-run listener: _upload_blobber_files 18:47:25 INFO - Blob upload gear active. 18:47:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:47:25 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 18:47:25 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'] 18:47:25 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 18:47:25 INFO - (blobuploader) - INFO - Open directory for files ... 18:47:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:47:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:47:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:26 INFO - (blobuploader) - INFO - Done attempting. 18:47:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:47:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:47:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:30 INFO - (blobuploader) - INFO - Done attempting. 18:47:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:47:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:47:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:31 INFO - (blobuploader) - INFO - Done attempting. 18:47:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:47:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:47:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:33 INFO - (blobuploader) - INFO - Done attempting. 18:47:33 INFO - (blobuploader) - INFO - Iteration through files over. 18:47:33 INFO - Return code: 0 18:47:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:47:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:47:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/226563937d9f55e20fd7d23c2630174f617f68ab9351ddaea039213bcf2f64951b2496bf25406cca39535f394cdb7a3ac12b8c894245100d05523df7c1da802f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ccf8ab8459d64b1fb2cbe6b4b027357ec2ce855fbc9187f48968dceb935b96fe90ed86fe3f50cff4e068fc9538f644d9fe27385d2dd0762d72e4e557634ff04", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cee2a83070c2efaa833b6065b6f5aae35796f7d58d1b40e46da7d0ec3136f23282765e87788cbbaaf81936a8108c65ba8901f174922310f578f36b3360ed8c35", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0fbc046efba31735be5047bb72bd4441961bbbaedca0b17d966997856125e3f7064f405f1cd66a75bedb7bfec9e4ffe4f3311c1a18a528bcd480b7d4c5c535a"} 18:47:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:47:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:47:33 INFO - Contents: 18:47:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/226563937d9f55e20fd7d23c2630174f617f68ab9351ddaea039213bcf2f64951b2496bf25406cca39535f394cdb7a3ac12b8c894245100d05523df7c1da802f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ccf8ab8459d64b1fb2cbe6b4b027357ec2ce855fbc9187f48968dceb935b96fe90ed86fe3f50cff4e068fc9538f644d9fe27385d2dd0762d72e4e557634ff04", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cee2a83070c2efaa833b6065b6f5aae35796f7d58d1b40e46da7d0ec3136f23282765e87788cbbaaf81936a8108c65ba8901f174922310f578f36b3360ed8c35", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0fbc046efba31735be5047bb72bd4441961bbbaedca0b17d966997856125e3f7064f405f1cd66a75bedb7bfec9e4ffe4f3311c1a18a528bcd480b7d4c5c535a"} 18:47:33 INFO - Running post-run listener: copy_logs_to_upload_dir 18:47:33 INFO - Copying logs to upload dir... 18:47:33 INFO - mkdir: /builds/slave/test/build/upload/logs 18:47:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.690012 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-07-01 18:47:33.053626) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-01 18:47:33.059202) ========= 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=923d835db2ba3686ebe126b700000192-1498952097.417011-475883730 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/226563937d9f55e20fd7d23c2630174f617f68ab9351ddaea039213bcf2f64951b2496bf25406cca39535f394cdb7a3ac12b8c894245100d05523df7c1da802f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ccf8ab8459d64b1fb2cbe6b4b027357ec2ce855fbc9187f48968dceb935b96fe90ed86fe3f50cff4e068fc9538f644d9fe27385d2dd0762d72e4e557634ff04", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cee2a83070c2efaa833b6065b6f5aae35796f7d58d1b40e46da7d0ec3136f23282765e87788cbbaaf81936a8108c65ba8901f174922310f578f36b3360ed8c35", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0fbc046efba31735be5047bb72bd4441961bbbaedca0b17d966997856125e3f7064f405f1cd66a75bedb7bfec9e4ffe4f3311c1a18a528bcd480b7d4c5c535a"} build_url:https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/dRaCMvOKTPSLvRajFdoGaw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/226563937d9f55e20fd7d23c2630174f617f68ab9351ddaea039213bcf2f64951b2496bf25406cca39535f394cdb7a3ac12b8c894245100d05523df7c1da802f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ccf8ab8459d64b1fb2cbe6b4b027357ec2ce855fbc9187f48968dceb935b96fe90ed86fe3f50cff4e068fc9538f644d9fe27385d2dd0762d72e4e557634ff04", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cee2a83070c2efaa833b6065b6f5aae35796f7d58d1b40e46da7d0ec3136f23282765e87788cbbaaf81936a8108c65ba8901f174922310f578f36b3360ed8c35", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0fbc046efba31735be5047bb72bd4441961bbbaedca0b17d966997856125e3f7064f405f1cd66a75bedb7bfec9e4ffe4f3311c1a18a528bcd480b7d4c5c535a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-01 18:47:33.084516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:47:33.088929) ========= 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=923d835db2ba3686ebe126b700000192-1498952097.417011-475883730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:47:33.167977) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-01 18:47:33.168415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-01 18:47:33.168800) ========= ========= Total master_lag: 0.21 =========