builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1498556743.53 results: success (0) revision: 53477d584130945864c4491632f88da437353356 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-27 02:45:43.532206) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-27 02:45:43.532768) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-27 02:45:43.533050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-27 02:45:43.575072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-27 02:45:43.575327) ========= 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=00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-27 02:45:43-- 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% 57.0K=0.2s 2017-06-27 02:45:43 (57.0 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.376640 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-27 02:45:43.964161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-27 02:45:43.964450) ========= 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=00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018140 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-27 02:45:44.015878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-27 02:45:44.016165) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 53477d584130945864c4491632f88da437353356 --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 53477d584130945864c4491632f88da437353356 --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=00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-27 02:45:43,894 truncating revision to first 12 chars 2017-06-27 02:45:43,894 Setting DEBUG logging. 2017-06-27 02:45:43,894 attempt 1/10 2017-06-27 02:45:43,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/53477d584130?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-27 02:45:44,802 unpacking tar archive at: mozilla-central-53477d584130/testing/mozharness/ program finished with exit code 0 elapsedTime=1.656439 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-27 02:45:45.690689) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-27 02:45:45.690985) ========= script_repo_revision: 53477d584130945864c4491632f88da437353356 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-27 02:45:45.691369) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-27 02:45:45.691662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-27 02:45:45.700113) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-06-27 02:45:45.700375) ========= /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=00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:45:45 INFO - MultiFileLogger online at 20170627 02:45:45 in /builds/slave/test 02:45:45 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 02:45:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:45:45 INFO - {'append_to_log': False, 02:45:45 INFO - 'base_work_dir': '/builds/slave/test', 02:45:45 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:45:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:45:45 INFO - 'branch': 'Firefox-Non-PGO', 02:45:45 INFO - 'buildbot_json_path': 'buildprops.json', 02:45:45 INFO - 'config_files': ('talos/linux_config.py',), 02:45:45 INFO - 'default_actions': ('clobber', 02:45:45 INFO - 'read-buildbot-config', 02:45:45 INFO - 'download-and-extract', 02:45:45 INFO - 'populate-webroot', 02:45:45 INFO - 'create-virtualenv', 02:45:45 INFO - 'install', 02:45:45 INFO - 'setup-mitmproxy', 02:45:45 INFO - 'run-tests'), 02:45:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:45:45 INFO - 'download_minidump_stackwalk': True, 02:45:45 INFO - 'download_symbols': 'ondemand', 02:45:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:45:45 INFO - 'tooltool.py': '/tools/tooltool.py', 02:45:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:45:45 INFO - '/tools/misc-python/virtualenv.py')}, 02:45:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:45:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:45:45 INFO - 'gecko_profile': False, 02:45:45 INFO - 'gecko_profile_interval': 0, 02:45:45 INFO - 'installer_path': 'installer.exe', 02:45:45 INFO - 'log_level': 'info', 02:45:45 INFO - 'log_name': 'talos', 02:45:45 INFO - 'log_to_console': True, 02:45:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:45:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:45:45 INFO - 'opt_config_files': (), 02:45:45 INFO - 'pip_index': False, 02:45:45 INFO - 'suite': 'dromaeojs-e10s', 02:45:45 INFO - 'system_bits': '32', 02:45:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:45:45 INFO - 'title': 'talos-linux64-ix-016', 02:45:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:45:45 INFO - 'use_talos_json': True, 02:45:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:45:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:45:45 INFO - 'work_dir': 'build'} 02:45:45 INFO - [mozharness: 2017-06-27 09:45:45.684976Z] Running clobber step. 02:45:45 INFO - Running pre-action listener: _resource_record_pre_action 02:45:45 INFO - Running main action method: clobber 02:45:45 INFO - rmtree: /builds/slave/test/build 02:45:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:45:47 INFO - Running post-action listener: _resource_record_post_action 02:45:47 INFO - [mozharness: 2017-06-27 09:45:47.236073Z] Finished clobber step (success) 02:45:47 INFO - [mozharness: 2017-06-27 09:45:47.236171Z] Running read-buildbot-config step. 02:45:47 INFO - Running pre-action listener: _resource_record_pre_action 02:45:47 INFO - Running main action method: read_buildbot_config 02:45:47 INFO - Using buildbot properties: 02:45:47 INFO - { 02:45:47 INFO - "project": "", 02:45:47 INFO - "product": "firefox", 02:45:47 INFO - "who": "cbook@mozilla.com", 02:45:47 INFO - "installer_path": "public/build/target.tar.bz2", 02:45:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:45:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:45:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:45:47 INFO - "stage_platform": "linux64", 02:45:47 INFO - "basedir": "/builds/slave/test", 02:45:47 INFO - "buildnumber": 685, 02:45:47 INFO - "platform": "ubuntu64_hw", 02:45:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:45:47 INFO - "slavebuilddir": "test", 02:45:47 INFO - "taskId": "OLeiB8B2TRGMUAuuGrlCMg", 02:45:47 INFO - "branch": "mozilla-central", 02:45:47 INFO - "script_repo_revision": "production", 02:45:47 INFO - "revision": "53477d584130945864c4491632f88da437353356", 02:45:47 INFO - "slavename": "talos-linux64-ix-016", 02:45:47 INFO - "repo_path": "mozilla-central" 02:45:47 INFO - } 02:45:47 INFO - Finding installer, test and symbols from parent task. 02:45:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OLeiB8B2TRGMUAuuGrlCMg'}, attempt #1 02:45:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OLeiB8B2TRGMUAuuGrlCMg'}, attempt #1 02:45:48 INFO - Task dependencies: TDXsJsKlQF-1ylW3NoXOBQ 02:45:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ'}, attempt #1 02:45:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.tar.bz2 02:45:48 INFO - Set test_url: https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/test_packages.json 02:45:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.crashreporter-symbols.zip 02:45:48 INFO - Running post-action listener: _resource_record_post_action 02:45:48 INFO - [mozharness: 2017-06-27 09:45:48.605683Z] Finished read-buildbot-config step (success) 02:45:48 INFO - [mozharness: 2017-06-27 09:45:48.605991Z] Running download-and-extract step. 02:45:48 INFO - Running pre-action listener: _resource_record_pre_action 02:45:48 INFO - Running main action method: download_and_extract 02:45:48 INFO - mkdir: /builds/slave/test/build/tests 02:45:48 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')]} 02:45:48 INFO - trying https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.test_packages.json 02:45:48 INFO - Downloading https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:45:49 INFO - Downloaded 989 bytes. 02:45:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:45:49 INFO - Using the following test package requirements: 02:45:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:45:49 INFO - u'common': [u'target.common.tests.zip'], 02:45:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:45:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:45:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:45:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:45:49 INFO - u'mozbase': [u'target.common.tests.zip'], 02:45:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:45:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:45:49 INFO - u'web-platform': [u'target.common.tests.zip', 02:45:49 INFO - u'target.web-platform.tests.tar.gz'], 02:45:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:45:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:45:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.common.tests.zip 02:45:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:45:49 INFO - Fetch https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.common.tests.zip into memory 02:45:50 INFO - Content-Length response header: 67751011 02:45:50 INFO - Bytes received: 67751011 02:46:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:46:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.common.tests.zip 02:46:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:46:01 INFO - Fetch https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.common.tests.zip into memory 02:46:02 INFO - Content-Length response header: 67751011 02:46:02 INFO - Bytes received: 67751011 02:46:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.talos.tests.zip 02:46:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:46:14 INFO - Fetch https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.talos.tests.zip into memory 02:46:24 INFO - Content-Length response header: 14442527 02:46:24 INFO - Bytes received: 14442527 02:46: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')]} 02:46:24 INFO - trying https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.tar.bz2 02:46:24 INFO - Downloading https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:46:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:46:26 INFO - Downloaded 61895528 bytes. 02:46:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.tar.bz2 02:46:26 INFO - mkdir: /builds/slave/test/properties 02:46:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:46:26 INFO - Writing to file /builds/slave/test/properties/build_url 02:46:26 INFO - Contents: 02:46:26 INFO - build_url:https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.tar.bz2 02:46:26 INFO - Running post-action listener: _resource_record_post_action 02:46:26 INFO - Running post-action listener: set_extra_try_arguments 02:46:26 INFO - [mozharness: 2017-06-27 09:46:26.989471Z] Finished download-and-extract step (success) 02:46:26 INFO - [mozharness: 2017-06-27 09:46:26.989606Z] Running populate-webroot step. 02:46:26 INFO - Running pre-action listener: _resource_record_pre_action 02:46:26 INFO - Running main action method: populate_webroot 02:46:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:46:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:46:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:46:26 INFO - '--tppagecycles', 02:46:26 INFO - '7'], 02:46:26 INFO - 'tests': ['tsvgm']}}, 02:46:26 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:46:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:46:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:46:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:46:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:46:27 INFO - 'talos_options': ['--disable-e10s'], 02:46:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:46:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:46:27 INFO - 'talos_options': ['--disable-e10s'], 02:46:27 INFO - 'tests': ['damp', 'tps']}, 02:46:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:46:27 INFO - 'tests': ['damp', 'tps']}, 02:46:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:46:27 INFO - 'tests': ['dromaeo_dom']}, 02:46:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:46:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:46:27 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:46:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:46:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:46:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:46:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:46:27 INFO - 'tests': ['a11yr', 02:46:27 INFO - 'ts_paint', 02:46:27 INFO - 'tpaint', 02:46:27 INFO - 'sessionrestore', 02:46:27 INFO - 'sessionrestore_no_auto_restore', 02:46:27 INFO - 'tabpaint']}, 02:46:27 INFO - 'other-e10s': {'tests': ['a11yr', 02:46:27 INFO - 'ts_paint', 02:46:27 INFO - 'tpaint', 02:46:27 INFO - 'sessionrestore', 02:46:27 INFO - 'sessionrestore_no_auto_restore', 02:46:27 INFO - 'tabpaint']}, 02:46:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:46:27 INFO - 'ts_paint', 02:46:27 INFO - 'tpaint', 02:46:27 INFO - 'sessionrestore', 02:46:27 INFO - 'sessionrestore_no_auto_restore', 02:46:27 INFO - 'tabpaint']}, 02:46:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:46:27 INFO - 'ts_paint', 02:46:27 INFO - 'tpaint', 02:46:27 INFO - 'sessionrestore', 02:46:27 INFO - 'sessionrestore_no_auto_restore', 02:46:27 INFO - 'tabpaint']}, 02:46:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:46:27 INFO - 'tests': ['a11yr', 02:46:27 INFO - 'ts_paint', 02:46:27 INFO - 'tpaint', 02:46:27 INFO - 'sessionrestore', 02:46:27 INFO - 'sessionrestore_no_auto_restore', 02:46:27 INFO - 'tabpaint']}, 02:46:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:46:27 INFO - 'tests': ['a11yr', 02:46:27 INFO - 'ts_paint', 02:46:27 INFO - 'tpaint', 02:46:27 INFO - 'sessionrestore', 02:46:27 INFO - 'sessionrestore_no_auto_restore', 02:46:27 INFO - 'tabpaint']}, 02:46:27 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:46:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:46:27 INFO - 'bloom_basic_ref']}, 02:46:27 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:46:27 INFO - 'talos_options': ['--mitmproxy', 02:46:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:46:27 INFO - '--firstNonBlankPaint'], 02:46:27 INFO - 'tests': ['quantum_pageload_google', 02:46:27 INFO - 'quantum_pageload_youtube', 02:46:27 INFO - 'quantum_pageload_amazon', 02:46:27 INFO - 'quantum_pageload_facebook']}, 02:46:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:46:27 INFO - 'tests': ['tsvgx', 02:46:27 INFO - 'tsvgr_opacity', 02:46:27 INFO - 'tart', 02:46:27 INFO - 'tscrollx', 02:46:27 INFO - 'cart', 02:46:27 INFO - 'tsvg_static']}, 02:46:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:46:27 INFO - 'tsvgr_opacity', 02:46:27 INFO - 'tart', 02:46:27 INFO - 'tscrollx', 02:46:27 INFO - 'cart', 02:46:27 INFO - 'tsvg_static']}, 02:46:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:46:27 INFO - 'talos_options': ['--disable-e10s'], 02:46:27 INFO - 'tests': ['tp5o']}, 02:46:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:46:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:46:27 INFO - 'talos_options': ['--disable-e10s', 02:46:27 INFO - '--xperf_path', 02:46:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:27 INFO - 'tests': ['tp5n']}, 02:46:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:46:27 INFO - 'talos_options': ['--xperf_path', 02:46:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:27 INFO - 'tests': ['tp5n']}}, 02:46:27 INFO - 'talos.zip': {'path': '', 02:46:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:46:27 INFO - Running post-action listener: _resource_record_post_action 02:46:27 INFO - [mozharness: 2017-06-27 09:46:27.007267Z] Finished populate-webroot step (success) 02:46:27 INFO - [mozharness: 2017-06-27 09:46:27.007357Z] Running create-virtualenv step. 02:46:27 INFO - Running pre-action listener: _resource_record_pre_action 02:46:27 INFO - Running main action method: create_virtualenv 02:46:27 INFO - Creating virtualenv /builds/slave/test/build/venv 02:46:27 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 02:46:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:46:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:46:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:46:27 INFO - Using real prefix '/usr' 02:46:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:46:27 INFO - Installing distribute.............................................................................................................................................................................................done. 02:46:29 INFO - Installing pip.................done. 02:46:29 INFO - Return code: 0 02:46:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:46:29 INFO - Reading from file tmpfile_stdout 02:46:29 INFO - Output received: 02:46:29 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) 02:46:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:46:29 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')]} 02:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:29 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')]} 02:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:29 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 0x10d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144e140>, '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 0x144ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144eed0>, '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': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', '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 02:46:29 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 02:46:29 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 02:46:29 INFO - Using env: {'DISPLAY': ':0', 02:46:29 INFO - 'HOME': '/home/cltbld', 02:46:29 INFO - 'LANG': 'en_US.UTF-8', 02:46:29 INFO - 'LANGUAGE': 'en_US:en', 02:46:29 INFO - 'LOGNAME': 'cltbld', 02:46:29 INFO - 'MAIL': '/var/mail/cltbld', 02:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:29 INFO - 'MOZ_NO_REMOTE': '1', 02:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:29 INFO - 'NO_EM_RESTART': '1', 02:46:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:29 INFO - 'PWD': '/builds/slave/test', 02:46:29 INFO - 'SHELL': '/bin/bash', 02:46:29 INFO - 'SHLVL': '1', 02:46:29 INFO - 'TERM': 'linux', 02:46:29 INFO - 'TMOUT': '86400', 02:46:29 INFO - 'USER': 'cltbld', 02:46:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', 02:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:29 INFO - '_': '/tools/buildbot/bin/python'} 02:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:30 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 02:46:30 INFO - Cleaning up... 02:46:30 INFO - Return code: 0 02:46:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:30 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 0x10d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144e140>, '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 0x144ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144eed0>, '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': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', '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 02:46:30 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 02:46:30 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 02:46:30 INFO - Using env: {'DISPLAY': ':0', 02:46:30 INFO - 'HOME': '/home/cltbld', 02:46:30 INFO - 'LANG': 'en_US.UTF-8', 02:46:30 INFO - 'LANGUAGE': 'en_US:en', 02:46:30 INFO - 'LOGNAME': 'cltbld', 02:46:30 INFO - 'MAIL': '/var/mail/cltbld', 02:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:30 INFO - 'MOZ_NO_REMOTE': '1', 02:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:30 INFO - 'NO_EM_RESTART': '1', 02:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:30 INFO - 'PWD': '/builds/slave/test', 02:46:30 INFO - 'SHELL': '/bin/bash', 02:46:30 INFO - 'SHLVL': '1', 02:46:30 INFO - 'TERM': 'linux', 02:46:30 INFO - 'TMOUT': '86400', 02:46:30 INFO - 'USER': 'cltbld', 02:46:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', 02:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:30 INFO - '_': '/tools/buildbot/bin/python'} 02:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:30 INFO - Downloading/unpacking psutil>=3.1.1 02:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:46:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:31 INFO - Installing collected packages: psutil 02:46:31 INFO - Running setup.py install for psutil 02:46:31 INFO - building 'psutil._psutil_linux' extension 02:46:31 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 02:46:31 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 02:46:31 INFO - building 'psutil._psutil_posix' extension 02:46:31 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 02:46:31 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 02:46:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:31 INFO - Successfully installed psutil 02:46:31 INFO - Cleaning up... 02:46:32 INFO - Return code: 0 02:46:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:46:32 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')]} 02:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:32 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')]} 02:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:32 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 0x10d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144e140>, '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 0x144ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144eed0>, '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': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', '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 02:46:32 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 02:46:32 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 02:46:32 INFO - Using env: {'DISPLAY': ':0', 02:46:32 INFO - 'HOME': '/home/cltbld', 02:46:32 INFO - 'LANG': 'en_US.UTF-8', 02:46:32 INFO - 'LANGUAGE': 'en_US:en', 02:46:32 INFO - 'LOGNAME': 'cltbld', 02:46:32 INFO - 'MAIL': '/var/mail/cltbld', 02:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:32 INFO - 'MOZ_NO_REMOTE': '1', 02:46:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:32 INFO - 'NO_EM_RESTART': '1', 02:46:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:32 INFO - 'PWD': '/builds/slave/test', 02:46:32 INFO - 'SHELL': '/bin/bash', 02:46:32 INFO - 'SHLVL': '1', 02:46:32 INFO - 'TERM': 'linux', 02:46:32 INFO - 'TMOUT': '86400', 02:46:32 INFO - 'USER': 'cltbld', 02:46:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', 02:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:32 INFO - '_': '/tools/buildbot/bin/python'} 02:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:46:32 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 02:46:32 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 02:46:32 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 02:46:32 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 02:46:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:46:33 INFO - Installing collected packages: mozsystemmonitor 02:46:33 INFO - Running setup.py install for mozsystemmonitor 02:46:33 INFO - Successfully installed mozsystemmonitor 02:46:33 INFO - Cleaning up... 02:46:33 INFO - Return code: 0 02:46:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:46:33 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')]} 02:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:33 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')]} 02:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:33 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 0x10d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144e140>, '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 0x144ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144eed0>, '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': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', '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 02:46:33 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 02:46:33 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 02:46:33 INFO - Using env: {'DISPLAY': ':0', 02:46:33 INFO - 'HOME': '/home/cltbld', 02:46:33 INFO - 'LANG': 'en_US.UTF-8', 02:46:33 INFO - 'LANGUAGE': 'en_US:en', 02:46:33 INFO - 'LOGNAME': 'cltbld', 02:46:33 INFO - 'MAIL': '/var/mail/cltbld', 02:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:33 INFO - 'MOZ_NO_REMOTE': '1', 02:46:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:33 INFO - 'NO_EM_RESTART': '1', 02:46:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:33 INFO - 'PWD': '/builds/slave/test', 02:46:33 INFO - 'SHELL': '/bin/bash', 02:46:33 INFO - 'SHLVL': '1', 02:46:33 INFO - 'TERM': 'linux', 02:46:33 INFO - 'TMOUT': '86400', 02:46:33 INFO - 'USER': 'cltbld', 02:46:33 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', 02:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:33 INFO - '_': '/tools/buildbot/bin/python'} 02:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:33 INFO - Downloading/unpacking jsonschema==2.5.1 02:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:46:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:46:34 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 02:46:34 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 02:46:34 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 02:46:34 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 02:46:34 INFO - Downloading functools32-3.2.3-2.tar.gz 02:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:46:34 INFO - warning: no files found matching '*.txt' 02:46:34 INFO - no previously-included directories found matching 'build' 02:46:34 INFO - no previously-included directories found matching 'dist' 02:46:34 INFO - no previously-included directories found matching '.git*' 02:46:34 INFO - Installing collected packages: jsonschema, functools32 02:46:35 INFO - Running setup.py install for functools32 02:46:35 INFO - warning: no files found matching '*.txt' 02:46:35 INFO - no previously-included directories found matching 'build' 02:46:35 INFO - no previously-included directories found matching 'dist' 02:46:35 INFO - no previously-included directories found matching '.git*' 02:46:35 INFO - Successfully installed jsonschema functools32 02:46:35 INFO - Cleaning up... 02:46:35 INFO - Return code: 0 02:46:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:46:35 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')]} 02:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:35 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')]} 02:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:35 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 0x10d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144e140>, '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 0x144ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144eed0>, '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': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', '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 02:46:35 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 02:46:35 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 02:46:35 INFO - Using env: {'DISPLAY': ':0', 02:46:35 INFO - 'HOME': '/home/cltbld', 02:46:35 INFO - 'LANG': 'en_US.UTF-8', 02:46:35 INFO - 'LANGUAGE': 'en_US:en', 02:46:35 INFO - 'LOGNAME': 'cltbld', 02:46:35 INFO - 'MAIL': '/var/mail/cltbld', 02:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:35 INFO - 'MOZ_NO_REMOTE': '1', 02:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:35 INFO - 'NO_EM_RESTART': '1', 02:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:35 INFO - 'PWD': '/builds/slave/test', 02:46:35 INFO - 'SHELL': '/bin/bash', 02:46:35 INFO - 'SHLVL': '1', 02:46:35 INFO - 'TERM': 'linux', 02:46:35 INFO - 'TMOUT': '86400', 02:46:35 INFO - 'USER': 'cltbld', 02:46:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', 02:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:35 INFO - '_': '/tools/buildbot/bin/python'} 02:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:46:35 INFO - Cleaning up... 02:46:35 INFO - Return code: 0 02:46:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:46:35 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')]} 02:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:35 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')]} 02:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:35 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 0x10d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144e140>, '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 0x144ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144eed0>, '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': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', '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 02:46:35 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 02:46:35 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 02:46:35 INFO - Using env: {'DISPLAY': ':0', 02:46:35 INFO - 'HOME': '/home/cltbld', 02:46:35 INFO - 'LANG': 'en_US.UTF-8', 02:46:35 INFO - 'LANGUAGE': 'en_US:en', 02:46:35 INFO - 'LOGNAME': 'cltbld', 02:46:35 INFO - 'MAIL': '/var/mail/cltbld', 02:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:35 INFO - 'MOZ_NO_REMOTE': '1', 02:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:35 INFO - 'NO_EM_RESTART': '1', 02:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:35 INFO - 'PWD': '/builds/slave/test', 02:46:35 INFO - 'SHELL': '/bin/bash', 02:46:35 INFO - 'SHLVL': '1', 02:46:35 INFO - 'TERM': 'linux', 02:46:35 INFO - 'TMOUT': '86400', 02:46:35 INFO - 'USER': 'cltbld', 02:46:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', 02:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:35 INFO - '_': '/tools/buildbot/bin/python'} 02:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:35 INFO - Downloading/unpacking blobuploader==1.2.4 02:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:36 INFO - Downloading blobuploader-1.2.4.tar.gz 02:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:46:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:46:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:46:37 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 02:46:37 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 02:46:37 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 02:46:37 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 02:46:37 INFO - Downloading docopt-0.6.1.tar.gz 02:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:46:37 INFO - Installing collected packages: blobuploader, requests, docopt 02:46:37 INFO - Running setup.py install for blobuploader 02:46:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:46:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:46:37 INFO - Running setup.py install for requests 02:46:37 INFO - Running setup.py install for docopt 02:46:37 INFO - Successfully installed blobuploader requests docopt 02:46:37 INFO - Cleaning up... 02:46:37 INFO - Return code: 0 02:46:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:37 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 0x10d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144e140>, '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 0x144ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144eed0>, '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': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', '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 02:46:37 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 02:46:37 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 02:46:37 INFO - Using env: {'DISPLAY': ':0', 02:46:37 INFO - 'HOME': '/home/cltbld', 02:46:37 INFO - 'LANG': 'en_US.UTF-8', 02:46:37 INFO - 'LANGUAGE': 'en_US:en', 02:46:37 INFO - 'LOGNAME': 'cltbld', 02:46:37 INFO - 'MAIL': '/var/mail/cltbld', 02:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:37 INFO - 'MOZ_NO_REMOTE': '1', 02:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:37 INFO - 'NO_EM_RESTART': '1', 02:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:37 INFO - 'PWD': '/builds/slave/test', 02:46:37 INFO - 'SHELL': '/bin/bash', 02:46:37 INFO - 'SHLVL': '1', 02:46:37 INFO - 'TERM': 'linux', 02:46:37 INFO - 'TMOUT': '86400', 02:46:37 INFO - 'USER': 'cltbld', 02:46:37 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', 02:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:37 INFO - '_': '/tools/buildbot/bin/python'} 02:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:38 INFO - Running setup.py (path:/tmp/pip-bCFly1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:38 INFO - Running setup.py (path:/tmp/pip-rQXcTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:38 INFO - Running setup.py (path:/tmp/pip-9lZEXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:38 INFO - Running setup.py (path:/tmp/pip-eOiQZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:38 INFO - Running setup.py (path:/tmp/pip-JAGYF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:38 INFO - Running setup.py (path:/tmp/pip-5ri4Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:38 INFO - Running setup.py (path:/tmp/pip-K35M02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:38 INFO - Running setup.py (path:/tmp/pip-uciMD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:38 INFO - Running setup.py (path:/tmp/pip-e9rU8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:38 INFO - Running setup.py (path:/tmp/pip-j0Dr_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:38 INFO - Running setup.py (path:/tmp/pip-ICX0yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:38 INFO - Running setup.py (path:/tmp/pip-zOYcNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:39 INFO - Running setup.py (path:/tmp/pip-ROaCDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:39 INFO - Running setup.py (path:/tmp/pip-TmdAwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:39 INFO - Running setup.py (path:/tmp/pip-T8_y5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:39 INFO - Running setup.py (path:/tmp/pip-l0Z1iY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:39 INFO - Running setup.py (path:/tmp/pip-8Kv4ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:46:39 INFO - Running setup.py install for manifestparser 02:46:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:46:39 INFO - Running setup.py install for mozcrash 02:46:39 INFO - Running setup.py install for mozdebug 02:46:39 INFO - Running setup.py install for mozdevice 02:46:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:46:39 INFO - Running setup.py install for mozfile 02:46:39 INFO - Running setup.py install for mozhttpd 02:46:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:46:39 INFO - Running setup.py install for mozinfo 02:46:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:46:40 INFO - Running setup.py install for mozInstall 02:46:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:46:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:46:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:46:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:46:40 INFO - Running setup.py install for mozleak 02:46:40 INFO - Running setup.py install for mozlog 02:46:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:46:40 INFO - Running setup.py install for moznetwork 02:46:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:46:40 INFO - Running setup.py install for mozprocess 02:46:40 INFO - Running setup.py install for mozprofile 02:46:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:46:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:46:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:46:40 INFO - Running setup.py install for mozrunner 02:46:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:46:40 INFO - Running setup.py install for mozscreenshot 02:46:40 INFO - Running setup.py install for moztest 02:46:41 INFO - Running setup.py install for mozversion 02:46:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:46:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:46:41 INFO - Cleaning up... 02:46:41 INFO - Return code: 0 02:46:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:41 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 0x10d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144e140>, '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 0x144ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144eed0>, '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': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', '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 02:46:41 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 02:46:41 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 02:46:41 INFO - Using env: {'DISPLAY': ':0', 02:46:41 INFO - 'HOME': '/home/cltbld', 02:46:41 INFO - 'LANG': 'en_US.UTF-8', 02:46:41 INFO - 'LANGUAGE': 'en_US:en', 02:46:41 INFO - 'LOGNAME': 'cltbld', 02:46:41 INFO - 'MAIL': '/var/mail/cltbld', 02:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:41 INFO - 'MOZ_NO_REMOTE': '1', 02:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:41 INFO - 'NO_EM_RESTART': '1', 02:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:41 INFO - 'PWD': '/builds/slave/test', 02:46:41 INFO - 'SHELL': '/bin/bash', 02:46:41 INFO - 'SHLVL': '1', 02:46:41 INFO - 'TERM': 'linux', 02:46:41 INFO - 'TMOUT': '86400', 02:46:41 INFO - 'USER': 'cltbld', 02:46:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', 02:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:41 INFO - '_': '/tools/buildbot/bin/python'} 02:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:41 INFO - Running setup.py (path:/tmp/pip-xfSLGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:41 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)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:41 INFO - Running setup.py (path:/tmp/pip-AGN_9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:41 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)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:41 INFO - Running setup.py (path:/tmp/pip-INqnKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:41 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)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:41 INFO - Running setup.py (path:/tmp/pip-BWyX3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:41 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)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:41 INFO - Running setup.py (path:/tmp/pip-a_QYeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:41 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)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:41 INFO - Running setup.py (path:/tmp/pip-TzctOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:41 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)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:41 INFO - Running setup.py (path:/tmp/pip-kHWlsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:41 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)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:41 INFO - Running setup.py (path:/tmp/pip-zw1aMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:41 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)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:41 INFO - Running setup.py (path:/tmp/pip-9z0iCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:42 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)) 02:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:42 INFO - Running setup.py (path:/tmp/pip-KpH5Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:42 INFO - Running setup.py (path:/tmp/pip-g4yPZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:42 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)) 02:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:42 INFO - Running setup.py (path:/tmp/pip-C_5vgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:42 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)) 02:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:42 INFO - Running setup.py (path:/tmp/pip-C0TOKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:42 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)) 02:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:42 INFO - Running setup.py (path:/tmp/pip-HfN0dO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:42 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)) 02:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:42 INFO - Running setup.py (path:/tmp/pip-RszHyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:42 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)) 02:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:42 INFO - Running setup.py (path:/tmp/pip-T18Cga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:42 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)) 02:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:42 INFO - Running setup.py (path:/tmp/pip-mOFIJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:42 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)) 02:46:42 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)) 02:46:42 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)) 02:46:42 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)) 02:46:42 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)) 02:46:42 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)) 02:46:42 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)) 02:46:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:42 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 02:46:42 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 02:46:42 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 02:46:42 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 02:46:43 INFO - Downloading blessings-1.6.tar.gz 02:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:46:44 INFO - Installing collected packages: blessings 02:46:44 INFO - Running setup.py install for blessings 02:46:44 INFO - Successfully installed blessings 02:46:44 INFO - Cleaning up... 02:46:44 INFO - Return code: 0 02:46:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:46:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:44 INFO - Reading from file tmpfile_stdout 02:46:44 INFO - Current package versions: 02:46:44 INFO - argparse == 1.2.1 02:46:44 INFO - blessings == 1.6 02:46:44 INFO - blobuploader == 1.2.4 02:46:44 INFO - docopt == 0.6.1 02:46:44 INFO - functools32 == 3.2.3-2 02:46:44 INFO - jsonschema == 2.5.1 02:46:44 INFO - manifestparser == 1.1 02:46:44 INFO - mozInstall == 1.13 02:46:44 INFO - mozcrash == 1.0 02:46:44 INFO - mozdebug == 0.1 02:46:44 INFO - mozdevice == 0.51 02:46:44 INFO - mozfile == 1.2 02:46:44 INFO - mozhttpd == 0.7 02:46:44 INFO - mozinfo == 0.10 02:46:44 INFO - mozleak == 0.1 02:46:44 INFO - mozlog == 3.4 02:46:44 INFO - moznetwork == 0.27 02:46:44 INFO - mozprocess == 0.25 02:46:44 INFO - mozprofile == 0.28 02:46:44 INFO - mozrunner == 6.13 02:46:44 INFO - mozscreenshot == 0.1 02:46:44 INFO - mozsystemmonitor == 0.3 02:46:44 INFO - moztest == 0.8 02:46:44 INFO - mozversion == 1.4 02:46:44 INFO - psutil == 3.1.1 02:46:44 INFO - requests == 1.2.3 02:46:44 INFO - wsgiref == 0.1.2 02:46:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:44 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')]} 02:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:44 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')]} 02:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:44 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 0x10d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144e140>, '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 0x144ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144eed0>, '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': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', '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 02:46:44 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 02:46:44 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 02:46:44 INFO - Using env: {'DISPLAY': ':0', 02:46:44 INFO - 'HOME': '/home/cltbld', 02:46:44 INFO - 'LANG': 'en_US.UTF-8', 02:46:44 INFO - 'LANGUAGE': 'en_US:en', 02:46:44 INFO - 'LOGNAME': 'cltbld', 02:46:44 INFO - 'MAIL': '/var/mail/cltbld', 02:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:44 INFO - 'MOZ_NO_REMOTE': '1', 02:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:44 INFO - 'NO_EM_RESTART': '1', 02:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:44 INFO - 'PWD': '/builds/slave/test', 02:46:44 INFO - 'SHELL': '/bin/bash', 02:46:44 INFO - 'SHLVL': '1', 02:46:44 INFO - 'TERM': 'linux', 02:46:44 INFO - 'TMOUT': '86400', 02:46:44 INFO - 'USER': 'cltbld', 02:46:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', 02:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:44 INFO - '_': '/tools/buildbot/bin/python'} 02:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:44 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)) 02:46:44 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)) 02:46:44 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)) 02:46:44 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)) 02:46:44 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)) 02:46:44 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)) 02:46:44 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)) 02:46:44 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)) 02:46:44 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)) 02:46:44 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:46:44 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 02:46:44 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 02:46:44 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 02:46:44 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 02:46:45 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:46:45 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)) 02:46:45 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)) 02:46:45 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)) 02:46:45 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)) 02:46:45 INFO - Installing collected packages: marionette-driver 02:46:45 INFO - Running setup.py install for marionette-driver 02:46:45 INFO - Successfully installed marionette-driver 02:46:45 INFO - Cleaning up... 02:46:45 INFO - Return code: 0 02:46:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144e140>, '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 0x144ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144eed0>, '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': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', '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 02:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:46:45 INFO - Using env: {'DISPLAY': ':0', 02:46:45 INFO - 'HOME': '/home/cltbld', 02:46:45 INFO - 'LANG': 'en_US.UTF-8', 02:46:45 INFO - 'LANGUAGE': 'en_US:en', 02:46:45 INFO - 'LOGNAME': 'cltbld', 02:46:45 INFO - 'MAIL': '/var/mail/cltbld', 02:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:45 INFO - 'MOZ_NO_REMOTE': '1', 02:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:45 INFO - 'NO_EM_RESTART': '1', 02:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:45 INFO - 'PWD': '/builds/slave/test', 02:46:45 INFO - 'SHELL': '/bin/bash', 02:46:45 INFO - 'SHLVL': '1', 02:46:45 INFO - 'TERM': 'linux', 02:46:45 INFO - 'TMOUT': '86400', 02:46:45 INFO - 'USER': 'cltbld', 02:46:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', 02:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:45 INFO - '_': '/tools/buildbot/bin/python'} 02:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:46:46 INFO - Cleaning up... 02:46:46 INFO - Return code: 0 02:46:46 INFO - Running post-action listener: _resource_record_post_action 02:46:46 INFO - Running post-action listener: _start_resource_monitoring 02:46:46 INFO - Starting resource monitoring. 02:46:46 INFO - [mozharness: 2017-06-27 09:46:46.176668Z] Finished create-virtualenv step (success) 02:46:46 INFO - [mozharness: 2017-06-27 09:46:46.177182Z] Running install step. 02:46:46 INFO - Running pre-action listener: _resource_record_pre_action 02:46:46 INFO - Running main action method: install 02:46:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:46 INFO - Reading from file tmpfile_stdout 02:46:46 INFO - Detecting whether we're running mozinstall >=1.0... 02:46:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:46:46 INFO - Reading from file tmpfile_stdout 02:46:46 INFO - Output received: 02:46:46 INFO - Usage: mozinstall [options] installer 02:46:46 INFO - Options: 02:46:46 INFO - -h, --help show this help message and exit 02:46:46 INFO - -d DEST, --destination=DEST 02:46:46 INFO - Directory to install application into. [default: 02:46:46 INFO - "/builds/slave/test"] 02:46:46 INFO - --app=APP Application being installed. [default: firefox] 02:46:46 INFO - mkdir: /builds/slave/test/build/application 02:46:46 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'] 02:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:47:04 INFO - Reading from file tmpfile_stdout 02:47:04 INFO - Output received: 02:47:04 INFO - /builds/slave/test/build/application/firefox/firefox 02:47:04 INFO - Running post-action listener: _resource_record_post_action 02:47:04 INFO - [mozharness: 2017-06-27 09:47:04.607957Z] Finished install step (success) 02:47:04 INFO - [mozharness: 2017-06-27 09:47:04.608236Z] Running setup-mitmproxy step. 02:47:04 INFO - Running pre-action listener: _resource_record_pre_action 02:47:04 INFO - Running main action method: setup_mitmproxy 02:47:04 INFO - Skipping: mitmproxy is not required 02:47:04 INFO - Running post-action listener: _resource_record_post_action 02:47:04 INFO - [mozharness: 2017-06-27 09:47:04.609552Z] Finished setup-mitmproxy step (success) 02:47:04 INFO - [mozharness: 2017-06-27 09:47:04.609776Z] Running run-tests step. 02:47:04 INFO - Running pre-action listener: _resource_record_pre_action 02:47:04 INFO - Running main action method: run_tests 02:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:47:04 INFO - Python 2.7.3 02:47:04 INFO - Return code: 0 02:47:04 INFO - grabbing minidump binary from tooltool 02:47:04 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')]} 02:47:04 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 0x144e140>, '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 0x144ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144eed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:47:04 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 02:47:04 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 02:47:04 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 02:47:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:47:04 INFO - Return code: 0 02:47:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:47:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:47:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:47:04 INFO - ENV: RUST_BACKTRACE is now 1 02:47:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:47:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:47:04 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/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 02:47:04 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/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 02:47:04 INFO - Using env: {'DISPLAY': ':0', 02:47:04 INFO - 'HOME': '/home/cltbld', 02:47:04 INFO - 'LANG': 'en_US.UTF-8', 02:47:04 INFO - 'LANGUAGE': 'en_US:en', 02:47:04 INFO - 'LOGNAME': 'cltbld', 02:47:04 INFO - 'MAIL': '/var/mail/cltbld', 02:47:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:47:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:04 INFO - 'MOZ_NO_REMOTE': '1', 02:47:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:04 INFO - 'NO_EM_RESTART': '1', 02:47:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:04 INFO - 'PWD': '/builds/slave/test', 02:47:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:47:04 INFO - 'RUST_BACKTRACE': '1', 02:47:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:47:04 INFO - 'SHELL': '/bin/bash', 02:47:04 INFO - 'SHLVL': '1', 02:47:04 INFO - 'TERM': 'linux', 02:47:04 INFO - 'TMOUT': '86400', 02:47:04 INFO - 'USER': 'cltbld', 02:47:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526', 02:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:04 INFO - '_': '/tools/buildbot/bin/python'} 02:47:04 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/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 02:47:04 INFO - mozversion application_buildid: 20170627085701 02:47:04 INFO - mozversion application_changeset: 53477d584130945864c4491632f88da437353356 02:47:04 INFO - mozversion application_display_name: Nightly 02:47:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:47:04 INFO - mozversion application_name: Firefox 02:47:04 INFO - mozversion application_remotingname: firefox 02:47:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:47:04 INFO - mozversion application_vendor: Mozilla 02:47:04 INFO - mozversion application_version: 56.0a1 02:47:04 INFO - mozversion platform_buildid: 20170627085701 02:47:04 INFO - mozversion platform_changeset: 53477d584130945864c4491632f88da437353356 02:47:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:47:04 INFO - mozversion platform_version: 56.0a1 02:47:04 INFO - using testdate: 1498556824 02:47:04 INFO - actual date: 1498556824 02:47:04 INFO - starting webserver on 'localhost:53673' 02:47:04 INFO - SUITE-START | Running 2 tests 02:47:04 INFO - TEST-START | dromaeo_css 02:47:04 INFO - operating with platform_type : linux_ 02:47:04 INFO - Initialising browser for dromaeo_css test... 02:47:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53673/getInfo.html -profile /tmp/tmpowcDGa/profile 02:47:05 INFO - TEST-INFO | started process 23840 (/builds/slave/test/build/application/firefox/firefox http://localhost:53673/getInfo.html) 02:47:10 INFO - TEST-INFO | 23840: exit 0 02:47:10 INFO - Browser initialized. 02:47:10 INFO - Running cycle 1/1 for dromaeo_css test... 02:47:10 INFO - TEST-INFO | started process 24051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpowcDGa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:22 INFO - PID 24051 | RSS: Main: 168820736 02:47:22 INFO - PID 24051 | 02:50:26 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:53673/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53673/tests/dromaeo/cssquery-ext.html) 02:50:28 INFO - PID 24051 | RSS: Main: 174936064 02:50:28 INFO - PID 24051 | 02:53:30 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:53673/tests/dromaeo/cssquery-ext.html (next: http://localhost:53673/tests/dromaeo/cssquery-jquery.html) 02:53:30 INFO - PID 24051 | RSS: Main: 173318144 02:53:30 INFO - PID 24051 | 02:56:32 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:53673/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53673/tests/dromaeo/cssquery-mootools.html) 02:56:32 INFO - PID 24051 | RSS: Main: 175722496 02:56:32 INFO - PID 24051 | 02:59:34 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:53673/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53673/tests/dromaeo/cssquery-prototype.html) 02:59:35 INFO - PID 24051 | RSS: Main: 175394816 02:59:35 INFO - PID 24051 | 03:02:37 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:53673/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53673/tests/dromaeo/cssquery-yui.html) 03:02:38 INFO - PID 24051 | RSS: Main: 173961216 03:02:38 INFO - PID 24051 | 03:05:40 INFO - PID 24051 | Cycle 1(1): loaded http://localhost:53673/tests/dromaeo/cssquery-yui.html (next: http://localhost:53673/tests/dromaeo/cssquery-dojo.html) 03:05:40 INFO - PID 24051 | RSS: Main: 178077696 03:05:40 INFO - PID 24051 | 03:05:40 INFO - PID 24051 | __start_tp_report 03:05:40 INFO - PID 24051 | _x_x_mozilla_page_load 03:05:40 INFO - PID 24051 | _x_x_mozilla_page_load_details 03:05:40 INFO - PID 24051 | |i|pagename|runs| 03:05:40 INFO - PID 24051 | |0;dojo.html;3043.726064654181;3079.8922037728685;3104.9379012419754;3124.843757812109;3134.2634480896986;6045.274567051954;6118.204633397658;6140.320203811473;6168.136460895467;6199.845003874905;6161.353057928909;6170.105334726462;6175.320714721388;6183.288921773986;6204;5684.147377893318;5695.743691533891;5732.398098199692;5735.11105778605;5790.36306006339;5547.8890422191735;5667.234923285345;5672.064109421961;5698.230738850264;5719.313682358102;5621.409751976024;5633.802816901389;5647.181158731961;5726.3700992890745;5739.913901291484;5704.22992895962;5705;5707.828765137053;5731.971340143315;5737.799177028784;5633.126865335838;5639.464250896158;5640.125780504029;5648.350439699446;5652.434756524314;6006.339302676702;6094.421030002142;6133.264008318985;6144.170536977495;6148.938510614926;6511.28375878653;6523.315051919528;6583.407493325576;6589.472842172615;6594.9010764838085;6666.0667506549125;6714.3957043866285;6717.664116794141;6718.529702920847;6721.294264102247;6130.325664176937;6217.751289948442;6249.437550620466;6253.249610046823;6257.468115210167;6631.966840165768;6719.260881303053;6769.763058292936;6799.966000170067;6828.351306625863;6538.051982462612;6539.640319782363;6549;6550.70521826519;6558.606483610999;6572.211334639778;6637.269900310962;6657.1345725055435;6670.232923213795;6681.5656982296;6622.304658010936;6630.9336906630315;6636.037774522667;6646.534742567974;6647.60114393138;6477.708503117371;6572.11276477679;6648.96675516629;6678.766243181465;6681.532292739462;5266;5308.92036619451;5325.440828713007;5332.866678333073;5336.599755018389;4529.909401811945;4605.723656580549;4630.791614377361;4630.86107416778;4634.629229661619;5777.537796976316;5784.305883293948;5788.160716696056;5801.82594522165;5832.445917637818;6593.835154121185;6627.469802415795;6661.3338666132995;6672.2994085621285;6695.163104611924;5698;5736.897118112654;5748.48263656273;5756.942430575725;5797.710114494258;5798.362180160179;5848.9707551462825;5850.385709500441;5886.175935369051;5897.616654917417;6450.580712253689;6451.903221451588;6525;6529.118568993125;6553.574017688835;6709.194896612243;6739.0902228198565;6741.865162696817;6748.527603067934;6750.831229219309;6500.674966251763;6508.544401891822;6514.218293804774;6522.21733391996;6543.214814222324;6383.489320854414;6498.220213574401;6508.8047358579315;6543.1821022372205;6595.637239951849;6504.902426463512;6536.8365790855605;6609.636469994197;6632.900506492503;6640.402363787282;6367.808965731036;6418.646974416265;6434.163558737334;6447.548671592944;6453.903191452226;6428.19647544057;6429.742810287723;6476.417122459001;6496.805095847132;6527.2167339919515;6113.847153821012;6244.344343843831;6283.71723272463;6287.528435367457;6436.6459844707115;6425.742970281136;6465.612063276219;6486.351364863476;6530.249021362414;6543.509236807354;6262;6263.686815659108;6336;6344.429001389897;6374.904376434264 03:05:40 INFO - PID 24051 | |1;ext.html;762.2567996203702;833.7165363776317;853.9530325832077;860.4794099569756;1073.3506228731621;32215.516767248482;43043;44028.33957490632;44068.3389749154;44317.113657726826;43782.56217437825;44115.338269925975;44367.112657746824;44402.77798611002;44492.77753611236;7710.190430004839;7775.261350171753;7824.72613458529;7856.175101614305;7865;7300.488965772398;7680.731174408897;7706.113796913342;7753.844923101535;7785.688572457095;7413.851722965537;7463.514871533333;7464.10430748311;7480.962595187044;7481.8877716834295;7387.889181662279;7440.441966852481;7459.440541959375;7461.664225109856;7483.962580187119;7634.389248860133;7677.2322767723335;7682.539047657103;7693.153753087212;7701.768946931601;39815.8009209955;39981.40027899584;39997;40186.39720404167;40188;3478.5303983962094;3480.9825950870086;3488.0582242794558;3500.43992961125;3500.8949731508096;30915.22711932197;30942.071737847902;31051.844740776378;31075.378492430253;31138;3655.4151335786414;3656.835442405098;3702.38910579754;3719.590845007047;3729.179580492287;186503;190353;191068.9999999986;191325;192827;49450.25824612634;50558.24162637563;50873.491265087614;50917.49082509201;51059.744701277;53638.195427068626;54079.45920540823;54167;54220;54314.45685543094;15912.76130858038;15970.121643309729;16075.919620402057;16082.678346433006;16085.115318657352;13125.868741312655;13167.53913613019;13188;13192.142510736963;13216.73566528664;14989.40042398292;15030.924845375921;15119.622009449631;15143.697126057417;15330;5716.5426765859465;5720.971395142998;5755.000274809051;5779.190913272145;5919.289685237799;962.9374090684083;967.0706939655432;1001.7746007148334;1012.473513772834;1018.5060245780791;22429.43926401853;22505.212317569134;22560.887195564246;22587.209447669582;22808;1039.1323245090282;1074.6292529077455;1108.3183841937312;1109.611635927419;1116.1015382617072;11793.410329483491;11864.466099025565;11868;11894.82157767634;12014.279143251433;220388;221530;222802;223033;223443;53117.468825312026;53143.46856531462;53200.73399632977;53213.467865320854;53363.733181333846;1437.2570712460479;1442.8052212951118;1471.1026273972868;1473.8452462491284;1490.7242160200399;21561.784382156606;22144.88927555352;22210.66683999709;22253.666195006765;26859.328516786456;51952.48047519477;52106.739466302424;52275.47724522706;52382.47617523776;52477.7376113117;194547.02726486276;195184;195235;195241;195383;34566.30867382688;34880.47679284762;35873;37174;37274.44088338732;46149.76925115353;46593.76703116463;46608.766956165004;46874.296885547425;49367.753161233966;32622.51066233961;33661.83169084139;34412.48381274233;34435.13912152216;34722.305553888276;33239;33769.83115084409;33798.66201337955;33818.154546136546;33854.153646159044;36226.275474489834;36542.086447839014;37067.25865482729;37311.6268837319;37328.25343493169;31110.68889311078;32342;33336.83331583327;33456.832715836266;33654.495182571794;23354.53290934206;23431.41421464477;23857.880710596335;23898.924548395713;24001.639975400034 03:05:40 INFO - PID 24051 | |2;jquery.html;559.1277606933185;565.2510423688608;568.840724597113;581.5144354464021;592.8547505861063;21983.450413739643;22535.54928901423;22664.54670906581;22676;22727;23965;25049;26231.737682623218;26268.47463050738;26334.868325658394;6570.178727659043;6702.932970670304;6703.128593282866;6704.229013663442;6715.160604924385;6579.111819904323;6626.436752875988;6628.270890202074;6637.933620663804;6645.102911107011;6170.96914515429;6404.871902561946;6421.229452465711;6458.61248325102;6633.237177724575;6430.389113034277;6573.638449885254;6578.506612004071;6578.703958321839;6579.309172536887;6091.055886337581;6093.634381937054;6094.329623741385;6118.908216376758;6119.265688117454;27342.863285683445;28221;28724;28766;28787;1876.6059127583223;1941.3787587971854;1944.8638595298335;1946.4355336952267;1961.4017724593994;17793.822061779345;18252.543686407815;18282.817171828243;18299;18336.724949125775;2284.4859906521065;2287.9084836606517;2308.68832707584;2336.6144586143264;2338.263447014185;117796.41101794437;120390;120941.39529302384;120944;121048;13382.665433364244;14288.928555357365;14814.92592537052;14858.851411485963;15010;23046.193383231508;23137.190198343313;23139.53720925572;23275;23336.416589585056;9465.148136667733;9466.29002824791;9503.382280151767;9548.1884039856;9718.368306060225;8557.529335886586;8593.355498337649;8630.39587228888;8689.000764911989;8711.34664900135;8604.655813767504;8627.78430539229;8654.48073115615;8855.73432797017;9182.95408522953;2545.5163518931713;2685.2615530729204;2712.986435067812;2747.615333853262;2842.616246806696;946.1579194516886;963.4893506441597;975.7463059604554;990.6928852055742;991.4893829677721;19347.709784353247;19633.509162271057;19801.20795168206;19972;20107;979.4710856137748;1013.6705570689555;1022.4529876516028;1044.2690116918188;1052.3422860712055;10394.696603498087;10430.217733670004;10693.465326733633;10696.89303106959;10849.511771970281;488821;494855;524518;530533;540499;104722;106599.26902558374;106809.99999999844;107636.4618176904;108441.45779271211;1172.5602898912907;1199.5741511763372;1226.4174517104482;1243.8383010208615;1257.6855786053486;16181.271842767339;19658.705119422935;20511.8974405127;20666.586668266853;20938;47251;49757.75121124516;51030.48969510257;51333.48666513287;54407.45592544182;62629.373706262355;62696.686516567126;63111.0533341991;63233;63750.362496374444;12252.203606765532;12414.317212553035;12481;12506.312152831682;12577.119601627799;18609.53476163107;18712.345067923103;18739.90630046841;18849.6230075395;19018.42944711661;15400.229988500307;15498;15579.844201558293;15691.686166276382;15947.282372293506;12743.10798244114;13318.467261309439;13450.46198152063;13541.59375218745;13941.163530188222;13855.86144138586;15185.6203594911;15420.84579154239;15518.534443966699;15527;12793;12950.158239714388;13052.804207937079;13064.673383165496;13147.60557183286;15550.611234719223;15559.766603501183;15595.922020389826;15638.45265415705;15663.765043524585 03:05:40 INFO - PID 24051 | |3;mootools.html;1328.8604696506866;1404.1224234853216;1415.05898577446;1415.3135729171354;1416.1432333438263;13170.539031133912;13960.930195349008;13991.510297139603;14035.438582456702;14110.223937683424;13415.664608384795;13843.169409835416;13928.930355348235;13935.303234838242;13938.303084845767;2616.2543675052566;2633.7102918679025;2641.181233817513;2655.4556315955183;2661.3213630524187;2484.167803785734;2554.272032470746;2565.9615105773337;2566.345581876619;2570.5501537231003;2566.5765148750434;2568.4606232691062;2593.4164812917134;2597.909073182439;2612.6603541539575;2490.3151633300895;2491.838030528019;2499.200255918107;2500.574902266601;2502.862342571158;2443.4624382635793;2462.2982450001664;2467.2968204061935;2474.183519438581;2475.10896077412;13561.525346612822;13589.728205435837;13617.523386681418;13646;13695.178289302574;7014.579125252501;7383.704651813921;7415.40676745859;7420.295071968154;7428.739994100235;4098.426220329156;4290.742555446684;4299.398084268205;4325.329573916048;4353.73877567347;1547.7755725419863;1563.1480842940625;1564.0771944552769;1599.7680336351164;1615.8868879178463;20176.899115504475;20936.895315523325;22169.22407715722;22344.55310893773;22480.55038899229;5535.833924982257;6194.4115309045565;6329.3354197809485;6332.240131184288;6365.904511432333;15159.848401515843;15266.313015914311;15277;15297.158656274012;15337.769933451007;7094.751683691046;7274.96362518184;7278.344948954619;7332.670029848669;7347.88978165328;6849.178098628096;6857.108575885203;6921.411680007155;6959.8956015659805;6974;4718.646101542398;4811.855644330606;4821.54195351441;4849.4908034656555;4869.659123861366;1344.3345543955804;1362.7206422683325;1374.216696482995;1391.624261449403;1395.3372148229712;897.7261935109855;899.4243684042218;916.276141847946;923.0538697834774;934.3693007220099;7308.488405811542;7408.666610002563;7466.440016998747;7527.134379546313;8551.102134275812;944.6788092048737;963.4749061761216;971.844504879216;990.3909095905966;997.1574019953129;4886.853394398174;4900.509949005071;4975.08459243194;5014.774335154927;5224.50367215114;18144.727829082574;18254.543636409195;18671.439856804318;18809.81190188108;18838.90580547116;17840.107994600217;18083.457496275132;18090.366837160636;18209.180586873623;18616.534586635444;10077.748056298651;10255.794884102426;10292.228082893664;10318.071373576264;10362.689119326433;7089.680964356513;7855.135935047026;7860.528368297921;7970.163132871197;8062.153473885158;15886.2056897157;15896.728261739265;15945.123018234108;16227.756583651018;16477.752833707265;15935.203239838194;16352.345906164097;16585.170741462636;16818.66362672764;16822.411215607393;9989.200863931013;9992.65025724096;10150.593976240867;10185.08334249921;10211.029952154533;12625.87374126247;12657.746845062862;12695.619131426072;12719.80920286178;12729.80905286403;10346.521889305608;10432.321899076536;10467.94766026165;10529.57881684724;10781.676549703521;9903.900960990299;10106.343087699275;10143.847842282225;10179.84730229062;10232.53953572106;9287.349885507949;9456.148946594565;9460.668876589287;9461.526923653651;9507.904920950701;6452.612843229421;6813.3527314905;6872.484563657646;6879.58722476633;6917.169939607078;6949.235584085645;6993.720251189896;7045.612491313027;7056.682449289691;7080.964595177197 03:05:40 INFO - PID 24051 | |4;prototype.html;478.07492502008597;500.1197891710588;518.1424742051905;520.4171328112513;527.0618299427022;6263.311035786066;6286.559940804145;6341.429271365576;6349.809505714836;6374;6034.125051867477;6221.7822376216845;6225.377462253772;6237.251529816428;6272.2159730033745;4995.475475075119;5004.149294619905;5019.899602007958;5029.798808047673;5052.545270925616;4985.601151907838;5035.672681275705;5036.546710796028;5049.9747501262445;5060.51925067118;4983.9252411213865;5014.373203349582;5018.548330650241;5044.873878153039;5051.217061355495;5020.849374518771;5227.738613069331;5232.92150617741;5235.293235413209;5245.213218017289;4873.926891096637;4878.585320247783;4881.511848815126;4882.31647569337;4895.069936712013;6111.663858487781;6153.353897840707;6168.87662246757;6175.938240617626;6203.782867599657;6029.005214139662;6065.605735627214;6087.421694938974;6100.23747031621;6101.749141425997;6653.301403352675;6695.363940425652;6707.865842683168;6712.664366781642;6725.730970761164;5328.813491527817;5358.946410535884;5361.892762144736;5387.811426600089;5390.5418039466695;6952.687129079203;6997.580145191254;7055.800513912647;7069.434445244368;7076.186238582577;5519.503244707996;5562.913907284768;5574.912891986024;5576.749046292926;5580.386157522669;5608.6073974821375;5637.915431268452;5658.971705141448;5669;5678.829635110953;6064.36324185963;6094.878102437927;6100.359462256488;6109.602875813058;6118.847028824315;6344.429001389804;6697.933020669829;6718;6747.325267473213;6761.93238067613;1954.5602239496;1956.6184594004033;1965.823075923145;1978.5655399835005;1994.8703334283516;1402.7615305398108;1425.3229715884872;1430.4135304525096;1449.0943160524673;1463.4438913213123;5617.41017193197;5782.88434231313;5788.27646544182;5840.328362238312;5890.2342695449315;6654.434373078343;6714;6738.797836064926;6752.358525940028;6761.729530818712;5829.7376618052285;5868.647881127146;5881.294244690579;5885.028970219866;5909.793157239562;3547.6807087362263;3556.644335566423;3577.5349204603235;3585.2829434113282;3613.512175856226;6498;6531.183602049744;6539.280679125292;6544.247411547638;6590.8352291193105;6894.620795856276;6915.585064896021;6936.653167341613;6953.33943275388;7004.299570042955;6533.41199292066;6535.934640653532;6561.1470508833545;6575.243846957661;6601.933980660132;6755.324467553205;6761.701021652661;6768.593884366954;6775.170703910016;6799.93200067993;6696.732130714717;6704.195496540251;6713.395794378529;6730.394264516217;6732.562383445061;6205.410486003822;6452.516061295515;6525.804225873231;6525.902111468236;6541.443977261986;4896.436909755424;4955.65310428281;5000.274960130833;5006.098902197639;5011.0206468445485;6747.325267473213;6767.0526126341365;6767.593944363354;6776.593404395752;6781.220159681699;6568.638724870178;6595.373439523238;6596.835079122869;6603.174603174603;6615.536912416084;6501.9674901625185;6507.381798729113;6578.822447745621;6584.868302634016;6588.143541339595;6408.58344207625;6465.127207826883;6485.870282594227;6485.902711459237;6502;6607.108040414675;6619.900701489578;6622.1722284714415;6624.138861947916;6639.734410623521;6394.808155755335;6403.3276505966205;6426.550141490238;6429.903551446639;6437.645929473737 03:05:40 INFO - PID 24051 | |5;yui.html;816.808050108224;854.3336197765741;861.3238607692961;871.0549054276111;872.7512658892217;17092.91453542732;17529.21118549665;17617.471475855713;17653;17677.204525796336;15600;15698.215089245521;15777.368905243777;16582.75125873113;18573.257069717194;1041.1254546181187;1064.4305296666246;1065.6856227412893;1067.4182570499058;1068.9684454501405;1054.5360041581719;1055.166418529361;1055.9260851740382;1056.0495554001423;1057.133150816331;1103.2112039891476;1113.3208742666966;1113.8273567596996;1116.3971455414066;1119.4906317625503;1038.1642777564057;1110.572429614596;1112.0880877680306;1112.8831472695372;1118.7706520163347;772.2509166108865;778.3500776851336;786.7875673568162;787.7085478372982;789.1634867040955;18021.7296740549;18172.182251798567;18205.54486137844;18214.08929553517;18255.452336429928;17980.37068702589;19256.422307330802;19390;19430.319938802073;19451.513712157168;15004.474843380429;15629.765553516592;16198.75701864473;16391.91804040984;16395.098269595168;3648.6533779290926;3655.4334078217917;3655.798931058791;3662.08447888028;3669.504616876714;98647;99842;100954.49522752412;102834.48582757039;104367;14799.482018129314;15003;15121;15262.618434539003;15288;27561.586576201375;27760.977259614574;28696.85651571729;28875;29064.564031539543;7594.278543538355;7687.500312479671;7742.574158421341;7766.951461552618;7789.298963093349;3672.9632703672623;3772.7359084864347;3778.112143646241;3807.600201978808;3834.9616503835164;4506.59440650343;4558.566936141061;4577.8168873244695;4589.380433641482;4604.88487787808;845.2984023260678;876.3646356391693;895.5701263393607;965.4207475514776;972.2465089555651;653.4641593892962;686.9965650171717;712.807541963667;718.6227230703922;732.5677850068486;11415;11606.651800446;12054.578089766992;12244.755104897853;12519.061070419755;628.1510868666871;635.7298148286959;652.0642877470844;666.2904007232379;670.7149461478949;5312.495312945264;5554.250176226238;5579.888402231933;5586.24585680936;5590.357108932443;88452.5577372109;91378.54310728404;91432.5428372854;95613.52193239129;95945.5202723982;64193.679031604544;79339;79838;82947.5852620733;83410.58294708487;65431;69181;70763.64618176979;71955.64022179856;74713;11610.361430121424;12222.388880555758;12271.447784849524;12426.75146497047;12507;32592.837035814668;32627.673723262462;33013;33792.831035845644;35083;41457.79271103625;43546.12907741764;44538.55461445344;44628.55371446244;45136.77431612821;17597.912010439864;17878;18339.266429342675;18378;18422.263109475472;19107.61784764269;19528.8047119527;19710.50723731861;19727.704084439032;20006.89996550008;16499.58751031234;17771.466855994342;17843.910780446535;17900.55248618795;18031.549211269823;17912.910435448262;17971.101444927965;18064.909675451538;18077.644176687063;18231.635367292845;16633.25150368212;16883.40908068261;17698.203580838635;17746.5563360917;18092.457226283233;11428.599998999995;11670.183087183816;11685.76628467409;11808.11439142085;11961.820572691242;12688.873111269138;12693.619191424272;12811.334526511493;12946.482140714643;12963.675908102374 03:05:40 INFO - PID 24051 | __end_tp_report 03:05:40 INFO - PID 24051 | __start_cc_report 03:05:40 INFO - PID 24051 | _x_x_mozilla_cycle_collect,347 03:05:40 INFO - PID 24051 | __end_cc_report 03:05:40 INFO - PID 24051 | __startTimestamp1498557940434__endTimestamp 03:05:40 INFO - PID 24051 | 03:05:40 INFO - PID 24051 | ------- Summary: start ------- 03:05:40 INFO - PID 24051 | Number of tests: 6 03:05:40 INFO - PID 24051 | 03:05:40 INFO - PID 24051 | [#0] dojo.html Cycles:165 Average:6103.42 Median:6344.43 stddev:721.21 (11.4%) stddev-sans-first:682.31 03:05:40 INFO - PID 24051 | Values: 3043.7 3079.9 3104.9 3124.8 3134.3 6045.3 6118.2 6140.3 6168.1 6199.8 6161.4 6170.1 6175.3 6183.3 6204.0 5684.1 5695.7 5732.4 5735.1 5790.4 5547.9 5667.2 5672.1 5698.2 5719.3 5621.4 5633.8 5647.2 5726.4 5739.9 5704.2 5705.0 5707.8 5732.0 5737.8 5633.1 5639.5 5640.1 5648.4 5652.4 6006.3 6094.4 6133.3 6144.2 6148.9 6511.3 6523.3 6583.4 6589.5 6594.9 6666.1 6714.4 6717.7 6718.5 6721.3 6130.3 6217.8 6249.4 6253.2 6257.5 6632.0 6719.3 6769.8 6800.0 6828.4 6538.1 6539.6 6549.0 6550.7 6558.6 6572.2 6637.3 6657.1 6670.2 6681.6 6622.3 6630.9 6636.0 6646.5 6647.6 6477.7 6572.1 6649.0 6678.8 6681.5 5266.0 5308.9 5325.4 5332.9 5336.6 4529.9 4605.7 4630.8 4630.9 4634.6 5777.5 5784.3 5788.2 5801.8 5832.4 6593.8 6627.5 6661.3 6672.3 6695.2 5698.0 5736.9 5748.5 5756.9 5797.7 5798.4 5849.0 5850.4 5886.2 5897.6 6450.6 6451.9 6525.0 6529.1 6553.6 6709.2 6739.1 6741.9 6748.5 6750.8 6500.7 6508.5 6514.2 6522.2 6543.2 6383.5 6498.2 6508.8 6543.2 6595.6 6504.9 6536.8 6609.6 6632.9 6640.4 6367.8 6418.6 6434.2 6447.5 6453.9 6428.2 6429.7 6476.4 6496.8 6527.2 6113.8 6244.3 6283.7 6287.5 6436.6 6425.7 6465.6 6486.4 6530.2 6543.5 6262.0 6263.7 6336.0 6344.4 6374.9 03:05:40 INFO - PID 24051 | 03:05:40 INFO - PID 24051 | [#1] ext.html Cycles:180 Average:38223.34 Median:3500.67 stddev:52703.92 (1505.5%) stddev-sans-first:52776.70 03:05:40 INFO - PID 24051 | Values: 762.3 833.7 854.0 860.5 1073.4 32215.5 43043.0 44028.3 44068.3 44317.1 43782.6 44115.3 44367.1 44402.8 44492.8 7710.2 7775.3 7824.7 7856.2 7865.0 7300.5 7680.7 7706.1 7753.8 7785.7 7413.9 7463.5 7464.1 7481.0 7481.9 7387.9 7440.4 7459.4 7461.7 7484.0 7634.4 7677.2 7682.5 7693.2 7701.8 39815.8 39981.4 39997.0 40186.4 40188.0 3478.5 3481.0 3488.1 3500.4 3500.9 30915.2 30942.1 31051.8 31075.4 31138.0 3655.4 3656.8 3702.4 3719.6 3729.2 186503.0 190353.0 191069.0 191325.0 192827.0 49450.3 50558.2 50873.5 50917.5 51059.7 53638.2 54079.5 54167.0 54220.0 54314.5 15912.8 15970.1 16075.9 16082.7 16085.1 13125.9 13167.5 13188.0 13192.1 13216.7 14989.4 15030.9 15119.6 15143.7 15330.0 5716.5 5721.0 5755.0 5779.2 5919.3 962.9 967.1 1001.8 1012.5 1018.5 22429.4 22505.2 22560.9 22587.2 22808.0 1039.1 1074.6 1108.3 1109.6 1116.1 11793.4 11864.5 11868.0 11894.8 12014.3 220388.0 221530.0 222802.0 223033.0 223443.0 53117.5 53143.5 53200.7 53213.5 53363.7 1437.3 1442.8 1471.1 1473.8 1490.7 21561.8 22144.9 22210.7 22253.7 26859.3 51952.5 52106.7 52275.5 52382.5 52477.7 194547.0 195184.0 195235.0 195241.0 195383.0 34566.3 34880.5 35873.0 37174.0 37274.4 46149.8 46593.8 46608.8 46874.3 49367.8 32622.5 33661.8 34412.5 34435.1 34722.3 33239.0 33769.8 33798.7 33818.2 33854.2 36226.3 36542.1 37067.3 37311.6 37328.3 31110.7 32342.0 33336.8 33456.8 33654.5 23354.5 23431.4 23857.9 23898.9 24001.6 03:05:40 INFO - PID 24051 | 03:05:40 INFO - PID 24051 | [#2] jquery.html Cycles:180 Average:33696.35 Median:12667.05 stddev:85881.72 (678.0%) stddev-sans-first:86086.60 03:05:40 INFO - PID 24051 | Values: 559.1 565.3 568.8 581.5 592.9 21983.5 22535.5 22664.5 22676.0 22727.0 23965.0 25049.0 26231.7 26268.5 26334.9 6570.2 6702.9 6703.1 6704.2 6715.2 6579.1 6626.4 6628.3 6637.9 6645.1 6171.0 6404.9 6421.2 6458.6 6633.2 6430.4 6573.6 6578.5 6578.7 6579.3 6091.1 6093.6 6094.3 6118.9 6119.3 27342.9 28221.0 28724.0 28766.0 28787.0 1876.6 1941.4 1944.9 1946.4 1961.4 17793.8 18252.5 18282.8 18299.0 18336.7 2284.5 2287.9 2308.7 2336.6 2338.3 117796.4 120390.0 120941.4 120944.0 121048.0 13382.7 14288.9 14814.9 14858.9 15010.0 23046.2 23137.2 23139.5 23275.0 23336.4 9465.1 9466.3 9503.4 9548.2 9718.4 8557.5 8593.4 8630.4 8689.0 8711.3 8604.7 8627.8 8654.5 8855.7 9183.0 2545.5 2685.3 2713.0 2747.6 2842.6 946.2 963.5 975.7 990.7 991.5 19347.7 19633.5 19801.2 19972.0 20107.0 979.5 1013.7 1022.5 1044.3 1052.3 10394.7 10430.2 10693.5 10696.9 10849.5 488821.0 494855.0 524518.0 530533.0 540499.0 104722.0 106599.3 106810.0 107636.5 108441.5 1172.6 1199.6 1226.4 1243.8 1257.7 16181.3 19658.7 20511.9 20666.6 20938.0 47251.0 49757.8 51030.5 51333.5 54407.5 62629.4 62696.7 63111.1 63233.0 63750.4 12252.2 12414.3 12481.0 12506.3 12577.1 18609.5 18712.3 18739.9 18849.6 19018.4 15400.2 15498.0 15579.8 15691.7 15947.3 12743.1 13318.5 13450.5 13541.6 13941.2 13855.9 15185.6 15420.8 15518.5 15527.0 12793.0 12950.2 13052.8 13064.7 13147.6 15550.6 15559.8 15595.9 15638.5 15663.8 03:05:40 INFO - PID 24051 | 03:05:40 INFO - PID 24051 | [#3] mootools.html Cycles:180 Average:8348.55 Median:2499.89 stddev:5668.53 (226.8%) stddev-sans-first:5659.89 03:05:40 INFO - PID 24051 | Values: 1328.9 1404.1 1415.1 1415.3 1416.1 13170.5 13960.9 13991.5 14035.4 14110.2 13415.7 13843.2 13928.9 13935.3 13938.3 2616.3 2633.7 2641.2 2655.5 2661.3 2484.2 2554.3 2566.0 2566.3 2570.6 2566.6 2568.5 2593.4 2597.9 2612.7 2490.3 2491.8 2499.2 2500.6 2502.9 2443.5 2462.3 2467.3 2474.2 2475.1 13561.5 13589.7 13617.5 13646.0 13695.2 7014.6 7383.7 7415.4 7420.3 7428.7 4098.4 4290.7 4299.4 4325.3 4353.7 1547.8 1563.1 1564.1 1599.8 1615.9 20176.9 20936.9 22169.2 22344.6 22480.6 5535.8 6194.4 6329.3 6332.2 6365.9 15159.8 15266.3 15277.0 15297.2 15337.8 7094.8 7275.0 7278.3 7332.7 7347.9 6849.2 6857.1 6921.4 6959.9 6974.0 4718.6 4811.9 4821.5 4849.5 4869.7 1344.3 1362.7 1374.2 1391.6 1395.3 897.7 899.4 916.3 923.1 934.4 7308.5 7408.7 7466.4 7527.1 8551.1 944.7 963.5 971.8 990.4 997.2 4886.9 4900.5 4975.1 5014.8 5224.5 18144.7 18254.5 18671.4 18809.8 18838.9 17840.1 18083.5 18090.4 18209.2 18616.5 10077.7 10255.8 10292.2 10318.1 10362.7 7089.7 7855.1 7860.5 7970.2 8062.2 15886.2 15896.7 15945.1 16227.8 16477.8 15935.2 16352.3 16585.2 16818.7 16822.4 9989.2 9992.7 10150.6 10185.1 10211.0 12625.9 12657.7 12695.6 12719.8 12729.8 10346.5 10432.3 10467.9 10529.6 10781.7 9903.9 10106.3 10143.8 10179.8 10232.5 9287.3 9456.1 9460.7 9461.5 9507.9 6452.6 6813.4 6872.5 6879.6 6917.2 6949.2 6993.7 7045.6 7056.7 7081.0 03:05:40 INFO - PID 24051 | 03:05:40 INFO - PID 24051 | [#4] prototype.html Cycles:180 Average:5645.16 Median:6204.60 stddev:1520.57 (24.5%) stddev-sans-first:1474.54 03:05:40 INFO - PID 24051 | Values: 478.1 500.1 518.1 520.4 527.1 6263.3 6286.6 6341.4 6349.8 6374.0 6034.1 6221.8 6225.4 6237.3 6272.2 4995.5 5004.1 5019.9 5029.8 5052.5 4985.6 5035.7 5036.5 5050.0 5060.5 4983.9 5014.4 5018.5 5044.9 5051.2 5020.8 5227.7 5232.9 5235.3 5245.2 4873.9 4878.6 4881.5 4882.3 4895.1 6111.7 6153.4 6168.9 6175.9 6203.8 6029.0 6065.6 6087.4 6100.2 6101.7 6653.3 6695.4 6707.9 6712.7 6725.7 5328.8 5358.9 5361.9 5387.8 5390.5 6952.7 6997.6 7055.8 7069.4 7076.2 5519.5 5562.9 5574.9 5576.7 5580.4 5608.6 5637.9 5659.0 5669.0 5678.8 6064.4 6094.9 6100.4 6109.6 6118.8 6344.4 6697.9 6718.0 6747.3 6761.9 1954.6 1956.6 1965.8 1978.6 1994.9 1402.8 1425.3 1430.4 1449.1 1463.4 5617.4 5782.9 5788.3 5840.3 5890.2 6654.4 6714.0 6738.8 6752.4 6761.7 5829.7 5868.6 5881.3 5885.0 5909.8 3547.7 3556.6 3577.5 3585.3 3613.5 6498.0 6531.2 6539.3 6544.2 6590.8 6894.6 6915.6 6936.7 6953.3 7004.3 6533.4 6535.9 6561.1 6575.2 6601.9 6755.3 6761.7 6768.6 6775.2 6799.9 6696.7 6704.2 6713.4 6730.4 6732.6 6205.4 6452.5 6525.8 6525.9 6541.4 4896.4 4955.7 5000.3 5006.1 5011.0 6747.3 6767.1 6767.6 6776.6 6781.2 6568.6 6595.4 6596.8 6603.2 6615.5 6502.0 6507.4 6578.8 6584.9 6588.1 6408.6 6465.1 6485.9 6485.9 6502.0 6607.1 6619.9 6622.2 6624.1 6639.7 6394.8 6403.3 6426.6 6429.9 6437.6 03:05:40 INFO - PID 24051 | 03:05:40 INFO - PID 24051 | [#5] yui.html Cycles:180 Average:20087.94 Median:19323.21 stddev:25573.15 (132.3%) stddev-sans-first:25603.95 03:05:40 INFO - PID 24051 | Values: 816.8 854.3 861.3 871.1 872.8 17092.9 17529.2 17617.5 17653.0 17677.2 15600.0 15698.2 15777.4 16582.8 18573.3 1041.1 1064.4 1065.7 1067.4 1069.0 1054.5 1055.2 1055.9 1056.0 1057.1 1103.2 1113.3 1113.8 1116.4 1119.5 1038.2 1110.6 1112.1 1112.9 1118.8 772.3 778.4 786.8 787.7 789.2 18021.7 18172.2 18205.5 18214.1 18255.5 17980.4 19256.4 19390.0 19430.3 19451.5 15004.5 15629.8 16198.8 16391.9 16395.1 3648.7 3655.4 3655.8 3662.1 3669.5 98647.0 99842.0 100954.5 102834.5 104367.0 14799.5 15003.0 15121.0 15262.6 15288.0 27561.6 27761.0 28696.9 28875.0 29064.6 7594.3 7687.5 7742.6 7767.0 7789.3 3673.0 3772.7 3778.1 3807.6 3835.0 4506.6 4558.6 4577.8 4589.4 4604.9 845.3 876.4 895.6 965.4 972.2 653.5 687.0 712.8 718.6 732.6 11415.0 11606.7 12054.6 12244.8 12519.1 628.2 635.7 652.1 666.3 670.7 5312.5 5554.3 5579.9 5586.2 5590.4 88452.6 91378.5 91432.5 95613.5 95945.5 64193.7 79339.0 79838.0 82947.6 83410.6 65431.0 69181.0 70763.6 71955.6 74713.0 11610.4 12222.4 12271.4 12426.8 12507.0 32592.8 32627.7 33013.0 33792.8 35083.0 41457.8 43546.1 44538.6 44628.6 45136.8 17597.9 17878.0 18339.3 18378.0 18422.3 19107.6 19528.8 19710.5 19727.7 20006.9 16499.6 17771.5 17843.9 17900.6 18031.5 17912.9 17971.1 18064.9 18077.6 18231.6 16633.3 16883.4 17698.2 17746.6 18092.5 11428.6 11670.2 11685.8 11808.1 11961.8 12688.9 12693.6 12811.3 12946.5 12963.7 03:05:40 INFO - PID 24051 | -------- Summary: end -------- 03:05:40 INFO - PID 24051 | 03:05:40 INFO - TEST-INFO | 24051: exit 0 03:05:41 INFO - TEST-OK | dromaeo_css | took 1116016ms 03:05:41 INFO - TEST-START | kraken 03:05:41 INFO - operating with platform_type : linux_ 03:05:41 INFO - Initialising browser for kraken test... 03:05:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53673/getInfo.html -profile /tmp/tmpEadzuu/profile 03:05:41 INFO - TEST-INFO | started process 24457 (/builds/slave/test/build/application/firefox/firefox http://localhost:53673/getInfo.html) 03:05:46 INFO - TEST-INFO | 24457: exit 0 03:05:46 INFO - Browser initialized. 03:05:46 INFO - Running cycle 1/1 for kraken test... 03:05:46 INFO - TEST-INFO | started process 24663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEadzuu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:58 INFO - PID 24663 | RSS: Main: 168390656 03:05:58 INFO - PID 24663 | 03:06:00 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53673/tests/kraken/driver.html?testName=audio-beat-detection) 03:06:01 INFO - PID 24663 | RSS: Main: 173383680 03:06:01 INFO - PID 24663 | 03:06:04 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53673/tests/kraken/driver.html?testName=audio-dft) 03:06:04 INFO - PID 24663 | RSS: Main: 174182400 03:06:04 INFO - PID 24663 | 03:06:07 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53673/tests/kraken/driver.html?testName=audio-fft) 03:06:08 INFO - PID 24663 | RSS: Main: 169529344 03:06:08 INFO - PID 24663 | 03:06:10 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53673/tests/kraken/driver.html?testName=audio-oscillator) 03:06:11 INFO - PID 24663 | RSS: Main: 169623552 03:06:11 INFO - PID 24663 | 03:06:13 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53673/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:06:13 INFO - PID 24663 | RSS: Main: 169459712 03:06:13 INFO - PID 24663 | 03:06:16 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53673/tests/kraken/driver.html?testName=imaging-darkroom) 03:06:17 INFO - PID 24663 | RSS: Main: 173432832 03:06:17 INFO - PID 24663 | 03:06:20 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53673/tests/kraken/driver.html?testName=imaging-desaturate) 03:06:21 INFO - PID 24663 | RSS: Main: 174866432 03:06:21 INFO - PID 24663 | 03:06:24 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53673/tests/kraken/driver.html?testName=json-parse-financial) 03:06:25 INFO - PID 24663 | RSS: Main: 173969408 03:06:25 INFO - PID 24663 | 03:06:26 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53673/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:06:27 INFO - PID 24663 | RSS: Main: 173330432 03:06:27 INFO - PID 24663 | 03:06:28 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53673/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:06:29 INFO - PID 24663 | RSS: Main: 173817856 03:06:29 INFO - PID 24663 | 03:06:31 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53673/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:06:32 INFO - PID 24663 | RSS: Main: 173617152 03:06:32 INFO - PID 24663 | 03:06:34 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53673/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:06:35 INFO - PID 24663 | RSS: Main: 173293568 03:06:35 INFO - PID 24663 | 03:06:38 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53673/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:06:39 INFO - PID 24663 | RSS: Main: 173428736 03:06:39 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | Cycle 1(1): loaded http://localhost:53673/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53673/tests/kraken/driver.html?testName=ai-astar) 03:06:41 INFO - PID 24663 | RSS: Main: 174665728 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | __start_tp_report 03:06:41 INFO - PID 24663 | _x_x_mozilla_page_load 03:06:41 INFO - PID 24663 | _x_x_mozilla_page_load_details 03:06:41 INFO - PID 24663 | |i|pagename|runs| 03:06:41 INFO - PID 24663 | |0;ai-astar;101;108;108;107;112;108;108;108;108;108 03:06:41 INFO - PID 24663 | |1;audio-beat-detection;143;118;147;176;125;149;147;121;178;126 03:06:41 INFO - PID 24663 | |2;audio-dft;162;162;161;161;160;178;164;170;166;161 03:06:41 INFO - PID 24663 | |3;audio-fft;75;75;74;182;74;73;75;74;96;75 03:06:41 INFO - PID 24663 | |4;audio-oscillator;82;81;131;81;80;81;134;80;82;127 03:06:41 INFO - PID 24663 | |5;imaging-gaussian-blur;115;114;114;113;114;114;114;113;114;113 03:06:41 INFO - PID 24663 | |6;imaging-darkroom;151;150;150;150;150;150;149;150;152;150 03:06:41 INFO - PID 24663 | |7;imaging-desaturate;94;94;94;94;95;94;94;94;95;94 03:06:41 INFO - PID 24663 | |8;json-parse-financial;55;59;55;54;56;57;60;56;54;56 03:06:41 INFO - PID 24663 | |9;json-stringify-tinderbox;55;53;53;54;54;54;53;55;54;53 03:06:41 INFO - PID 24663 | |10;stanford-crypto-aes;86;77;79;78;76;78;76;78;75;79 03:06:41 INFO - PID 24663 | |11;stanford-crypto-ccm;129;134;133;127;125;124;130;137;128;154 03:06:41 INFO - PID 24663 | |12;stanford-crypto-pbkdf2;183;187;185;184;190;183;183;183;182;191 03:06:41 INFO - PID 24663 | |13;stanford-crypto-sha256-iterative;68;71;67;67;71;67;69;66;70;65 03:06:41 INFO - PID 24663 | __end_tp_report 03:06:41 INFO - PID 24663 | __start_cc_report 03:06:41 INFO - PID 24663 | _x_x_mozilla_cycle_collect,947 03:06:41 INFO - PID 24663 | __end_cc_report 03:06:41 INFO - PID 24663 | __startTimestamp1498558001331__endTimestamp 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | ------- Summary: start ------- 03:06:41 INFO - PID 24663 | Number of tests: 14 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#0] ai-astar Cycles:10 Average:107.60 Median:108.00 stddev:2.67 (2.5%) stddev-sans-first:1.41 03:06:41 INFO - PID 24663 | Values: 101.0 108.0 108.0 107.0 112.0 108.0 108.0 108.0 108.0 108.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:147.00 stddev:21.35 (14.5%) stddev-sans-first:22.65 03:06:41 INFO - PID 24663 | Values: 143.0 118.0 147.0 176.0 125.0 149.0 147.0 121.0 178.0 126.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.00 stddev:5.62 (3.4%) stddev-sans-first:5.89 03:06:41 INFO - PID 24663 | Values: 162.0 162.0 161.0 161.0 160.0 178.0 164.0 170.0 166.0 161.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#3] audio-fft Cycles:10 Average:87.30 Median:75.00 stddev:33.97 (45.3%) stddev-sans-first:35.74 03:06:41 INFO - PID 24663 | Values: 75.0 75.0 74.0 182.0 74.0 73.0 75.0 74.0 96.0 75.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:81.00 stddev:24.06 (29.7%) stddev-sans-first:24.99 03:06:41 INFO - PID 24663 | Values: 82.0 81.0 131.0 81.0 80.0 81.0 134.0 80.0 82.0 127.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 03:06:41 INFO - PID 24663 | Values: 115.0 114.0 114.0 113.0 114.0 114.0 114.0 113.0 114.0 113.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 03:06:41 INFO - PID 24663 | Values: 151.0 150.0 150.0 150.0 150.0 150.0 149.0 150.0 152.0 150.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:06:41 INFO - PID 24663 | Values: 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:1.99 (3.6%) stddev-sans-first:2.06 03:06:41 INFO - PID 24663 | Values: 55.0 59.0 55.0 54.0 56.0 57.0 60.0 56.0 54.0 56.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.71 03:06:41 INFO - PID 24663 | Values: 55.0 53.0 53.0 54.0 54.0 54.0 53.0 55.0 54.0 53.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:3.05 (3.9%) stddev-sans-first:1.41 03:06:41 INFO - PID 24663 | Values: 86.0 77.0 79.0 78.0 76.0 78.0 76.0 78.0 75.0 79.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:131.50 stddev:8.70 (6.6%) stddev-sans-first:9.15 03:06:41 INFO - PID 24663 | Values: 129.0 134.0 133.0 127.0 125.0 124.0 130.0 137.0 128.0 154.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.10 Median:184.50 stddev:3.18 (1.7%) stddev-sans-first:3.28 03:06:41 INFO - PID 24663 | Values: 183.0 187.0 185.0 184.0 190.0 183.0 183.0 183.0 182.0 191.0 03:06:41 INFO - PID 24663 | 03:06:41 INFO - PID 24663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:2.08 (3.0%) stddev-sans-first:2.20 03:06:41 INFO - PID 24663 | Values: 68.0 71.0 67.0 67.0 71.0 67.0 69.0 66.0 70.0 65.0 03:06:41 INFO - PID 24663 | -------- Summary: end -------- 03:06:41 INFO - PID 24663 | 03:06:42 INFO - TEST-INFO | 24663: exit 0 03:06:42 INFO - TEST-OK | kraken | took 61127ms 03:06:42 INFO - SUITE-END | took 1177s 03:06:42 INFO - Completed test suite (00:19:37) 03:06:42 INFO - javascript benchmark 03:06:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8268.28309753427, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.726064654181, 3079.8922037728685, 3104.9379012419754, 3124.843757812109, 3134.2634480896986, 6045.274567051954, 6118.204633397658, 6140.320203811473, 6168.136460895467, 6199.845003874905, 6161.353057928909, 6170.105334726462, 6175.320714721388, 6183.288921773986, 6204.0, 5684.147377893318, 5695.743691533891, 5732.398098199692, 5735.11105778605, 5790.36306006339, 5547.8890422191735, 5667.234923285345, 5672.064109421961, 5698.230738850264, 5719.313682358102, 5621.409751976024, 5633.802816901389, 5647.181158731961, 5726.3700992890745, 5739.913901291484, 5704.22992895962, 5705.0, 5707.828765137053, 5731.971340143315, 5737.799177028784, 5633.126865335838, 5639.464250896158, 5640.125780504029, 5648.350439699446, 5652.434756524314, 6006.339302676702, 6094.421030002142, 6133.264008318985, 6144.170536977495, 6148.938510614926, 6511.28375878653, 6523.315051919528, 6583.407493325576, 6589.472842172615, 6594.9010764838085, 6666.0667506549125, 6714.3957043866285, 6717.664116794141, 6718.529702920847, 6721.294264102247, 6130.325664176937, 6217.751289948442, 6249.437550620466, 6253.249610046823, 6257.468115210167, 6631.966840165768, 6719.260881303053, 6769.763058292936, 6799.966000170067, 6828.351306625863, 6538.051982462612, 6539.640319782363, 6549.0, 6550.70521826519, 6558.606483610999, 6572.211334639778, 6637.269900310962, 6657.1345725055435, 6670.232923213795, 6681.5656982296, 6622.304658010936, 6630.9336906630315, 6636.037774522667, 6646.534742567974, 6647.60114393138, 6477.708503117371, 6572.11276477679, 6648.96675516629, 6678.766243181465, 6681.532292739462, 5266.0, 5308.92036619451, 5325.440828713007, 5332.866678333073, 5336.599755018389, 4529.909401811945, 4605.723656580549, 4630.791614377361, 4630.86107416778, 4634.629229661619, 5777.537796976316, 5784.305883293948, 5788.160716696056, 5801.82594522165, 5832.445917637818, 6593.835154121185, 6627.469802415795, 6661.3338666132995, 6672.2994085621285, 6695.163104611924, 5698.0, 5736.897118112654, 5748.48263656273, 5756.942430575725, 5797.710114494258, 5798.362180160179, 5848.9707551462825, 5850.385709500441, 5886.175935369051, 5897.616654917417, 6450.580712253689, 6451.903221451588, 6525.0, 6529.118568993125, 6553.574017688835, 6709.194896612243, 6739.0902228198565, 6741.865162696817, 6748.527603067934, 6750.831229219309, 6500.674966251763, 6508.544401891822, 6514.218293804774, 6522.21733391996, 6543.214814222324, 6383.489320854414, 6498.220213574401, 6508.8047358579315, 6543.1821022372205, 6595.637239951849, 6504.902426463512, 6536.8365790855605, 6609.636469994197, 6632.900506492503, 6640.402363787282, 6367.808965731036, 6418.646974416265, 6434.163558737334, 6447.548671592944, 6453.903191452226, 6428.19647544057, 6429.742810287723, 6476.417122459001, 6496.805095847132, 6527.2167339919515, 6113.847153821012, 6244.344343843831, 6283.71723272463, 6287.528435367457, 6436.6459844707115, 6425.742970281136, 6465.612063276219, 6486.351364863476, 6530.249021362414, 6543.509236807354, 6262.0, 6263.686815659108, 6336.0, 6344.429001389897, 6374.904376434264], "value": 6048.671315095459, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.2567996203702, 833.7165363776317, 853.9530325832077, 860.4794099569756, 1073.3506228731621, 32215.516767248482, 43043.0, 44028.33957490632, 44068.3389749154, 44317.113657726826, 43782.56217437825, 44115.338269925975, 44367.112657746824, 44402.77798611002, 44492.77753611236, 7710.190430004839, 7775.261350171753, 7824.72613458529, 7856.175101614305, 7865.0, 7300.488965772398, 7680.731174408897, 7706.113796913342, 7753.844923101535, 7785.688572457095, 7413.851722965537, 7463.514871533333, 7464.10430748311, 7480.962595187044, 7481.8877716834295, 7387.889181662279, 7440.441966852481, 7459.440541959375, 7461.664225109856, 7483.962580187119, 7634.389248860133, 7677.2322767723335, 7682.539047657103, 7693.153753087212, 7701.768946931601, 39815.8009209955, 39981.40027899584, 39997.0, 40186.39720404167, 40188.0, 3478.5303983962094, 3480.9825950870086, 3488.0582242794558, 3500.43992961125, 3500.8949731508096, 30915.22711932197, 30942.071737847902, 31051.844740776378, 31075.378492430253, 31138.0, 3655.4151335786414, 3656.835442405098, 3702.38910579754, 3719.590845007047, 3729.179580492287, 186503.0, 190353.0, 191068.9999999986, 191325.0, 192827.0, 49450.25824612634, 50558.24162637563, 50873.491265087614, 50917.49082509201, 51059.744701277, 53638.195427068626, 54079.45920540823, 54167.0, 54220.0, 54314.45685543094, 15912.76130858038, 15970.121643309729, 16075.919620402057, 16082.678346433006, 16085.115318657352, 13125.868741312655, 13167.53913613019, 13188.0, 13192.142510736963, 13216.73566528664, 14989.40042398292, 15030.924845375921, 15119.622009449631, 15143.697126057417, 15330.0, 5716.5426765859465, 5720.971395142998, 5755.000274809051, 5779.190913272145, 5919.289685237799, 962.9374090684083, 967.0706939655432, 1001.7746007148334, 1012.473513772834, 1018.5060245780791, 22429.43926401853, 22505.212317569134, 22560.887195564246, 22587.209447669582, 22808.0, 1039.1323245090282, 1074.6292529077455, 1108.3183841937312, 1109.611635927419, 1116.1015382617072, 11793.410329483491, 11864.466099025565, 11868.0, 11894.82157767634, 12014.279143251433, 220388.0, 221530.0, 222802.0, 223033.0, 223443.0, 53117.468825312026, 53143.46856531462, 53200.73399632977, 53213.467865320854, 53363.733181333846, 1437.2570712460479, 1442.8052212951118, 1471.1026273972868, 1473.8452462491284, 1490.7242160200399, 21561.784382156606, 22144.88927555352, 22210.66683999709, 22253.666195006765, 26859.328516786456, 51952.48047519477, 52106.739466302424, 52275.47724522706, 52382.47617523776, 52477.7376113117, 194547.02726486276, 195184.0, 195235.0, 195241.0, 195383.0, 34566.30867382688, 34880.47679284762, 35873.0, 37174.0, 37274.44088338732, 46149.76925115353, 46593.76703116463, 46608.766956165004, 46874.296885547425, 49367.753161233966, 32622.51066233961, 33661.83169084139, 34412.48381274233, 34435.13912152216, 34722.305553888276, 33239.0, 33769.83115084409, 33798.66201337955, 33818.154546136546, 33854.153646159044, 36226.275474489834, 36542.086447839014, 37067.25865482729, 37311.6268837319, 37328.25343493169, 31110.68889311078, 32342.0, 33336.83331583327, 33456.832715836266, 33654.495182571794, 23354.53290934206, 23431.41421464477, 23857.880710596335, 23898.924548395713, 24001.639975400034], "value": 17353.181321533288, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.1277606933185, 565.2510423688608, 568.840724597113, 581.5144354464021, 592.8547505861063, 21983.450413739643, 22535.54928901423, 22664.54670906581, 22676.0, 22727.0, 23965.0, 25049.0, 26231.737682623218, 26268.47463050738, 26334.868325658394, 6570.178727659043, 6702.932970670304, 6703.128593282866, 6704.229013663442, 6715.160604924385, 6579.111819904323, 6626.436752875988, 6628.270890202074, 6637.933620663804, 6645.102911107011, 6170.96914515429, 6404.871902561946, 6421.229452465711, 6458.61248325102, 6633.237177724575, 6430.389113034277, 6573.638449885254, 6578.506612004071, 6578.703958321839, 6579.309172536887, 6091.055886337581, 6093.634381937054, 6094.329623741385, 6118.908216376758, 6119.265688117454, 27342.863285683445, 28221.0, 28724.0, 28766.0, 28787.0, 1876.6059127583223, 1941.3787587971854, 1944.8638595298335, 1946.4355336952267, 1961.4017724593994, 17793.822061779345, 18252.543686407815, 18282.817171828243, 18299.0, 18336.724949125775, 2284.4859906521065, 2287.9084836606517, 2308.68832707584, 2336.6144586143264, 2338.263447014185, 117796.41101794437, 120390.0, 120941.39529302384, 120944.0, 121048.0, 13382.665433364244, 14288.928555357365, 14814.92592537052, 14858.851411485963, 15010.0, 23046.193383231508, 23137.190198343313, 23139.53720925572, 23275.0, 23336.416589585056, 9465.148136667733, 9466.29002824791, 9503.382280151767, 9548.1884039856, 9718.368306060225, 8557.529335886586, 8593.355498337649, 8630.39587228888, 8689.000764911989, 8711.34664900135, 8604.655813767504, 8627.78430539229, 8654.48073115615, 8855.73432797017, 9182.95408522953, 2545.5163518931713, 2685.2615530729204, 2712.986435067812, 2747.615333853262, 2842.616246806696, 946.1579194516886, 963.4893506441597, 975.7463059604554, 990.6928852055742, 991.4893829677721, 19347.709784353247, 19633.509162271057, 19801.20795168206, 19972.0, 20107.0, 979.4710856137748, 1013.6705570689555, 1022.4529876516028, 1044.2690116918188, 1052.3422860712055, 10394.696603498087, 10430.217733670004, 10693.465326733633, 10696.89303106959, 10849.511771970281, 488821.0, 494855.0, 524518.0, 530533.0, 540499.0, 104722.0, 106599.26902558374, 106809.99999999844, 107636.4618176904, 108441.45779271211, 1172.5602898912907, 1199.5741511763372, 1226.4174517104482, 1243.8383010208615, 1257.6855786053486, 16181.271842767339, 19658.705119422935, 20511.8974405127, 20666.586668266853, 20938.0, 47251.0, 49757.75121124516, 51030.48969510257, 51333.48666513287, 54407.45592544182, 62629.373706262355, 62696.686516567126, 63111.0533341991, 63233.0, 63750.362496374444, 12252.203606765532, 12414.317212553035, 12481.0, 12506.312152831682, 12577.119601627799, 18609.53476163107, 18712.345067923103, 18739.90630046841, 18849.6230075395, 19018.42944711661, 15400.229988500307, 15498.0, 15579.844201558293, 15691.686166276382, 15947.282372293506, 12743.10798244114, 13318.467261309439, 13450.46198152063, 13541.59375218745, 13941.163530188222, 13855.86144138586, 15185.6203594911, 15420.84579154239, 15518.534443966699, 15527.0, 12793.0, 12950.158239714388, 13052.804207937079, 13064.673383165496, 13147.60557183286, 15550.611234719223, 15559.766603501183, 15595.922020389826, 15638.45265415705, 15663.765043524585], "value": 11333.80790371109, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.8604696506866, 1404.1224234853216, 1415.05898577446, 1415.3135729171354, 1416.1432333438263, 13170.539031133912, 13960.930195349008, 13991.510297139603, 14035.438582456702, 14110.223937683424, 13415.664608384795, 13843.169409835416, 13928.930355348235, 13935.303234838242, 13938.303084845767, 2616.2543675052566, 2633.7102918679025, 2641.181233817513, 2655.4556315955183, 2661.3213630524187, 2484.167803785734, 2554.272032470746, 2565.9615105773337, 2566.345581876619, 2570.5501537231003, 2566.5765148750434, 2568.4606232691062, 2593.4164812917134, 2597.909073182439, 2612.6603541539575, 2490.3151633300895, 2491.838030528019, 2499.200255918107, 2500.574902266601, 2502.862342571158, 2443.4624382635793, 2462.2982450001664, 2467.2968204061935, 2474.183519438581, 2475.10896077412, 13561.525346612822, 13589.728205435837, 13617.523386681418, 13646.0, 13695.178289302574, 7014.579125252501, 7383.704651813921, 7415.40676745859, 7420.295071968154, 7428.739994100235, 4098.426220329156, 4290.742555446684, 4299.398084268205, 4325.329573916048, 4353.73877567347, 1547.7755725419863, 1563.1480842940625, 1564.0771944552769, 1599.7680336351164, 1615.8868879178463, 20176.899115504475, 20936.895315523325, 22169.22407715722, 22344.55310893773, 22480.55038899229, 5535.833924982257, 6194.4115309045565, 6329.3354197809485, 6332.240131184288, 6365.904511432333, 15159.848401515843, 15266.313015914311, 15277.0, 15297.158656274012, 15337.769933451007, 7094.751683691046, 7274.96362518184, 7278.344948954619, 7332.670029848669, 7347.88978165328, 6849.178098628096, 6857.108575885203, 6921.411680007155, 6959.8956015659805, 6974.0, 4718.646101542398, 4811.855644330606, 4821.54195351441, 4849.4908034656555, 4869.659123861366, 1344.3345543955804, 1362.7206422683325, 1374.216696482995, 1391.624261449403, 1395.3372148229712, 897.7261935109855, 899.4243684042218, 916.276141847946, 923.0538697834774, 934.3693007220099, 7308.488405811542, 7408.666610002563, 7466.440016998747, 7527.134379546313, 8551.102134275812, 944.6788092048737, 963.4749061761216, 971.844504879216, 990.3909095905966, 997.1574019953129, 4886.853394398174, 4900.509949005071, 4975.08459243194, 5014.774335154927, 5224.50367215114, 18144.727829082574, 18254.543636409195, 18671.439856804318, 18809.81190188108, 18838.90580547116, 17840.107994600217, 18083.457496275132, 18090.366837160636, 18209.180586873623, 18616.534586635444, 10077.748056298651, 10255.794884102426, 10292.228082893664, 10318.071373576264, 10362.689119326433, 7089.680964356513, 7855.135935047026, 7860.528368297921, 7970.163132871197, 8062.153473885158, 15886.2056897157, 15896.728261739265, 15945.123018234108, 16227.756583651018, 16477.752833707265, 15935.203239838194, 16352.345906164097, 16585.170741462636, 16818.66362672764, 16822.411215607393, 9989.200863931013, 9992.65025724096, 10150.593976240867, 10185.08334249921, 10211.029952154533, 12625.87374126247, 12657.746845062862, 12695.619131426072, 12719.80920286178, 12729.80905286403, 10346.521889305608, 10432.321899076536, 10467.94766026165, 10529.57881684724, 10781.676549703521, 9903.900960990299, 10106.343087699275, 10143.847842282225, 10179.84730229062, 10232.53953572106, 9287.349885507949, 9456.148946594565, 9460.668876589287, 9461.526923653651, 9507.904920950701, 6452.612843229421, 6813.3527314905, 6872.484563657646, 6879.58722476633, 6917.169939607078, 6949.235584085645, 6993.720251189896, 7045.612491313027, 7056.682449289691, 7080.964595177197], "value": 6106.41532897537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.07492502008597, 500.1197891710588, 518.1424742051905, 520.4171328112513, 527.0618299427022, 6263.311035786066, 6286.559940804145, 6341.429271365576, 6349.809505714836, 6374.0, 6034.125051867477, 6221.7822376216845, 6225.377462253772, 6237.251529816428, 6272.2159730033745, 4995.475475075119, 5004.149294619905, 5019.899602007958, 5029.798808047673, 5052.545270925616, 4985.601151907838, 5035.672681275705, 5036.546710796028, 5049.9747501262445, 5060.51925067118, 4983.9252411213865, 5014.373203349582, 5018.548330650241, 5044.873878153039, 5051.217061355495, 5020.849374518771, 5227.738613069331, 5232.92150617741, 5235.293235413209, 5245.213218017289, 4873.926891096637, 4878.585320247783, 4881.511848815126, 4882.31647569337, 4895.069936712013, 6111.663858487781, 6153.353897840707, 6168.87662246757, 6175.938240617626, 6203.782867599657, 6029.005214139662, 6065.605735627214, 6087.421694938974, 6100.23747031621, 6101.749141425997, 6653.301403352675, 6695.363940425652, 6707.865842683168, 6712.664366781642, 6725.730970761164, 5328.813491527817, 5358.946410535884, 5361.892762144736, 5387.811426600089, 5390.5418039466695, 6952.687129079203, 6997.580145191254, 7055.800513912647, 7069.434445244368, 7076.186238582577, 5519.503244707996, 5562.913907284768, 5574.912891986024, 5576.749046292926, 5580.386157522669, 5608.6073974821375, 5637.915431268452, 5658.971705141448, 5669.0, 5678.829635110953, 6064.36324185963, 6094.878102437927, 6100.359462256488, 6109.602875813058, 6118.847028824315, 6344.429001389804, 6697.933020669829, 6718.0, 6747.325267473213, 6761.93238067613, 1954.5602239496, 1956.6184594004033, 1965.823075923145, 1978.5655399835005, 1994.8703334283516, 1402.7615305398108, 1425.3229715884872, 1430.4135304525096, 1449.0943160524673, 1463.4438913213123, 5617.41017193197, 5782.88434231313, 5788.27646544182, 5840.328362238312, 5890.2342695449315, 6654.434373078343, 6714.0, 6738.797836064926, 6752.358525940028, 6761.729530818712, 5829.7376618052285, 5868.647881127146, 5881.294244690579, 5885.028970219866, 5909.793157239562, 3547.6807087362263, 3556.644335566423, 3577.5349204603235, 3585.2829434113282, 3613.512175856226, 6498.0, 6531.183602049744, 6539.280679125292, 6544.247411547638, 6590.8352291193105, 6894.620795856276, 6915.585064896021, 6936.653167341613, 6953.33943275388, 7004.299570042955, 6533.41199292066, 6535.934640653532, 6561.1470508833545, 6575.243846957661, 6601.933980660132, 6755.324467553205, 6761.701021652661, 6768.593884366954, 6775.170703910016, 6799.93200067993, 6696.732130714717, 6704.195496540251, 6713.395794378529, 6730.394264516217, 6732.562383445061, 6205.410486003822, 6452.516061295515, 6525.804225873231, 6525.902111468236, 6541.443977261986, 4896.436909755424, 4955.65310428281, 5000.274960130833, 5006.098902197639, 5011.0206468445485, 6747.325267473213, 6767.0526126341365, 6767.593944363354, 6776.593404395752, 6781.220159681699, 6568.638724870178, 6595.373439523238, 6596.835079122869, 6603.174603174603, 6615.536912416084, 6501.9674901625185, 6507.381798729113, 6578.822447745621, 6584.868302634016, 6588.143541339595, 6408.58344207625, 6465.127207826883, 6485.870282594227, 6485.902711459237, 6502.0, 6607.108040414675, 6619.900701489578, 6622.1722284714415, 6624.138861947916, 6639.734410623521, 6394.808155755335, 6403.3276505966205, 6426.550141490238, 6429.903551446639, 6437.645929473737], "value": 5206.838414303977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.808050108224, 854.3336197765741, 861.3238607692961, 871.0549054276111, 872.7512658892217, 17092.91453542732, 17529.21118549665, 17617.471475855713, 17653.0, 17677.204525796336, 15600.0, 15698.215089245521, 15777.368905243777, 16582.75125873113, 18573.257069717194, 1041.1254546181187, 1064.4305296666246, 1065.6856227412893, 1067.4182570499058, 1068.9684454501405, 1054.5360041581719, 1055.166418529361, 1055.9260851740382, 1056.0495554001423, 1057.133150816331, 1103.2112039891476, 1113.3208742666966, 1113.8273567596996, 1116.3971455414066, 1119.4906317625503, 1038.1642777564057, 1110.572429614596, 1112.0880877680306, 1112.8831472695372, 1118.7706520163347, 772.2509166108865, 778.3500776851336, 786.7875673568162, 787.7085478372982, 789.1634867040955, 18021.7296740549, 18172.182251798567, 18205.54486137844, 18214.08929553517, 18255.452336429928, 17980.37068702589, 19256.422307330802, 19390.0, 19430.319938802073, 19451.513712157168, 15004.474843380429, 15629.765553516592, 16198.75701864473, 16391.91804040984, 16395.098269595168, 3648.6533779290926, 3655.4334078217917, 3655.798931058791, 3662.08447888028, 3669.504616876714, 98647.0, 99842.0, 100954.49522752412, 102834.48582757039, 104367.0, 14799.482018129314, 15003.0, 15121.0, 15262.618434539003, 15288.0, 27561.586576201375, 27760.977259614574, 28696.85651571729, 28875.0, 29064.564031539543, 7594.278543538355, 7687.500312479671, 7742.574158421341, 7766.951461552618, 7789.298963093349, 3672.9632703672623, 3772.7359084864347, 3778.112143646241, 3807.600201978808, 3834.9616503835164, 4506.59440650343, 4558.566936141061, 4577.8168873244695, 4589.380433641482, 4604.88487787808, 845.2984023260678, 876.3646356391693, 895.5701263393607, 965.4207475514776, 972.2465089555651, 653.4641593892962, 686.9965650171717, 712.807541963667, 718.6227230703922, 732.5677850068486, 11415.0, 11606.651800446, 12054.578089766992, 12244.755104897853, 12519.061070419755, 628.1510868666871, 635.7298148286959, 652.0642877470844, 666.2904007232379, 670.7149461478949, 5312.495312945264, 5554.250176226238, 5579.888402231933, 5586.24585680936, 5590.357108932443, 88452.5577372109, 91378.54310728404, 91432.5428372854, 95613.52193239129, 95945.5202723982, 64193.679031604544, 79339.0, 79838.0, 82947.5852620733, 83410.58294708487, 65431.0, 69181.0, 70763.64618176979, 71955.64022179856, 74713.0, 11610.361430121424, 12222.388880555758, 12271.447784849524, 12426.75146497047, 12507.0, 32592.837035814668, 32627.673723262462, 33013.0, 33792.831035845644, 35083.0, 41457.79271103625, 43546.12907741764, 44538.55461445344, 44628.55371446244, 45136.77431612821, 17597.912010439864, 17878.0, 18339.266429342675, 18378.0, 18422.263109475472, 19107.61784764269, 19528.8047119527, 19710.50723731861, 19727.704084439032, 20006.89996550008, 16499.58751031234, 17771.466855994342, 17843.910780446535, 17900.55248618795, 18031.549211269823, 17912.910435448262, 17971.101444927965, 18064.909675451538, 18077.644176687063, 18231.635367292845, 16633.25150368212, 16883.40908068261, 17698.203580838635, 17746.5563360917, 18092.457226283233, 11428.599998999995, 11670.183087183816, 11685.76628467409, 11808.11439142085, 11961.820572691242, 12688.873111269138, 12693.619191424272, 12811.334526511493, 12946.482140714643, 12963.675908102374], "value": 8446.770965761547, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 108.0, 107.0, 112.0, 108.0, 108.0, 108.0, 108.0, 108.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 147.0, 176.0, 125.0, 149.0, 147.0, 121.0, 178.0, 126.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 160.0, 178.0, 164.0, 170.0, 166.0, 161.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 182.0, 74.0, 73.0, 75.0, 74.0, 96.0, 75.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 131.0, 81.0, 80.0, 81.0, 134.0, 80.0, 82.0, 127.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 150.0, 150.0, 150.0, 149.0, 150.0, 152.0, 150.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 55.0, 54.0, 56.0, 57.0, 60.0, 56.0, 54.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 54.0, 54.0, 54.0, 53.0, 55.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 77.0, 79.0, 78.0, 76.0, 78.0, 76.0, 78.0, 75.0, 79.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 134.0, 133.0, 127.0, 125.0, 124.0, 130.0, 137.0, 128.0, 154.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 187.0, 185.0, 184.0, 190.0, 183.0, 183.0, 183.0, 182.0, 191.0], "value": 185.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 67.0, 71.0, 67.0, 69.0, 66.0, 70.0, 65.0], "value": 68.1, "unit": "score"}]}]} 03:06:42 INFO - Return code: 0 03:06:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:06:42 INFO - # TBPL SUCCESS # 03:06:42 INFO - Running post-action listener: _resource_record_post_action 03:06:42 INFO - [mozharness: 2017-06-27 10:06:42.699541Z] Finished run-tests step (success) 03:06:42 INFO - Running post-run listener: _resource_record_post_run 03:06:42 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 438329344; Read time: 16; Write time: 342088 03:06:42 INFO - TinderboxPrint: CPU usage
13.1% 03:06:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:06:42 INFO - TinderboxPrint: I/O write bytes / time
438,329,344 / 342,088 03:06:42 INFO - TinderboxPrint: CPU idle
8,290.4 (86.9%) 03:06:42 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 03:06:42 INFO - TinderboxPrint: Swap in / out
0 / 0 03:06:42 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107229184; Read time: 0; Write time: 114544 03:06:42 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:06:42 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 330457088; Read time: 0; Write time: 227520 03:06:43 INFO - Running post-run listener: _upload_blobber_files 03:06:43 INFO - Blob upload gear active. 03:06:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:06:43 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 03:06:43 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'] 03:06:43 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 03:06:43 INFO - (blobuploader) - INFO - Open directory for files ... 03:06:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:06:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:06:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:44 INFO - (blobuploader) - INFO - Done attempting. 03:06:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:06:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:06:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:45 INFO - (blobuploader) - INFO - Done attempting. 03:06:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:06:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:06:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:46 INFO - (blobuploader) - INFO - Done attempting. 03:06:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:06:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:06:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:49 INFO - (blobuploader) - INFO - Done attempting. 03:06:49 INFO - (blobuploader) - INFO - Iteration through files over. 03:06:49 INFO - Return code: 0 03:06:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:06:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:06:49 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecfa6ce0eb3800f65d15add438610f61272f3f7eb11e30173b221bca0d5884a136f5040fdb816c87672ea08dcbc593b42f87482b76188b773bcac419ecee96a9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3170fcd0e86ea9cdd1fda79d8633de7ded4239a818b35464f4f70cddeec91f36ce3f135723989d18d4c76e597b00764433f0c4d17e84577cfae8f4bf32f65456", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4f07b1efb9020f6499a3d26024d0b70acd1c621a11a1012b2d59f034ca53407e35a3636133ab7493f617d6656be384c10d9ad83d2513aca5265a094db883003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/193ddd0c84618471030768b4dd489ef8a6b5519e583f8926edf958f3f921142575c45303830a37f943d86912dfc213e62adf0c2043bc73d67ff8cc9f8d53057a"} 03:06:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:06:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:06:49 INFO - Contents: 03:06:49 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecfa6ce0eb3800f65d15add438610f61272f3f7eb11e30173b221bca0d5884a136f5040fdb816c87672ea08dcbc593b42f87482b76188b773bcac419ecee96a9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3170fcd0e86ea9cdd1fda79d8633de7ded4239a818b35464f4f70cddeec91f36ce3f135723989d18d4c76e597b00764433f0c4d17e84577cfae8f4bf32f65456", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4f07b1efb9020f6499a3d26024d0b70acd1c621a11a1012b2d59f034ca53407e35a3636133ab7493f617d6656be384c10d9ad83d2513aca5265a094db883003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/193ddd0c84618471030768b4dd489ef8a6b5519e583f8926edf958f3f921142575c45303830a37f943d86912dfc213e62adf0c2043bc73d67ff8cc9f8d53057a"} 03:06:49 INFO - Running post-run listener: copy_logs_to_upload_dir 03:06:49 INFO - Copying logs to upload dir... 03:06:49 INFO - mkdir: /builds/slave/test/build/upload/logs 03:06:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.314105 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-06-27 03:06:49.910071) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-27 03:06:49.913303) ========= 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=00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecfa6ce0eb3800f65d15add438610f61272f3f7eb11e30173b221bca0d5884a136f5040fdb816c87672ea08dcbc593b42f87482b76188b773bcac419ecee96a9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3170fcd0e86ea9cdd1fda79d8633de7ded4239a818b35464f4f70cddeec91f36ce3f135723989d18d4c76e597b00764433f0c4d17e84577cfae8f4bf32f65456", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4f07b1efb9020f6499a3d26024d0b70acd1c621a11a1012b2d59f034ca53407e35a3636133ab7493f617d6656be384c10d9ad83d2513aca5265a094db883003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/193ddd0c84618471030768b4dd489ef8a6b5519e583f8926edf958f3f921142575c45303830a37f943d86912dfc213e62adf0c2043bc73d67ff8cc9f8d53057a"} build_url:https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/TDXsJsKlQF-1ylW3NoXOBQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecfa6ce0eb3800f65d15add438610f61272f3f7eb11e30173b221bca0d5884a136f5040fdb816c87672ea08dcbc593b42f87482b76188b773bcac419ecee96a9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3170fcd0e86ea9cdd1fda79d8633de7ded4239a818b35464f4f70cddeec91f36ce3f135723989d18d4c76e597b00764433f0c4d17e84577cfae8f4bf32f65456", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4f07b1efb9020f6499a3d26024d0b70acd1c621a11a1012b2d59f034ca53407e35a3636133ab7493f617d6656be384c10d9ad83d2513aca5265a094db883003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/193ddd0c84618471030768b4dd489ef8a6b5519e583f8926edf958f3f921142575c45303830a37f943d86912dfc213e62adf0c2043bc73d67ff8cc9f8d53057a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-27 03:06:49.936964) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-27 03:06:49.937256) ========= 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=00204705a9daa57ed339a427000001b9-1498554162.298856-2126646526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-27 03:06:50.021726) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-27 03:06:50.022071) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-27 03:06:50.022351) ========= ========= Total master_lag: 0.05 =========