builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1496407997.19 results: success (0) revision: 194c009d6295597344662f8e20f5e309deffe8e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 05:53:17.187992) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 05:53:17.188425) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 05:53:17.188696) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 05:53:17.233592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 05:53:17.233874) ========= 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=db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-02 05:53:17-- 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% 87.9K=0.1s 2017-06-02 05:53:17 (87.9 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.262557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 05:53:17.513920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 05:53:17.516308) ========= 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=db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023033 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 05:53:17.565852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 05:53:17.569197) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 194c009d6295597344662f8e20f5e309deffe8e9 --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 194c009d6295597344662f8e20f5e309deffe8e9 --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=db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-02 05:53:17,983 truncating revision to first 12 chars 2017-06-02 05:53:17,983 Setting DEBUG logging. 2017-06-02 05:53:17,983 attempt 1/10 2017-06-02 05:53:17,983 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/194c009d6295?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-02 05:53:19,343 unpacking tar archive at: mozilla-central-194c009d6295/testing/mozharness/ program finished with exit code 0 elapsedTime=1.685642 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 05:53:19.270247) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 05:53:19.270599) ========= script_repo_revision: 194c009d6295597344662f8e20f5e309deffe8e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 05:53:19.270973) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 05:53:19.271269) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 05:53:19.281233) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2017-06-02 05:53:19.281570) ========= /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=db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:53:19 INFO - MultiFileLogger online at 20170602 05:53:19 in /builds/slave/test 05:53:19 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 05:53:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:53:19 INFO - {'append_to_log': False, 05:53:19 INFO - 'base_work_dir': '/builds/slave/test', 05:53:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:53:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:53:19 INFO - 'branch': 'Firefox-Non-PGO', 05:53:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:53:19 INFO - 'config_files': ('talos/linux_config.py',), 05:53:19 INFO - 'default_actions': ('clobber', 05:53:19 INFO - 'read-buildbot-config', 05:53:19 INFO - 'download-and-extract', 05:53:19 INFO - 'populate-webroot', 05:53:19 INFO - 'create-virtualenv', 05:53:19 INFO - 'install', 05:53:19 INFO - 'setup-mitmproxy', 05:53:19 INFO - 'run-tests'), 05:53:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:53:19 INFO - 'download_minidump_stackwalk': True, 05:53:19 INFO - 'download_symbols': 'ondemand', 05:53:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:53:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:53:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:53:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:53:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:53:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:53:19 INFO - 'gecko_profile': False, 05:53:19 INFO - 'gecko_profile_interval': 0, 05:53:19 INFO - 'installer_path': 'installer.exe', 05:53:19 INFO - 'log_level': 'info', 05:53:19 INFO - 'log_name': 'talos', 05:53:19 INFO - 'log_to_console': True, 05:53:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:53:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:53:19 INFO - 'opt_config_files': (), 05:53:19 INFO - 'pip_index': False, 05:53:19 INFO - 'suite': 'dromaeojs-e10s', 05:53:19 INFO - 'system_bits': '32', 05:53:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:53:19 INFO - 'title': 'talos-linux64-ix-031', 05:53:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:53:19 INFO - 'use_talos_json': True, 05:53:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:53:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:53:19 INFO - 'work_dir': 'build'} 05:53:19 INFO - [mozharness: 2017-06-02 12:53:19.793102Z] Running clobber step. 05:53:19 INFO - Running pre-action listener: _resource_record_pre_action 05:53:19 INFO - Running main action method: clobber 05:53:19 INFO - rmtree: /builds/slave/test/build 05:53:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:53:20 INFO - Running post-action listener: _resource_record_post_action 05:53:20 INFO - [mozharness: 2017-06-02 12:53:20.829810Z] Finished clobber step (success) 05:53:20 INFO - [mozharness: 2017-06-02 12:53:20.829911Z] Running read-buildbot-config step. 05:53:20 INFO - Running pre-action listener: _resource_record_pre_action 05:53:20 INFO - Running main action method: read_buildbot_config 05:53:20 INFO - Using buildbot properties: 05:53:20 INFO - { 05:53:20 INFO - "project": "", 05:53:20 INFO - "product": "firefox", 05:53:20 INFO - "who": "cbook@mozilla.com", 05:53:20 INFO - "installer_path": "public/build/target.tar.bz2", 05:53:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:53:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:53:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:53:20 INFO - "stage_platform": "linux64", 05:53:20 INFO - "basedir": "/builds/slave/test", 05:53:20 INFO - "buildnumber": 884, 05:53:20 INFO - "platform": "ubuntu64_hw", 05:53:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:53:20 INFO - "slavebuilddir": "test", 05:53:20 INFO - "taskId": "aCq28ItbRbeB4JMOnr3Rog", 05:53:20 INFO - "branch": "mozilla-central", 05:53:20 INFO - "script_repo_revision": "production", 05:53:20 INFO - "revision": "194c009d6295597344662f8e20f5e309deffe8e9", 05:53:20 INFO - "slavename": "talos-linux64-ix-031", 05:53:20 INFO - "repo_path": "mozilla-central" 05:53:20 INFO - } 05:53:20 INFO - Finding installer, test and symbols from parent task. 05:53:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aCq28ItbRbeB4JMOnr3Rog'}, attempt #1 05:53:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aCq28ItbRbeB4JMOnr3Rog'}, attempt #1 05:53:21 INFO - Task dependencies: KIyO_hv7Sjqum__yWX1O2A 05:53:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A'}, attempt #1 05:53:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.tar.bz2 05:53:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/test_packages.json 05:53:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.crashreporter-symbols.zip 05:53:22 INFO - Running post-action listener: _resource_record_post_action 05:53:22 INFO - [mozharness: 2017-06-02 12:53:22.190752Z] Finished read-buildbot-config step (success) 05:53:22 INFO - [mozharness: 2017-06-02 12:53:22.190974Z] Running download-and-extract step. 05:53:22 INFO - Running pre-action listener: _resource_record_pre_action 05:53:22 INFO - Running main action method: download_and_extract 05:53:22 INFO - mkdir: /builds/slave/test/build/tests 05:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:22 INFO - trying https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.test_packages.json 05:53:22 INFO - Downloading https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:53:22 INFO - Downloaded 989 bytes. 05:53:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:53:22 INFO - Using the following test package requirements: 05:53:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:53:22 INFO - u'common': [u'target.common.tests.zip'], 05:53:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:53:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:53:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:53:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:53:22 INFO - u'mozbase': [u'target.common.tests.zip'], 05:53:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:53:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:53:22 INFO - u'web-platform': [u'target.common.tests.zip', 05:53:22 INFO - u'target.web-platform.tests.tar.gz'], 05:53:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:53:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:53:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.common.tests.zip 05:53:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:53:22 INFO - Fetch https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.common.tests.zip into memory 05:53:23 INFO - Content-Length response header: 65101707 05:53:23 INFO - Bytes received: 65101707 05:53:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:53:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.common.tests.zip 05:53:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:53:34 INFO - Fetch https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.common.tests.zip into memory 05:53:35 INFO - Content-Length response header: 65101707 05:53:35 INFO - Bytes received: 65101707 05:53:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.talos.tests.zip 05:53:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:53:47 INFO - Fetch https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.talos.tests.zip into memory 05:53:48 INFO - Content-Length response header: 14447425 05:53:48 INFO - Bytes received: 14447425 05:53: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')]} 05:53:48 INFO - trying https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.tar.bz2 05:53:48 INFO - Downloading https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:53:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:53:50 INFO - Downloaded 58604039 bytes. 05:53:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.tar.bz2 05:53:50 INFO - mkdir: /builds/slave/test/properties 05:53:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:53:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:53:50 INFO - Contents: 05:53:50 INFO - build_url:https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.tar.bz2 05:53:50 INFO - Running post-action listener: _resource_record_post_action 05:53:50 INFO - Running post-action listener: set_extra_try_arguments 05:53:50 INFO - [mozharness: 2017-06-02 12:53:50.303899Z] Finished download-and-extract step (success) 05:53:50 INFO - [mozharness: 2017-06-02 12:53:50.303996Z] Running populate-webroot step. 05:53:50 INFO - Running pre-action listener: _resource_record_pre_action 05:53:50 INFO - Running main action method: populate_webroot 05:53:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:53:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:53:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:53:50 INFO - '--tppagecycles', 05:53:50 INFO - '7'], 05:53:50 INFO - 'tests': ['tsvgm']}}, 05:53:50 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:53:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:53:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:53:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:53:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:53:50 INFO - 'talos_options': ['--disable-e10s'], 05:53:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:53:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:53:50 INFO - 'talos_options': ['--disable-e10s'], 05:53:50 INFO - 'tests': ['damp', 'tps']}, 05:53:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:53:50 INFO - 'tests': ['damp', 'tps']}, 05:53:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:53:50 INFO - 'tests': ['dromaeo_dom']}, 05:53:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:53:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:53:50 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:53:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:53:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:53:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:53:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:53:50 INFO - 'tests': ['a11yr', 05:53:50 INFO - 'ts_paint', 05:53:50 INFO - 'tpaint', 05:53:50 INFO - 'sessionrestore', 05:53:50 INFO - 'sessionrestore_no_auto_restore', 05:53:50 INFO - 'tabpaint']}, 05:53:50 INFO - 'other-e10s': {'tests': ['a11yr', 05:53:50 INFO - 'ts_paint', 05:53:50 INFO - 'tpaint', 05:53:50 INFO - 'sessionrestore', 05:53:50 INFO - 'sessionrestore_no_auto_restore', 05:53:50 INFO - 'tabpaint']}, 05:53:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:53:50 INFO - 'ts_paint', 05:53:50 INFO - 'tpaint', 05:53:50 INFO - 'sessionrestore', 05:53:50 INFO - 'sessionrestore_no_auto_restore', 05:53:50 INFO - 'tabpaint']}, 05:53:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:53:50 INFO - 'ts_paint', 05:53:50 INFO - 'tpaint', 05:53:50 INFO - 'sessionrestore', 05:53:50 INFO - 'sessionrestore_no_auto_restore', 05:53:50 INFO - 'tabpaint']}, 05:53:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:53:50 INFO - 'tests': ['a11yr', 05:53:50 INFO - 'ts_paint', 05:53:50 INFO - 'tpaint', 05:53:50 INFO - 'sessionrestore', 05:53:50 INFO - 'sessionrestore_no_auto_restore', 05:53:50 INFO - 'tabpaint']}, 05:53:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:53:50 INFO - 'tests': ['a11yr', 05:53:50 INFO - 'ts_paint', 05:53:50 INFO - 'tpaint', 05:53:50 INFO - 'sessionrestore', 05:53:50 INFO - 'sessionrestore_no_auto_restore', 05:53:50 INFO - 'tabpaint']}, 05:53:50 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:53:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:53:50 INFO - 'bloom_basic_ref']}, 05:53:50 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 05:53:50 INFO - 'talos_options': ['--mitmproxy', 05:53:50 INFO - 'mitmproxy-recording-1.mp', 05:53:50 INFO - '--firstNonBlankPaint'], 05:53:50 INFO - 'tests': ['Quantum_1']}, 05:53:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:53:50 INFO - 'tests': ['tsvgx', 05:53:50 INFO - 'tsvgr_opacity', 05:53:50 INFO - 'tart', 05:53:50 INFO - 'tscrollx', 05:53:50 INFO - 'cart', 05:53:50 INFO - 'tsvg_static']}, 05:53:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:53:50 INFO - 'tsvgr_opacity', 05:53:50 INFO - 'tart', 05:53:50 INFO - 'tscrollx', 05:53:50 INFO - 'cart', 05:53:50 INFO - 'tsvg_static']}, 05:53:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:53:50 INFO - 'talos_options': ['--disable-e10s'], 05:53:50 INFO - 'tests': ['tp5o']}, 05:53:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:53:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:53:50 INFO - 'talos_options': ['--disable-e10s', 05:53:50 INFO - '--xperf_path', 05:53:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:50 INFO - 'tests': ['tp5n']}, 05:53:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:53:50 INFO - 'talos_options': ['--xperf_path', 05:53:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:50 INFO - 'tests': ['tp5n']}}, 05:53:50 INFO - 'talos.zip': {'path': '', 05:53:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:53:50 INFO - Running post-action listener: _resource_record_post_action 05:53:50 INFO - [mozharness: 2017-06-02 12:53:50.322798Z] Finished populate-webroot step (success) 05:53:50 INFO - [mozharness: 2017-06-02 12:53:50.322893Z] Running create-virtualenv step. 05:53:50 INFO - Running pre-action listener: _resource_record_pre_action 05:53:50 INFO - Running main action method: create_virtualenv 05:53:50 INFO - Creating virtualenv /builds/slave/test/build/venv 05:53:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:53:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:53:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:53:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:53:50 INFO - Using real prefix '/usr' 05:53:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:53:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:53:52 INFO - Installing pip.................done. 05:53:52 INFO - Return code: 0 05:53:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:53:53 INFO - Reading from file tmpfile_stdout 05:53:53 INFO - Output received: 05:53:53 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:53:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d053b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080840>, '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 0x2081740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081bd0>, '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': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:53:53 INFO - Using env: {'DISPLAY': ':0', 05:53:53 INFO - 'HOME': '/home/cltbld', 05:53:53 INFO - 'LANG': 'en_US.UTF-8', 05:53:53 INFO - 'LANGUAGE': 'en_US:en', 05:53:53 INFO - 'LOGNAME': 'cltbld', 05:53:53 INFO - 'MAIL': '/var/mail/cltbld', 05:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:53 INFO - 'MOZ_NO_REMOTE': '1', 05:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:53 INFO - 'NO_EM_RESTART': '1', 05:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:53 INFO - 'PWD': '/builds/slave/test', 05:53:53 INFO - 'SHELL': '/bin/bash', 05:53:53 INFO - 'SHLVL': '1', 05:53:53 INFO - 'TERM': 'linux', 05:53:53 INFO - 'TMOUT': '86400', 05:53:53 INFO - 'USER': 'cltbld', 05:53:53 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 05:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:53 INFO - '_': '/tools/buildbot/bin/python'} 05:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:53:53 INFO - Cleaning up... 05:53:53 INFO - Return code: 0 05:53:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d053b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080840>, '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 0x2081740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081bd0>, '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': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:53:53 INFO - Using env: {'DISPLAY': ':0', 05:53:53 INFO - 'HOME': '/home/cltbld', 05:53:53 INFO - 'LANG': 'en_US.UTF-8', 05:53:53 INFO - 'LANGUAGE': 'en_US:en', 05:53:53 INFO - 'LOGNAME': 'cltbld', 05:53:53 INFO - 'MAIL': '/var/mail/cltbld', 05:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:53 INFO - 'MOZ_NO_REMOTE': '1', 05:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:53 INFO - 'NO_EM_RESTART': '1', 05:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:53 INFO - 'PWD': '/builds/slave/test', 05:53:53 INFO - 'SHELL': '/bin/bash', 05:53:53 INFO - 'SHLVL': '1', 05:53:53 INFO - 'TERM': 'linux', 05:53:53 INFO - 'TMOUT': '86400', 05:53:53 INFO - 'USER': 'cltbld', 05:53:53 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 05:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:53 INFO - '_': '/tools/buildbot/bin/python'} 05:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:53 INFO - Downloading/unpacking psutil>=3.1.1 05:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:53:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:54 INFO - Installing collected packages: psutil 05:53:54 INFO - Running setup.py install for psutil 05:53:54 INFO - building 'psutil._psutil_linux' extension 05:53:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:53:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:53:55 INFO - building 'psutil._psutil_posix' extension 05:53:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:53:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:53:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:55 INFO - Successfully installed psutil 05:53:55 INFO - Cleaning up... 05:53:55 INFO - Return code: 0 05:53:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:55 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 0x1d053b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080840>, '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 0x2081740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081bd0>, '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': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:53:55 INFO - Using env: {'DISPLAY': ':0', 05:53:55 INFO - 'HOME': '/home/cltbld', 05:53:55 INFO - 'LANG': 'en_US.UTF-8', 05:53:55 INFO - 'LANGUAGE': 'en_US:en', 05:53:55 INFO - 'LOGNAME': 'cltbld', 05:53:55 INFO - 'MAIL': '/var/mail/cltbld', 05:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:55 INFO - 'MOZ_NO_REMOTE': '1', 05:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:55 INFO - 'NO_EM_RESTART': '1', 05:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:55 INFO - 'PWD': '/builds/slave/test', 05:53:55 INFO - 'SHELL': '/bin/bash', 05:53:55 INFO - 'SHLVL': '1', 05:53:55 INFO - 'TERM': 'linux', 05:53:55 INFO - 'TMOUT': '86400', 05:53:55 INFO - 'USER': 'cltbld', 05:53:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 05:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:55 INFO - '_': '/tools/buildbot/bin/python'} 05:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:53:56 INFO - Installing collected packages: mozsystemmonitor 05:53:56 INFO - Running setup.py install for mozsystemmonitor 05:53:56 INFO - Successfully installed mozsystemmonitor 05:53:56 INFO - Cleaning up... 05:53:56 INFO - Return code: 0 05:53:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:56 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 0x1d053b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080840>, '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 0x2081740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081bd0>, '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': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:53:56 INFO - Using env: {'DISPLAY': ':0', 05:53:56 INFO - 'HOME': '/home/cltbld', 05:53:56 INFO - 'LANG': 'en_US.UTF-8', 05:53:56 INFO - 'LANGUAGE': 'en_US:en', 05:53:56 INFO - 'LOGNAME': 'cltbld', 05:53:56 INFO - 'MAIL': '/var/mail/cltbld', 05:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:56 INFO - 'MOZ_NO_REMOTE': '1', 05:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:56 INFO - 'NO_EM_RESTART': '1', 05:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:56 INFO - 'PWD': '/builds/slave/test', 05:53:56 INFO - 'SHELL': '/bin/bash', 05:53:56 INFO - 'SHLVL': '1', 05:53:56 INFO - 'TERM': 'linux', 05:53:56 INFO - 'TMOUT': '86400', 05:53:56 INFO - 'USER': 'cltbld', 05:53:56 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 05:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:56 INFO - '_': '/tools/buildbot/bin/python'} 05:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:56 INFO - Downloading/unpacking jsonschema==2.5.1 05:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:58 INFO - warning: no files found matching '*.txt' 05:53:58 INFO - no previously-included directories found matching 'build' 05:53:58 INFO - no previously-included directories found matching 'dist' 05:53:58 INFO - no previously-included directories found matching '.git*' 05:53:58 INFO - Installing collected packages: jsonschema, functools32 05:53:58 INFO - Running setup.py install for functools32 05:53:58 INFO - warning: no files found matching '*.txt' 05:53:58 INFO - no previously-included directories found matching 'build' 05:53:58 INFO - no previously-included directories found matching 'dist' 05:53:58 INFO - no previously-included directories found matching '.git*' 05:53:58 INFO - Successfully installed jsonschema functools32 05:53:58 INFO - Cleaning up... 05:53:58 INFO - Return code: 0 05:53:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:58 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 0x1d053b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080840>, '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 0x2081740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081bd0>, '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': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:53:58 INFO - Using env: {'DISPLAY': ':0', 05:53:58 INFO - 'HOME': '/home/cltbld', 05:53:58 INFO - 'LANG': 'en_US.UTF-8', 05:53:58 INFO - 'LANGUAGE': 'en_US:en', 05:53:58 INFO - 'LOGNAME': 'cltbld', 05:53:58 INFO - 'MAIL': '/var/mail/cltbld', 05:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:58 INFO - 'MOZ_NO_REMOTE': '1', 05:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:58 INFO - 'NO_EM_RESTART': '1', 05:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:58 INFO - 'PWD': '/builds/slave/test', 05:53:58 INFO - 'SHELL': '/bin/bash', 05:53:58 INFO - 'SHLVL': '1', 05:53:58 INFO - 'TERM': 'linux', 05:53:58 INFO - 'TMOUT': '86400', 05:53:58 INFO - 'USER': 'cltbld', 05:53:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 05:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:58 INFO - '_': '/tools/buildbot/bin/python'} 05:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:53:58 INFO - Cleaning up... 05:53:58 INFO - Return code: 0 05:53:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:58 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 0x1d053b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080840>, '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 0x2081740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081bd0>, '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': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:53:58 INFO - Using env: {'DISPLAY': ':0', 05:53:58 INFO - 'HOME': '/home/cltbld', 05:53:58 INFO - 'LANG': 'en_US.UTF-8', 05:53:58 INFO - 'LANGUAGE': 'en_US:en', 05:53:58 INFO - 'LOGNAME': 'cltbld', 05:53:58 INFO - 'MAIL': '/var/mail/cltbld', 05:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:58 INFO - 'MOZ_NO_REMOTE': '1', 05:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:58 INFO - 'NO_EM_RESTART': '1', 05:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:58 INFO - 'PWD': '/builds/slave/test', 05:53:58 INFO - 'SHELL': '/bin/bash', 05:53:58 INFO - 'SHLVL': '1', 05:53:58 INFO - 'TERM': 'linux', 05:53:58 INFO - 'TMOUT': '86400', 05:53:58 INFO - 'USER': 'cltbld', 05:53:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 05:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:58 INFO - '_': '/tools/buildbot/bin/python'} 05:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:00 INFO - Downloading docopt-0.6.1.tar.gz 05:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:00 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:00 INFO - Running setup.py install for blobuploader 05:54:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:00 INFO - Running setup.py install for requests 05:54:00 INFO - Running setup.py install for docopt 05:54:01 INFO - Successfully installed blobuploader requests docopt 05:54:01 INFO - Cleaning up... 05:54:01 INFO - Return code: 0 05:54:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:01 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 0x1d053b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080840>, '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 0x2081740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081bd0>, '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': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:54:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:54:01 INFO - Using env: {'DISPLAY': ':0', 05:54:01 INFO - 'HOME': '/home/cltbld', 05:54:01 INFO - 'LANG': 'en_US.UTF-8', 05:54:01 INFO - 'LANGUAGE': 'en_US:en', 05:54:01 INFO - 'LOGNAME': 'cltbld', 05:54:01 INFO - 'MAIL': '/var/mail/cltbld', 05:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:01 INFO - 'MOZ_NO_REMOTE': '1', 05:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:01 INFO - 'NO_EM_RESTART': '1', 05:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:01 INFO - 'PWD': '/builds/slave/test', 05:54:01 INFO - 'SHELL': '/bin/bash', 05:54:01 INFO - 'SHLVL': '1', 05:54:01 INFO - 'TERM': 'linux', 05:54:01 INFO - 'TMOUT': '86400', 05:54:01 INFO - 'USER': 'cltbld', 05:54:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 05:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:01 INFO - '_': '/tools/buildbot/bin/python'} 05:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:01 INFO - Running setup.py (path:/tmp/pip-0HWA0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:01 INFO - Running setup.py (path:/tmp/pip-IGlXrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:01 INFO - Running setup.py (path:/tmp/pip-VlAZcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:01 INFO - Running setup.py (path:/tmp/pip-8TSKsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:01 INFO - Running setup.py (path:/tmp/pip-nVMGUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:01 INFO - Running setup.py (path:/tmp/pip-q4g904-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:01 INFO - Running setup.py (path:/tmp/pip-EKIYDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:01 INFO - Running setup.py (path:/tmp/pip-6yrckE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:01 INFO - Running setup.py (path:/tmp/pip-XPfXbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:01 INFO - Running setup.py (path:/tmp/pip-DBbRM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:02 INFO - Running setup.py (path:/tmp/pip-EeoxZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:02 INFO - Running setup.py (path:/tmp/pip-bWq4mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:02 INFO - Running setup.py (path:/tmp/pip-CsdDb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:02 INFO - Running setup.py (path:/tmp/pip-2G6G5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:02 INFO - Running setup.py (path:/tmp/pip-4tinEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:02 INFO - Running setup.py (path:/tmp/pip-NJN7Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:02 INFO - Running setup.py (path:/tmp/pip-rnptun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:02 INFO - Running setup.py install for manifestparser 05:54:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:02 INFO - Running setup.py install for mozcrash 05:54:02 INFO - Running setup.py install for mozdebug 05:54:02 INFO - Running setup.py install for mozdevice 05:54:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:02 INFO - Running setup.py install for mozfile 05:54:03 INFO - Running setup.py install for mozhttpd 05:54:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:03 INFO - Running setup.py install for mozinfo 05:54:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:03 INFO - Running setup.py install for mozInstall 05:54:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:03 INFO - Running setup.py install for mozleak 05:54:03 INFO - Running setup.py install for mozlog 05:54:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:03 INFO - Running setup.py install for moznetwork 05:54:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:03 INFO - Running setup.py install for mozprocess 05:54:03 INFO - Running setup.py install for mozprofile 05:54:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:03 INFO - Running setup.py install for mozrunner 05:54:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:04 INFO - Running setup.py install for mozscreenshot 05:54:04 INFO - Running setup.py install for moztest 05:54:04 INFO - Running setup.py install for mozversion 05:54:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:04 INFO - Cleaning up... 05:54:04 INFO - Return code: 0 05:54:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54: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')]} 05:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54: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')]} 05:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:04 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 0x1d053b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080840>, '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 0x2081740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081bd0>, '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': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:54:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:54:04 INFO - Using env: {'DISPLAY': ':0', 05:54:04 INFO - 'HOME': '/home/cltbld', 05:54:04 INFO - 'LANG': 'en_US.UTF-8', 05:54:04 INFO - 'LANGUAGE': 'en_US:en', 05:54:04 INFO - 'LOGNAME': 'cltbld', 05:54:04 INFO - 'MAIL': '/var/mail/cltbld', 05:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:04 INFO - 'MOZ_NO_REMOTE': '1', 05:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:04 INFO - 'NO_EM_RESTART': '1', 05:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:04 INFO - 'PWD': '/builds/slave/test', 05:54:04 INFO - 'SHELL': '/bin/bash', 05:54:04 INFO - 'SHLVL': '1', 05:54:04 INFO - 'TERM': 'linux', 05:54:04 INFO - 'TMOUT': '86400', 05:54:04 INFO - 'USER': 'cltbld', 05:54:04 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 05:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:04 INFO - '_': '/tools/buildbot/bin/python'} 05:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:04 INFO - Running setup.py (path:/tmp/pip-NKpMdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:04 INFO - Running setup.py (path:/tmp/pip-ud6f0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:04 INFO - Running setup.py (path:/tmp/pip-2Ou_79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:04 INFO - Running setup.py (path:/tmp/pip-daSUAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:04 INFO - Running setup.py (path:/tmp/pip-A4pqeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:04 INFO - Running setup.py (path:/tmp/pip-dztCmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:04 INFO - Running setup.py (path:/tmp/pip-1d0Pb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:05 INFO - Running setup.py (path:/tmp/pip-aNhH8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:05 INFO - Running setup.py (path:/tmp/pip-UY23Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:05 INFO - Running setup.py (path:/tmp/pip-y14jA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:05 INFO - Running setup.py (path:/tmp/pip-FwYVoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:05 INFO - Running setup.py (path:/tmp/pip-mMXAWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:05 INFO - Running setup.py (path:/tmp/pip-jpn1_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:05 INFO - Running setup.py (path:/tmp/pip-QePYzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:05 INFO - Running setup.py (path:/tmp/pip-NudKdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:05 INFO - Running setup.py (path:/tmp/pip-hxTrau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:05 INFO - Running setup.py (path:/tmp/pip-regzlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:06 INFO - Downloading blessings-1.6.tar.gz 05:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:54:06 INFO - Installing collected packages: blessings 05:54:06 INFO - Running setup.py install for blessings 05:54:07 INFO - Successfully installed blessings 05:54:07 INFO - Cleaning up... 05:54:07 INFO - Return code: 0 05:54:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:54:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:07 INFO - Reading from file tmpfile_stdout 05:54:07 INFO - Current package versions: 05:54:07 INFO - argparse == 1.2.1 05:54:07 INFO - blessings == 1.6 05:54:07 INFO - blobuploader == 1.2.4 05:54:07 INFO - docopt == 0.6.1 05:54:07 INFO - functools32 == 3.2.3-2 05:54:07 INFO - jsonschema == 2.5.1 05:54:07 INFO - manifestparser == 1.1 05:54:07 INFO - mozInstall == 1.12 05:54:07 INFO - mozcrash == 1.0 05:54:07 INFO - mozdebug == 0.1 05:54:07 INFO - mozdevice == 0.51 05:54:07 INFO - mozfile == 1.2 05:54:07 INFO - mozhttpd == 0.7 05:54:07 INFO - mozinfo == 0.9 05:54:07 INFO - mozleak == 0.1 05:54:07 INFO - mozlog == 3.4 05:54:07 INFO - moznetwork == 0.27 05:54:07 INFO - mozprocess == 0.25 05:54:07 INFO - mozprofile == 0.28 05:54:07 INFO - mozrunner == 6.13 05:54:07 INFO - mozscreenshot == 0.1 05:54:07 INFO - mozsystemmonitor == 0.3 05:54:07 INFO - moztest == 0.8 05:54:07 INFO - mozversion == 1.4 05:54:07 INFO - psutil == 3.1.1 05:54:07 INFO - requests == 1.2.3 05:54:07 INFO - wsgiref == 0.1.2 05:54:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:07 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 0x1d053b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080840>, '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 0x2081740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081bd0>, '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': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:54:07 INFO - Using env: {'DISPLAY': ':0', 05:54:07 INFO - 'HOME': '/home/cltbld', 05:54:07 INFO - 'LANG': 'en_US.UTF-8', 05:54:07 INFO - 'LANGUAGE': 'en_US:en', 05:54:07 INFO - 'LOGNAME': 'cltbld', 05:54:07 INFO - 'MAIL': '/var/mail/cltbld', 05:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:07 INFO - 'MOZ_NO_REMOTE': '1', 05:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:07 INFO - 'NO_EM_RESTART': '1', 05:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:07 INFO - 'PWD': '/builds/slave/test', 05:54:07 INFO - 'SHELL': '/bin/bash', 05:54:07 INFO - 'SHLVL': '1', 05:54:07 INFO - 'TERM': 'linux', 05:54:07 INFO - 'TMOUT': '86400', 05:54:07 INFO - 'USER': 'cltbld', 05:54:07 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 05:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:07 INFO - '_': '/tools/buildbot/bin/python'} 05:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:54:07 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:08 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:54:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:54:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:54:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:54:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:54:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:54:08 INFO - Installing collected packages: marionette-driver 05:54:08 INFO - Running setup.py install for marionette-driver 05:54:08 INFO - Successfully installed marionette-driver 05:54:08 INFO - Cleaning up... 05:54:08 INFO - Return code: 0 05:54:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:08 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 0x1d053b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080840>, '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 0x2081740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081bd0>, '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': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:54:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:54:08 INFO - Using env: {'DISPLAY': ':0', 05:54:08 INFO - 'HOME': '/home/cltbld', 05:54:08 INFO - 'LANG': 'en_US.UTF-8', 05:54:08 INFO - 'LANGUAGE': 'en_US:en', 05:54:08 INFO - 'LOGNAME': 'cltbld', 05:54:08 INFO - 'MAIL': '/var/mail/cltbld', 05:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:08 INFO - 'MOZ_NO_REMOTE': '1', 05:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:08 INFO - 'NO_EM_RESTART': '1', 05:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:08 INFO - 'PWD': '/builds/slave/test', 05:54:08 INFO - 'SHELL': '/bin/bash', 05:54:08 INFO - 'SHLVL': '1', 05:54:08 INFO - 'TERM': 'linux', 05:54:08 INFO - 'TMOUT': '86400', 05:54:08 INFO - 'USER': 'cltbld', 05:54:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 05:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:08 INFO - '_': '/tools/buildbot/bin/python'} 05:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:54:09 INFO - Cleaning up... 05:54:09 INFO - Return code: 0 05:54:09 INFO - Running post-action listener: _resource_record_post_action 05:54:09 INFO - Running post-action listener: _start_resource_monitoring 05:54:09 INFO - Starting resource monitoring. 05:54:09 INFO - [mozharness: 2017-06-02 12:54:09.130565Z] Finished create-virtualenv step (success) 05:54:09 INFO - [mozharness: 2017-06-02 12:54:09.131038Z] Running install step. 05:54:09 INFO - Running pre-action listener: _resource_record_pre_action 05:54:09 INFO - Running main action method: install 05:54:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:09 INFO - Reading from file tmpfile_stdout 05:54:09 INFO - Detecting whether we're running mozinstall >=1.0... 05:54:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:54:09 INFO - Reading from file tmpfile_stdout 05:54:09 INFO - Output received: 05:54:09 INFO - Usage: mozinstall [options] installer 05:54:09 INFO - Options: 05:54:09 INFO - -h, --help show this help message and exit 05:54:09 INFO - -d DEST, --destination=DEST 05:54:09 INFO - Directory to install application into. [default: 05:54:09 INFO - "/builds/slave/test"] 05:54:09 INFO - --app=APP Application being installed. [default: firefox] 05:54:09 INFO - mkdir: /builds/slave/test/build/application 05:54:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:54:26 INFO - Reading from file tmpfile_stdout 05:54:26 INFO - Output received: 05:54:26 INFO - /builds/slave/test/build/application/firefox/firefox 05:54:26 INFO - Running post-action listener: _resource_record_post_action 05:54:26 INFO - [mozharness: 2017-06-02 12:54:26.390216Z] Finished install step (success) 05:54:26 INFO - [mozharness: 2017-06-02 12:54:26.390493Z] Running setup-mitmproxy step. 05:54:26 INFO - Running pre-action listener: _resource_record_pre_action 05:54:26 INFO - Running main action method: setup_mitmproxy 05:54:26 INFO - Skipping: mitmproxy is not required 05:54:26 INFO - Running post-action listener: _resource_record_post_action 05:54:26 INFO - [mozharness: 2017-06-02 12:54:26.391630Z] Finished setup-mitmproxy step (success) 05:54:26 INFO - [mozharness: 2017-06-02 12:54:26.391851Z] Running run-tests step. 05:54:26 INFO - Running pre-action listener: _resource_record_pre_action 05:54:26 INFO - Running main action method: run_tests 05:54:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:54:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:54:26 INFO - Python 2.7.3 05:54:26 INFO - Return code: 0 05:54:26 INFO - grabbing minidump binary from tooltool 05:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:26 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 0x2080840>, '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 0x2081740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:54:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:54:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:54:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:54:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:54:26 INFO - Return code: 0 05:54:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:54:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:54:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:54:26 INFO - ENV: RUST_BACKTRACE is now 1 05:54:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:54:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:54:26 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/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:54:26 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/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:54:26 INFO - Using env: {'DISPLAY': ':0', 05:54:26 INFO - 'HOME': '/home/cltbld', 05:54:26 INFO - 'LANG': 'en_US.UTF-8', 05:54:26 INFO - 'LANGUAGE': 'en_US:en', 05:54:26 INFO - 'LOGNAME': 'cltbld', 05:54:26 INFO - 'MAIL': '/var/mail/cltbld', 05:54:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:54:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:26 INFO - 'MOZ_NO_REMOTE': '1', 05:54:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:54:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:26 INFO - 'NO_EM_RESTART': '1', 05:54:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:26 INFO - 'PWD': '/builds/slave/test', 05:54:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:54:26 INFO - 'RUST_BACKTRACE': '1', 05:54:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:54:26 INFO - 'SHELL': '/bin/bash', 05:54:26 INFO - 'SHLVL': '1', 05:54:26 INFO - 'TERM': 'linux', 05:54:26 INFO - 'TMOUT': '86400', 05:54:26 INFO - 'USER': 'cltbld', 05:54:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448', 05:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:26 INFO - '_': '/tools/buildbot/bin/python'} 05:54:26 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/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:54:26 INFO - mozversion application_buildid: 20170602121725 05:54:26 INFO - mozversion application_changeset: 194c009d6295597344662f8e20f5e309deffe8e9 05:54:26 INFO - mozversion application_display_name: Nightly 05:54:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:54:26 INFO - mozversion application_name: Firefox 05:54:26 INFO - mozversion application_remotingname: firefox 05:54:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:54:26 INFO - mozversion application_vendor: Mozilla 05:54:26 INFO - mozversion application_version: 55.0a1 05:54:26 INFO - mozversion platform_buildid: 20170602121725 05:54:26 INFO - mozversion platform_changeset: 194c009d6295597344662f8e20f5e309deffe8e9 05:54:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:54:26 INFO - mozversion platform_version: 55.0a1 05:54:26 INFO - using testdate: 1496408066 05:54:26 INFO - actual date: 1496408066 05:54:26 INFO - starting webserver on 'localhost:46342' 05:54:26 INFO - SUITE-START | Running 2 tests 05:54:26 INFO - TEST-START | dromaeo_css 05:54:26 INFO - operating with platform_type : linux_ 05:54:26 INFO - Initialising browser for dromaeo_css test... 05:54:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46342/getInfo.html -profile /tmp/tmppJ6qCX/profile 05:54:26 INFO - TEST-INFO | started process 19148 (/builds/slave/test/build/application/firefox/firefox http://localhost:46342/getInfo.html) 05:55:01 INFO - TEST-INFO | 19148: killed by SIGTERM 05:55:01 INFO - Browser initialized. 05:55:01 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:01 INFO - TEST-INFO | started process 19355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppJ6qCX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:13 INFO - PID 19355 | RSS: Main: 188178432 05:55:13 INFO - PID 19355 | 05:58:14 INFO - PID 19355 | Cycle 1(1): loaded http://localhost:46342/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46342/tests/dromaeo/cssquery-ext.html) 05:58:15 INFO - PID 19355 | RSS: Main: 185192448 05:58:15 INFO - PID 19355 | 06:01:17 INFO - PID 19355 | Cycle 1(1): loaded http://localhost:46342/tests/dromaeo/cssquery-ext.html (next: http://localhost:46342/tests/dromaeo/cssquery-jquery.html) 06:01:18 INFO - PID 19355 | RSS: Main: 188915712 06:01:18 INFO - PID 19355 | 06:04:20 INFO - PID 19355 | Cycle 1(1): loaded http://localhost:46342/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46342/tests/dromaeo/cssquery-mootools.html) 06:04:20 INFO - PID 19355 | RSS: Main: 185835520 06:04:20 INFO - PID 19355 | 06:07:22 INFO - PID 19355 | Cycle 1(1): loaded http://localhost:46342/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46342/tests/dromaeo/cssquery-prototype.html) 06:07:23 INFO - PID 19355 | RSS: Main: 190136320 06:07:23 INFO - PID 19355 | 06:10:26 INFO - PID 19355 | Cycle 1(1): loaded http://localhost:46342/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46342/tests/dromaeo/cssquery-yui.html) 06:10:26 INFO - PID 19355 | RSS: Main: 188407808 06:10:26 INFO - PID 19355 | 06:13:28 INFO - PID 19355 | Cycle 1(1): loaded http://localhost:46342/tests/dromaeo/cssquery-yui.html (next: http://localhost:46342/tests/dromaeo/cssquery-dojo.html) 06:13:28 INFO - PID 19355 | RSS: Main: 188186624 06:13:28 INFO - PID 19355 | 06:13:28 INFO - PID 19355 | __start_tp_report 06:13:28 INFO - PID 19355 | _x_x_mozilla_page_load 06:13:28 INFO - PID 19355 | _x_x_mozilla_page_load_details 06:13:28 INFO - PID 19355 | |i|pagename|runs| 06:13:28 INFO - PID 19355 | |0;dojo.html;3098.349346637206;3098.8140711557307;3118.3139709263955;3129.108204161813;3134.388794185134;5804.709764511778;5899.764009439617;5929.229200203973;5938.346781853998;5957.285125784906;5861.970690146554;5910.438508341711;5925.288965324156;6005.279366476029;6028.4574388305155;5337.70642614656;5401.405845357027;5406.972965135169;5423.620346575751;5446.891062178754;5501.174823776426;5539.169124631298;5551.278333816598;5565.860853478655;5609.298837645294;5381.730913454312;5410.08028635129;5452.236686863842;5457.481539253785;5485.259489968843;5482.862928426782;5483.150111732688;5492.093804522249;5561.443855614447;5561.4716601922755;5419.051665958442;5457.781688732446;5468.890622187574;5471.206675032138;5473.616846820724;5768.134779783024;5829.766809327664;5894.440028197314;5909.881802363929;5929.762809487615;6289.7169627366875;6396.872062558769;6398.072279519443;6426.775062872777;6429.742810287583;6391.77628782995;6393.93606063938;6409.551331406803;6417.743290268384;6443.5167362448;5844.094165404369;5914.053751399755;5923.259592550931;5938.7624495020145;5962.135490353874;6386.680665966683;6423.0686550450855;6499.642519661464;6519.152510173742;6551.8362040948405;6138.877222455526;6140.324564297924;6173.382661733791;6290.496760259169;6310;6370.0763389308295;6384.904226436607;6386.233651961701;6395.5203359747275;6435.22777266731;6390.552661313756;6403.711832967434;6410.61536307823;6412.7114279857515;6425.100485931974;6157.692115394212;6236.906446403307;6309.053641953744;6373.458256048195;6378.45783108441;5169.638125331191;5179.171332586768;5182.455842136521;5183.948160518346;5217.478252174828;4423.734575925455;4424.159409712209;4440.977795111068;4475.1273501666865;4478.373027776114;5461;5480.287562616834;5543.2793736814765;5543.891221755665;5641.153826925994;6302.936970630235;6312.747490100436;6329;6332.620042797447;6398.912184928573;5536.252605898233;5538.806141785019;5549.611527193058;5557.694326812064;5602.2717046783655;5514.172874068841;5544.251526043932;5590.692511911802;5613.298337707786;5617.101263797773;6120.782376608313;6122.123717501779;6127.234095738033;6177.104319873683;6182.1345011698395;6391.296957334596;6393.520485963664;6395.456386207225;6399.488040956619;6404.743810247538;6110.69446527663;6160.9383906160365;6177.722002509808;6180.505559555315;6186.257649082139;6073.089036644362;6114.844865410725;6130;6180.320164781961;6284.874302514016;6392.328805475544;6444.9355506444335;6464.997925321582;6492.577982431127;6512.348765123639;6007.219061521974;6127.693615319127;6150;6235.095911092957;6276.780312689034;6232.220972378453;6249.0626406039455;6251.937480625317;6258.123862659322;6267.874642507216;5988.790392336422;6184.226971628546;6184.628922264678;6198.411150940653;6209.130721699056;6130.0312685453755;6143.481172719164;6202.317745048132;6209.068639704081;6228.128062071404;6079.452849243589;6080.118382834553;6094.11635312886;6110.205673262448;6119.082137679384 06:13:28 INFO - PID 19355 | |1;ext.html;669.4978765925556;714.3142583120205;740.422470473031;1130.7229728716466;1139.93730344831;35846;36484.63515364846;36750.63249367509;36793.81603091981;36818.4477232841;38995;39057;39308.41037384442;39465.40801887974;39466;7269.854602907939;7356.668949897241;7428.777136685908;7526.6236688165645;7530.58581778002;7400.074990626172;7425.10898692155;7487.925120748777;7499.73750918718;7504.474686771928;7476.401887848959;7477.700891964315;7517.36102431294;7524.247575242487;7539.509931854412;7473.364763995067;7492.625368731542;7503.174650788382;7512;7515;7328.706851725925;7333.1200255969625;7355.190928997806;7365;7394.2975417335265;35438.64561354379;35472;35546.28907421863;35589.64410355915;35736.28527429463;3462.4286992646184;3483.372992861284;3505.3515099706638;3506.2461570762407;3527.9823600882087;28682.426351472855;28758;28815.85592072047;28851;28894.71105288941;3639.5268615080136;3662.468942003421;3671.687906527948;3673.797941113238;3674.926501469956;164587;165247;167009;174857;183326.08336958362;43059.35410968838;43293;43305.566944330785;43311.13377732428;43311.783441082596;44111.33832992508;44946.46017256711;45050.54949450529;45494;45503.77248113805;15176;15471.149086800335;15494.457693980656;15503.14732689713;15503.379864805507;12386.75226495465;12543.56097536582;12581.182223155649;12594.307313097868;12686.619401417787;14213.928930355489;14281.928590356982;14329.211893345757;14356.569302920929;14492.275386230645;5780.971095144581;5873.442023007808;5908.202392676933;5966.940330596639;6004.42957918997;996.6611352140308;1026.897310268982;1036.1192985962023;1037.1702637889657;1046.199657262195;22707.545849082926;24252;24301.39246518851;24424.464380157853;24476.14333498319;1115.3642423818346;1121.697141771717;1132.1395739238073;1153.146671463128;1153.371412580146;12336.876631233572;12991.870081299256;13187.340632968313;13189.670258243428;13213.753661877505;211975;212222;212553;213072;213692;47285.29072063922;47611.81046463938;47763.76118119387;48124.27813582799;48246.758766205945;1406.528812847687;1466.0397439676815;1467.801846750675;1475.7933889255512;1489.5531340597995;20667.276645317343;22313;23580.17469388563;23608.22268437042;23674.881625591763;34871;34911.47632785561;35105;35148.82425587958;35159.64840351666;171909;172621;172803;172950;173277;34302.65697342995;34558.65441345655;34583.13542161466;34742.65257347394;34802;41455;41729.37405938974;43262;43436.348454772575;43518.56481435145;29833.55249671213;30985;31029.68970310268;32120;33036.834815825765;30495.48316452284;30623.693763062085;31615.841920790248;32818;33103;36206;36235.09412264715;36382.8180859094;36400.81799591091;36432.63567364292;30297.697023029486;31115.53326700056;31639.367212656078;31945.201369965936;32103.518447223778;23130.884345578837;24593.877030615447;25101.74898251067;25258;25566 06:13:28 INFO - PID 19355 | |2;jquery.html;406.21600311399004;419.6936236547322;426.32214778502185;435.649302311639;437.6498800959232;14632.707345853076;15368.846311536881;20213.59572808545;21030.579388412243;21123.894380528094;21262.255821046267;22039.228626998058;22139.446513837163;22162.22432214873;22212.11151553936;5816.651000939946;5934.792282270121;6007.15899774032;6008.068749343837;6008.279006519224;5851.093080572518;5938;5963.254593175853;5963.463288304052;5969.253843269591;5625.80309689161;5872.882542349172;5881;5927.347991720929;5938.406159384049;5797;5804.129380592903;5811.302643682764;5824.068149096145;5855.443732845373;5253.737313134328;5257.263983042377;5259.737013149327;5270.183121616155;5276.736163191864;24811.379715507257;24852.50294994108;25012.124575639766;25034.24897253085;25132;1872.7284543741082;1884.6984482482737;1890.4423195157462;1894.1097684088456;1912.6557219700449;15804.604884877856;16750.74873876893;16945.57636059096;16951.745723814154;16955.406560770312;2231.308294428732;2250.6173950428465;2268.3421807675754;2278.624027035537;2298.9425264368356;108426;112191;112856.43571782089;113063;113356.4332178342;10825.945870270756;10887.346759194474;11043.558257669603;11043.779124417466;11487.827682584768;16634.25145868439;16709;16718.916405417895;16784.244708988124;16878.156092195342;8805.647774089093;8976.506292153994;8994.325425592975;8999.77500562478;9114.088591140833;8516.574171291411;8561.357898157663;8655.412631305293;8736.519491427905;8742.650293988168;7486.513376630611;7533.7363192288;7647.655855486517;7704.6532906019365;7753.6123193840085;2135.338045205991;2137.1558234497597;2143.785621437844;2151.3438401287444;2245.809106225989;930.7068273493828;969.8496733006396;981.2689546288061;1005.5726316315537;1018.2363227579316;18696.158672859754;18824.717629235573;19495.805041949683;19728.70406943897;20026.499337516678;999.7702825524646;1008.2841182760322;1009.5911155981839;1014.1633152649094;1017.3692310767372;10412.68761937143;10600.204984626183;10855.402952837512;10862.72843178911;10906;418185;424634;428612;430153;432094;98031.50984245034;100655;103905;108097.4595127035;109285;1040.7346126737634;1048.6696690542456;1088.9237753357188;1100.9669709908715;1119.2668801934747;18686.626267474847;19171.61656766829;19583.510412239808;19918.800811992274;20159.193632254544;50743.74628126836;50901.23648145355;51083.48916510787;51611.48388516067;52315;64169;64456.033159501705;64552;64978;65606;9871.50642467888;10022.398656080659;10022.699319020441;10089.29374943747;10097;16188.595285117495;16848.831511685217;17682.115894205497;17791.288348465918;17878.781819272655;13539.729205416033;13816.585502434944;14647.92676036613;14658.633534161305;15175.089494630358;12869.935650322062;13043.869561304266;13239.933800330937;13524.39140238672;13672.726545469233;14929.253537322873;14929.402823886923;15091.169985650895;15244.466443674419;15272.541823745305;10151.086402223835;10254.846177307496;10262.43556604394;10266.948665256627;10282.383057016603;14072.155670659793;14339.856601433852;14673.899457540514;14742.557723268319;14767 06:13:28 INFO - PID 19355 | |3;mootools.html;1259.8677138900416;1322.6891680455085;1325.7348530293943;1331.7070244546203;1334.8197993270905;10443.582256709731;10923.180761442884;10937.671869843898;10937.890621093788;11249.775004499905;10596.470176491164;10773.56905723772;10786.56853725852;10794.406307653077;10825.404602746847;2325.720913490379;2365.905363785455;2370.8221883358733;2380.821438392119;2381.226101517005;2281.9885900570557;2328.906843726249;2350.9882450587725;2368.2066507719846;2386.0932845518764;2338.088145623208;2338.4504641409253;2347.95304093918;2358.8584684918874;2366.065404165354;2279.3959600705825;2306.688597039395;2311.1910831209025;2313.1903833658084;2317.733460652021;2244.1920908472935;2261.366817291161;2273.795358417734;2275.863448193097;2279.988600057006;10465.110465610433;10694.144468442506;10721.624743133953;10727.302725322828;10748.140148788156;5917.378675239124;6088.360722124157;6104.908426373608;6114.96942515289;6129.111278864584;3705.3886108792017;3778.9433158502643;3830.71269654777;3905.9218815623813;3921.0393453603765;1304.712963148106;1311.8819306262387;1328.7940369242783;1351.621545967121;1355.1868878672817;15463.458778942795;15829.841701583067;15937.760933586005;16016.439424620083;16076.356945722157;5031.924521132113;5062.898742025139;5101.9744901276;5125.359330083739;5146.330976972969;11307.604233851776;11379.886201137882;11399.544018239343;11409.48657310423;11421.9440500709;6050.42520960508;6136.355682653347;6142.969285153546;6147.877042459126;6156.076588511759;5700.486956173964;5740.741666625012;5745.109508026263;5759.078547432475;5824.883502330014;4042.1509284636154;4151.958480415157;4179.1432756284885;4205.495340559152;4259.680523960716;1128.8645362556547;1133.8866113388594;1137.8122609769296;1148.609472779259;1161.7502237018912;805.7663277649416;818.0878320672407;822.839546288468;826.4958375391006;862.5256109140073;5985.610935289193;6005.279366475964;6005.309389420186;6178.845528861814;6315.115883776275;592.4786188154396;597.5040716205539;607.298570151467;614.7510258345377;616.8581226317972;3813.1420430402936;3982.6216509431556;4280.828766849353;4479.462464504215;4511.796969136397;13090.541831035867;13742.65643358904;13809.723805524034;13867.583972480841;14008.579742607739;13233.206007639572;13633.522826701017;13789.51736689211;13916.721665566834;13921.512747054006;7570.129435115033;7835.3731701464885;8617.698380556776;8777.824443511094;8824.955875220583;6607.7356905725155;6619.536632435684;6640.800775976729;6764.797056088325;6879;12429.813552796535;12541.122121451412;12615.369231538203;12726.363681816058;12806.231626102464;12580.245185288912;12806.807897881354;12981.4158362872;12982.805257921327;13024.088313817942;9708.85436718464;9712.417254964725;9905.257105717244;9910.75223119399;9912.950435247778;9726.513674316115;9859.901400986186;9870;9895.604175833174;9925.65260215889;8239.35008531877;8263.462874913112;8416.915830841614;8476.321894248322;8622.82754344922;8121.228483294078;8183.058948220792;8280.668773249003;8323.583820809057;8344.791380215544;7573.734919278019;7676.961615191888;7707.152213256425;7718.6140692964;7742.92257077422;5689.118186681071;5741.741621626953;5763.5965482417505;5832.591718579659;6062.120992455981;5715.8571035724435;5726.112452569859;5789.623674461147;5862.296524417097;5966.164736936919 06:13:28 INFO - PID 19355 | |4;prototype.html;388.90471834400574;390.19814281651196;390.9784961827098;398.4322340664553;399.3251405125338;6014;6081.935661259278;6117.724702388392;6154.138420621117;6189.876202475948;5815.331236907757;5913.881722365551;5945.643261404308;5956.731947062382;6003.1895694081395;4612.884677883063;4724.149653062439;4746.76266186691;4754.857354279377;4781.3545171401765;4767.094252092109;4773.57037866592;4773.856784296477;4781.760911954389;4793.400824896888;4719.07977944301;4723.74019428933;4738.90522189556;4760.547747963938;4761;4740.478547359788;4745.559469384703;4768.260919557474;4769;4771.141194584973;4147.854825081138;4153.584641535853;4158.459400277945;4161.396597493377;4169.687273454473;5924.881502369928;5951.940480595182;5954.46409823118;5979.133025711248;5991.400859914017;5394.946050539484;5415.048798404879;5424.294841670597;5424.701641409721;5436.782528698847;6426.839329016765;6428.967855160741;6440.967795161041;6459.483241340681;6461.547691661585;4541;4541.8410355637725;4556.3393307970155;4558.293464513005;4563.224251877189;6406.359364063556;6658.800235992928;6750.257471678112;6821.249662537117;6854.629074185183;4385.144896745168;4538.205813982606;4541.977290113528;4559.586528176276;4559.908801824011;4634.026854360554;4640.141573808856;4661.184292748755;4663.414439090726;4670;5206.219067139959;5311.52196302327;5323.1216849219445;5335.359756829205;5341.252224688546;6321.3678632137335;6349.365063493706;6351.777687780906;6358.205224346957;6379.521535884827;1593.0998985573115;1607.638281386702;1608.340580362046;1616.4908053962963;1617.7088124137533;1060.2578195263347;1074.4090750087578;1096.0519150934545;1098.3080659184823;1104.315324498816;5669.319681638147;5674.233978412862;5679.119736440858;5766.884662306814;5768.278965129359;6478.352164783484;6510.869782604416;6519.478441724651;6560.671966401661;6573.276939536647;5641.323041235078;5678.517326027251;5695.515881150149;5706.3722990471015;5729.054705973551;3489.180042689966;3509.4207606576633;3524.718022558189;3530.805805680661;3543.875964341236;6394.712237949303;6401.471418789552;6420.871582568322;6432.903506447407;6452.1289625900845;6699.196096468455;6752.63962281116;6755.8177318969965;6780.796576102626;6802.3537763912345;6350.2055947759145;6365.299817020032;6414.61512309263;6458.12815269942;6489.935100649028;6595.373439523238;6617.172853393326;6625.668716564249;6643.734250629921;6671.633060181736;6572.277049524453;6588.301119531667;6614.305497922841;6653.168353955755;6676.132102826601;5896.8820623586425;6447.709853056717;6506.048185544223;6521.597921403129;6532.902006469812;4577.832652673547;4589.403377560896;4591;4605.700629459075;4628.39830821991;6645.903425934666;6677.2655007948115;6678.666066696548;6692.130023096966;6697.899531506934;6262.843428914313;6427.485801135805;6433.163688720437;6483.997282934325;6518.608883467007;6453.063855945627;6500.219973603198;6500.837479063061;6501.349865013461;6518.706658200487;6425.710843012169;6426.678666066771;6427.389398007182;6444.806655800334;6448.968165093563;6470.288268290578;6493.928501797151;6502.382273683992;6503.2846386898345;6513.413792758674;6261.373862613702;6282.717277722422;6312.936870631419;6321.557490975588;6362.109304697438 06:13:28 INFO - PID 19355 | |5;yui.html;820.4011071917496;838.7022606974525;846.8137009857829;856.3577317012241;860.3461369359289;17226.655466890654;17543.912280438613;17558.73661895071;17737.556561085978;18773.43679689608;17267.654646907053;17429.302827886902;17491.737623935653;17578.736318955194;17607.383741569014;971.3103696375564;994.2294721590753;1002.6390499420203;1005.3465247589053;1011.989880101197;987.8073775613758;993.2054356514795;1011.1506334678868;1014.90865822076;1023.7952409518089;1072.7103682005854;1073.2969904712427;1073.7423018475588;1074.591655171038;1076.0208210528422;1061.6125114333252;1061.7451811565206;1062.0706881478707;1062.6865074802952;1070.1813112968507;773.5436092705331;775.1008829757454;783.6747749683874;785.3442375616368;786.4887822915093;15836.28736706851;15871.761923571155;15891.60270993223;15940.840591594051;16295.103769292684;17823.376181833573;18096;18096;18135.274589016422;18312.450626481226;14274.143551386846;14480.203588802611;14590.781138282828;14609.634759131;14637.048591841496;3380;3407.216340241758;3418.0429479745712;3424.092615456906;3437.535932649085;83787.5810620949;83961;84706;85275.57362213211;85576.99999999937;12443.37783110859;12538.185017973803;12618.116731828868;12871.935640321739;12969.481220751064;23125.653115203284;23433.179838705564;23434.882825585762;23478;23703.40741481442;7988.400869934778;8023.879641805378;8265.710700125466;8289.336853051742;8308.210719981593;3992.5608183099835;4066.3290557058344;4073.06319546506;4080.224757296104;4104.035551645361;4073.0835561998315;4185.414042034056;4187.958120418757;4215.178040282177;4342.544032876503;761.3300295739714;771.6720393832599;775.0312109862672;786.7875673568104;788.3417346515723;664.5348256220665;690.9170899492093;692.1140939597324;708.4828075504807;709.1915216653019;11451;12142.271463712206;12259.938700306442;12420.695826938221;12513.3743312834;687.8889848426242;694.0803435448051;694.4305669351083;701.1761180612759;704.6371118873784;5152.351247600732;5322.467753224647;5451.781928722886;5473.75368108436;5533.557315414757;93039.53480232555;93059;93403.53298233465;96555.51722241344;97935;81747;81748.59125704333;82554.58722706468;82692.58653706813;83257;63383;70915.64542177255;71242.2875771246;71601.28398715946;74870;11352.148588856035;11734.94132529332;12143.33211673331;12211.389430528616;12232.87767122353;28122.71877281201;28355.291117721397;28507.144785656463;28773.568396473653;29896.551551726305;36183.63816361803;36596.63403365932;36748.81625591855;37705.43441848429;55456.44543554674;16741.24664390081;16937.407190748265;16972.66054678924;16976.490705278862;17057.14714264257;18737.531561711065;18755.156017979498;18840.246390144788;19081.236750530377;19088.045597720335;16981.23584438728;17244.482665520056;17267.481975540755;17404.12979351053;17595.736063958793;16105.436309729103;16889.831101689317;17056;17251.309947602458;17468.82531174672;16019.759703604223;16372.426965056165;16796.664066718353;16937.153142342588;17043.829561704224;11453.713657158638;11782.764344712887;11860.347680877634;11921.284722916653;12194.634160975185;12889.935550322189;13715.519956801463;14220.928895355457;14648.414063437343;14692.191929443556 06:13:28 INFO - PID 19355 | __end_tp_report 06:13:28 INFO - PID 19355 | __start_cc_report 06:13:28 INFO - PID 19355 | _x_x_mozilla_cycle_collect,361 06:13:28 INFO - PID 19355 | __end_cc_report 06:13:28 INFO - PID 19355 | __startTimestamp1496409208722__endTimestamp 06:13:28 INFO - PID 19355 | 06:13:28 INFO - PID 19355 | ------- Summary: start ------- 06:13:28 INFO - PID 19355 | Number of tests: 6 06:13:28 INFO - PID 19355 | 06:13:28 INFO - PID 19355 | [#0] dojo.html Cycles:165 Average:5863.76 Median:6110.69 stddev:666.83 (10.9%) stddev-sans-first:632.61 06:13:28 INFO - PID 19355 | Values: 3098.3 3098.8 3118.3 3129.1 3134.4 5804.7 5899.8 5929.2 5938.3 5957.3 5862.0 5910.4 5925.3 6005.3 6028.5 5337.7 5401.4 5407.0 5423.6 5446.9 5501.2 5539.2 5551.3 5565.9 5609.3 5381.7 5410.1 5452.2 5457.5 5485.3 5482.9 5483.2 5492.1 5561.4 5561.5 5419.1 5457.8 5468.9 5471.2 5473.6 5768.1 5829.8 5894.4 5909.9 5929.8 6289.7 6396.9 6398.1 6426.8 6429.7 6391.8 6393.9 6409.6 6417.7 6443.5 5844.1 5914.1 5923.3 5938.8 5962.1 6386.7 6423.1 6499.6 6519.2 6551.8 6138.9 6140.3 6173.4 6290.5 6310.0 6370.1 6384.9 6386.2 6395.5 6435.2 6390.6 6403.7 6410.6 6412.7 6425.1 6157.7 6236.9 6309.1 6373.5 6378.5 5169.6 5179.2 5182.5 5183.9 5217.5 4423.7 4424.2 4441.0 4475.1 4478.4 5461.0 5480.3 5543.3 5543.9 5641.2 6302.9 6312.7 6329.0 6332.6 6398.9 5536.3 5538.8 5549.6 5557.7 5602.3 5514.2 5544.3 5590.7 5613.3 5617.1 6120.8 6122.1 6127.2 6177.1 6182.1 6391.3 6393.5 6395.5 6399.5 6404.7 6110.7 6160.9 6177.7 6180.5 6186.3 6073.1 6114.8 6130.0 6180.3 6284.9 6392.3 6444.9 6465.0 6492.6 6512.3 6007.2 6127.7 6150.0 6235.1 6276.8 6232.2 6249.1 6251.9 6258.1 6267.9 5988.8 6184.2 6184.6 6198.4 6209.1 6130.0 6143.5 6202.3 6209.1 6228.1 6079.5 6080.1 6094.1 6110.2 6119.1 06:13:28 INFO - PID 19355 | 06:13:28 INFO - PID 19355 | [#1] ext.html Cycles:180 Average:34931.02 Median:34772.33 stddev:48140.84 (138.4%) stddev-sans-first:48207.15 06:13:28 INFO - PID 19355 | Values: 669.5 714.3 740.4 1130.7 1139.9 35846.0 36484.6 36750.6 36793.8 36818.4 38995.0 39057.0 39308.4 39465.4 39466.0 7269.9 7356.7 7428.8 7526.6 7530.6 7400.1 7425.1 7487.9 7499.7 7504.5 7476.4 7477.7 7517.4 7524.2 7539.5 7473.4 7492.6 7503.2 7512.0 7515.0 7328.7 7333.1 7355.2 7365.0 7394.3 35438.6 35472.0 35546.3 35589.6 35736.3 3462.4 3483.4 3505.4 3506.2 3528.0 28682.4 28758.0 28815.9 28851.0 28894.7 3639.5 3662.5 3671.7 3673.8 3674.9 164587.0 165247.0 167009.0 174857.0 183326.1 43059.4 43293.0 43305.6 43311.1 43311.8 44111.3 44946.5 45050.5 45494.0 45503.8 15176.0 15471.1 15494.5 15503.1 15503.4 12386.8 12543.6 12581.2 12594.3 12686.6 14213.9 14281.9 14329.2 14356.6 14492.3 5781.0 5873.4 5908.2 5966.9 6004.4 996.7 1026.9 1036.1 1037.2 1046.2 22707.5 24252.0 24301.4 24424.5 24476.1 1115.4 1121.7 1132.1 1153.1 1153.4 12336.9 12991.9 13187.3 13189.7 13213.8 211975.0 212222.0 212553.0 213072.0 213692.0 47285.3 47611.8 47763.8 48124.3 48246.8 1406.5 1466.0 1467.8 1475.8 1489.6 20667.3 22313.0 23580.2 23608.2 23674.9 34871.0 34911.5 35105.0 35148.8 35159.6 171909.0 172621.0 172803.0 172950.0 173277.0 34302.7 34558.7 34583.1 34742.7 34802.0 41455.0 41729.4 43262.0 43436.3 43518.6 29833.6 30985.0 31029.7 32120.0 33036.8 30495.5 30623.7 31615.8 32818.0 33103.0 36206.0 36235.1 36382.8 36400.8 36432.6 30297.7 31115.5 31639.4 31945.2 32103.5 23130.9 24593.9 25101.7 25258.0 25566.0 06:13:28 INFO - PID 19355 | 06:13:28 INFO - PID 19355 | [#2] jquery.html Cycles:180 Average:29915.10 Median:20186.39 stddev:71855.82 (356.0%) stddev-sans-first:72023.24 06:13:28 INFO - PID 19355 | Values: 406.2 419.7 426.3 435.6 437.6 14632.7 15368.8 20213.6 21030.6 21123.9 21262.3 22039.2 22139.4 22162.2 22212.1 5816.7 5934.8 6007.2 6008.1 6008.3 5851.1 5938.0 5963.3 5963.5 5969.3 5625.8 5872.9 5881.0 5927.3 5938.4 5797.0 5804.1 5811.3 5824.1 5855.4 5253.7 5257.3 5259.7 5270.2 5276.7 24811.4 24852.5 25012.1 25034.2 25132.0 1872.7 1884.7 1890.4 1894.1 1912.7 15804.6 16750.7 16945.6 16951.7 16955.4 2231.3 2250.6 2268.3 2278.6 2298.9 108426.0 112191.0 112856.4 113063.0 113356.4 10825.9 10887.3 11043.6 11043.8 11487.8 16634.3 16709.0 16718.9 16784.2 16878.2 8805.6 8976.5 8994.3 8999.8 9114.1 8516.6 8561.4 8655.4 8736.5 8742.7 7486.5 7533.7 7647.7 7704.7 7753.6 2135.3 2137.2 2143.8 2151.3 2245.8 930.7 969.8 981.3 1005.6 1018.2 18696.2 18824.7 19495.8 19728.7 20026.5 999.8 1008.3 1009.6 1014.2 1017.4 10412.7 10600.2 10855.4 10862.7 10906.0 418185.0 424634.0 428612.0 430153.0 432094.0 98031.5 100655.0 103905.0 108097.5 109285.0 1040.7 1048.7 1088.9 1101.0 1119.3 18686.6 19171.6 19583.5 19918.8 20159.2 50743.7 50901.2 51083.5 51611.5 52315.0 64169.0 64456.0 64552.0 64978.0 65606.0 9871.5 10022.4 10022.7 10089.3 10097.0 16188.6 16848.8 17682.1 17791.3 17878.8 13539.7 13816.6 14647.9 14658.6 15175.1 12869.9 13043.9 13239.9 13524.4 13672.7 14929.3 14929.4 15091.2 15244.5 15272.5 10151.1 10254.8 10262.4 10266.9 10282.4 14072.2 14339.9 14673.9 14742.6 14767.0 06:13:28 INFO - PID 19355 | 06:13:28 INFO - PID 19355 | [#3] mootools.html Cycles:180 Average:6704.46 Median:3951.83 stddev:4226.48 (106.9%) stddev-sans-first:4218.53 06:13:28 INFO - PID 19355 | Values: 1259.9 1322.7 1325.7 1331.7 1334.8 10443.6 10923.2 10937.7 10937.9 11249.8 10596.5 10773.6 10786.6 10794.4 10825.4 2325.7 2365.9 2370.8 2380.8 2381.2 2282.0 2328.9 2351.0 2368.2 2386.1 2338.1 2338.5 2348.0 2358.9 2366.1 2279.4 2306.7 2311.2 2313.2 2317.7 2244.2 2261.4 2273.8 2275.9 2280.0 10465.1 10694.1 10721.6 10727.3 10748.1 5917.4 6088.4 6104.9 6115.0 6129.1 3705.4 3778.9 3830.7 3905.9 3921.0 1304.7 1311.9 1328.8 1351.6 1355.2 15463.5 15829.8 15937.8 16016.4 16076.4 5031.9 5062.9 5102.0 5125.4 5146.3 11307.6 11379.9 11399.5 11409.5 11421.9 6050.4 6136.4 6143.0 6147.9 6156.1 5700.5 5740.7 5745.1 5759.1 5824.9 4042.2 4152.0 4179.1 4205.5 4259.7 1128.9 1133.9 1137.8 1148.6 1161.8 805.8 818.1 822.8 826.5 862.5 5985.6 6005.3 6005.3 6178.8 6315.1 592.5 597.5 607.3 614.8 616.9 3813.1 3982.6 4280.8 4479.5 4511.8 13090.5 13742.7 13809.7 13867.6 14008.6 13233.2 13633.5 13789.5 13916.7 13921.5 7570.1 7835.4 8617.7 8777.8 8825.0 6607.7 6619.5 6640.8 6764.8 6879.0 12429.8 12541.1 12615.4 12726.4 12806.2 12580.2 12806.8 12981.4 12982.8 13024.1 9708.9 9712.4 9905.3 9910.8 9913.0 9726.5 9859.9 9870.0 9895.6 9925.7 8239.4 8263.5 8416.9 8476.3 8622.8 8121.2 8183.1 8280.7 8323.6 8344.8 7573.7 7677.0 7707.2 7718.6 7742.9 5689.1 5741.7 5763.6 5832.6 6062.1 5715.9 5726.1 5789.6 5862.3 5966.2 06:13:28 INFO - PID 19355 | 06:13:28 INFO - PID 19355 | [#4] prototype.html Cycles:180 Average:5341.66 Median:5953.20 stddev:1573.38 (26.4%) stddev-sans-first:1533.25 06:13:28 INFO - PID 19355 | Values: 388.9 390.2 391.0 398.4 399.3 6014.0 6081.9 6117.7 6154.1 6189.9 5815.3 5913.9 5945.6 5956.7 6003.2 4612.9 4724.1 4746.8 4754.9 4781.4 4767.1 4773.6 4773.9 4781.8 4793.4 4719.1 4723.7 4738.9 4760.5 4761.0 4740.5 4745.6 4768.3 4769.0 4771.1 4147.9 4153.6 4158.5 4161.4 4169.7 5924.9 5951.9 5954.5 5979.1 5991.4 5394.9 5415.0 5424.3 5424.7 5436.8 6426.8 6429.0 6441.0 6459.5 6461.5 4541.0 4541.8 4556.3 4558.3 4563.2 6406.4 6658.8 6750.3 6821.2 6854.6 4385.1 4538.2 4542.0 4559.6 4559.9 4634.0 4640.1 4661.2 4663.4 4670.0 5206.2 5311.5 5323.1 5335.4 5341.3 6321.4 6349.4 6351.8 6358.2 6379.5 1593.1 1607.6 1608.3 1616.5 1617.7 1060.3 1074.4 1096.1 1098.3 1104.3 5669.3 5674.2 5679.1 5766.9 5768.3 6478.4 6510.9 6519.5 6560.7 6573.3 5641.3 5678.5 5695.5 5706.4 5729.1 3489.2 3509.4 3524.7 3530.8 3543.9 6394.7 6401.5 6420.9 6432.9 6452.1 6699.2 6752.6 6755.8 6780.8 6802.4 6350.2 6365.3 6414.6 6458.1 6489.9 6595.4 6617.2 6625.7 6643.7 6671.6 6572.3 6588.3 6614.3 6653.2 6676.1 5896.9 6447.7 6506.0 6521.6 6532.9 4577.8 4589.4 4591.0 4605.7 4628.4 6645.9 6677.3 6678.7 6692.1 6697.9 6262.8 6427.5 6433.2 6484.0 6518.6 6453.1 6500.2 6500.8 6501.3 6518.7 6425.7 6426.7 6427.4 6444.8 6449.0 6470.3 6493.9 6502.4 6503.3 6513.4 6261.4 6282.7 6312.9 6321.6 6362.1 06:13:28 INFO - PID 19355 | 06:13:28 INFO - PID 19355 | [#5] yui.html Cycles:180 Average:19203.90 Median:21106.85 stddev:24550.92 (116.3%) stddev-sans-first:24580.98 06:13:28 INFO - PID 19355 | Values: 820.4 838.7 846.8 856.4 860.3 17226.7 17543.9 17558.7 17737.6 18773.4 17267.7 17429.3 17491.7 17578.7 17607.4 971.3 994.2 1002.6 1005.3 1012.0 987.8 993.2 1011.2 1014.9 1023.8 1072.7 1073.3 1073.7 1074.6 1076.0 1061.6 1061.7 1062.1 1062.7 1070.2 773.5 775.1 783.7 785.3 786.5 15836.3 15871.8 15891.6 15940.8 16295.1 17823.4 18096.0 18096.0 18135.3 18312.5 14274.1 14480.2 14590.8 14609.6 14637.0 3380.0 3407.2 3418.0 3424.1 3437.5 83787.6 83961.0 84706.0 85275.6 85577.0 12443.4 12538.2 12618.1 12871.9 12969.5 23125.7 23433.2 23434.9 23478.0 23703.4 7988.4 8023.9 8265.7 8289.3 8308.2 3992.6 4066.3 4073.1 4080.2 4104.0 4073.1 4185.4 4188.0 4215.2 4342.5 761.3 771.7 775.0 786.8 788.3 664.5 690.9 692.1 708.5 709.2 11451.0 12142.3 12259.9 12420.7 12513.4 687.9 694.1 694.4 701.2 704.6 5152.4 5322.5 5451.8 5473.8 5533.6 93039.5 93059.0 93403.5 96555.5 97935.0 81747.0 81748.6 82554.6 82692.6 83257.0 63383.0 70915.6 71242.3 71601.3 74870.0 11352.1 11734.9 12143.3 12211.4 12232.9 28122.7 28355.3 28507.1 28773.6 29896.6 36183.6 36596.6 36748.8 37705.4 55456.4 16741.2 16937.4 16972.7 16976.5 17057.1 18737.5 18755.2 18840.2 19081.2 19088.0 16981.2 17244.5 17267.5 17404.1 17595.7 16105.4 16889.8 17056.0 17251.3 17468.8 16019.8 16372.4 16796.7 16937.2 17043.8 11453.7 11782.8 11860.3 11921.3 12194.6 12889.9 13715.5 14220.9 14648.4 14692.2 06:13:28 INFO - PID 19355 | -------- Summary: end -------- 06:13:28 INFO - PID 19355 | 06:13:29 INFO - TEST-INFO | 19355: exit 0 06:13:29 INFO - TEST-OK | dromaeo_css | took 1142953ms 06:13:29 INFO - TEST-START | kraken 06:13:29 INFO - operating with platform_type : linux_ 06:13:29 INFO - Initialising browser for kraken test... 06:13:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46342/getInfo.html -profile /tmp/tmpI3Ig8u/profile 06:13:29 INFO - TEST-INFO | started process 19755 (/builds/slave/test/build/application/firefox/firefox http://localhost:46342/getInfo.html) 06:14:04 INFO - TEST-INFO | 19755: killed by SIGTERM 06:14:04 INFO - Browser initialized. 06:14:04 INFO - Running cycle 1/1 for kraken test... 06:14:04 INFO - TEST-INFO | started process 19958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI3Ig8u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:16 INFO - PID 19958 | RSS: Main: 189042688 06:14:16 INFO - PID 19958 | 06:14:19 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46342/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:19 INFO - PID 19958 | RSS: Main: 191623168 06:14:19 INFO - PID 19958 | 06:14:22 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46342/tests/kraken/driver.html?testName=audio-dft) 06:14:23 INFO - PID 19958 | RSS: Main: 190140416 06:14:23 INFO - PID 19958 | 06:14:26 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46342/tests/kraken/driver.html?testName=audio-fft) 06:14:26 INFO - PID 19958 | RSS: Main: 186494976 06:14:26 INFO - PID 19958 | 06:14:28 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46342/tests/kraken/driver.html?testName=audio-oscillator) 06:14:29 INFO - PID 19958 | RSS: Main: 187117568 06:14:29 INFO - PID 19958 | 06:14:31 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46342/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:32 INFO - PID 19958 | RSS: Main: 187416576 06:14:32 INFO - PID 19958 | 06:14:35 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46342/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:35 INFO - PID 19958 | RSS: Main: 188198912 06:14:35 INFO - PID 19958 | 06:14:39 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46342/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:40 INFO - PID 19958 | RSS: Main: 187969536 06:14:40 INFO - PID 19958 | 06:14:42 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46342/tests/kraken/driver.html?testName=json-parse-financial) 06:14:43 INFO - PID 19958 | RSS: Main: 188399616 06:14:43 INFO - PID 19958 | 06:14:45 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46342/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:45 INFO - PID 19958 | RSS: Main: 188579840 06:14:45 INFO - PID 19958 | 06:14:47 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:48 INFO - PID 19958 | RSS: Main: 188375040 06:14:48 INFO - PID 19958 | 06:14:50 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:51 INFO - PID 19958 | RSS: Main: 188280832 06:14:51 INFO - PID 19958 | 06:14:53 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:54 INFO - PID 19958 | RSS: Main: 188817408 06:14:54 INFO - PID 19958 | 06:14:57 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:58 INFO - PID 19958 | RSS: Main: 188563456 06:14:58 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46342/tests/kraken/driver.html?testName=ai-astar) 06:15:00 INFO - PID 19958 | RSS: Main: 189919232 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | __start_tp_report 06:15:00 INFO - PID 19958 | _x_x_mozilla_page_load 06:15:00 INFO - PID 19958 | _x_x_mozilla_page_load_details 06:15:00 INFO - PID 19958 | |i|pagename|runs| 06:15:00 INFO - PID 19958 | |0;ai-astar;103;109;109;109;110;112;110;110;109;111 06:15:00 INFO - PID 19958 | |1;audio-beat-detection;148;126;127;171;131;123;123;120;146;125 06:15:00 INFO - PID 19958 | |2;audio-dft;162;166;165;162;165;166;169;174;167;164 06:15:00 INFO - PID 19958 | |3;audio-fft;73;74;74;118;73;75;73;76;106;73 06:15:00 INFO - PID 19958 | |4;audio-oscillator;83;82;105;82;82;82;97;83;83;107 06:15:00 INFO - PID 19958 | |5;imaging-gaussian-blur;114;113;114;114;119;115;114;113;116;115 06:15:00 INFO - PID 19958 | |6;imaging-darkroom;151;151;150;150;150;151;150;149;150;150 06:15:00 INFO - PID 19958 | |7;imaging-desaturate;94;95;95;94;95;94;94;94;95;95 06:15:00 INFO - PID 19958 | |8;json-parse-financial;55;55;56;56;55;54;55;56;64;55 06:15:00 INFO - PID 19958 | |9;json-stringify-tinderbox;55;55;54;54;56;62;55;56;55;55 06:15:00 INFO - PID 19958 | |10;stanford-crypto-aes;87;87;85;89;95;88;88;95;130;88 06:15:00 INFO - PID 19958 | |11;stanford-crypto-ccm;129;132;140;141;132;145;128;135;130;141 06:15:00 INFO - PID 19958 | |12;stanford-crypto-pbkdf2;190;208;198;195;194;198;196;191;198;201 06:15:00 INFO - PID 19958 | |13;stanford-crypto-sha256-iterative;77;75;75;76;72;73;72;71;71;74 06:15:00 INFO - PID 19958 | __end_tp_report 06:15:00 INFO - PID 19958 | __start_cc_report 06:15:00 INFO - PID 19958 | _x_x_mozilla_cycle_collect,1012 06:15:00 INFO - PID 19958 | __end_cc_report 06:15:00 INFO - PID 19958 | __startTimestamp1496409300309__endTimestamp 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | ------- Summary: start ------- 06:15:00 INFO - PID 19958 | Number of tests: 14 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.39 (2.2%) stddev-sans-first:1.05 06:15:00 INFO - PID 19958 | Values: 103.0 109.0 109.0 109.0 110.0 112.0 110.0 110.0 109.0 111.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:129.00 stddev:16.16 (12.5%) stddev-sans-first:16.33 06:15:00 INFO - PID 19958 | Values: 148.0 126.0 127.0 171.0 131.0 123.0 123.0 120.0 146.0 125.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#2] audio-dft Cycles:10 Average:166.00 Median:166.00 stddev:3.53 (2.1%) stddev-sans-first:3.43 06:15:00 INFO - PID 19958 | Values: 162.0 166.0 165.0 162.0 165.0 166.0 169.0 174.0 167.0 164.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#3] audio-fft Cycles:10 Average:81.50 Median:73.50 stddev:16.35 (22.2%) stddev-sans-first:17.05 06:15:00 INFO - PID 19958 | Values: 73.0 74.0 74.0 118.0 73.0 75.0 73.0 76.0 106.0 73.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:82.50 stddev:10.25 (12.4%) stddev-sans-first:10.67 06:15:00 INFO - PID 19958 | Values: 83.0 82.0 105.0 82.0 82.0 82.0 97.0 83.0 83.0 107.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.77 (1.5%) stddev-sans-first:1.86 06:15:00 INFO - PID 19958 | Values: 114.0 113.0 114.0 114.0 119.0 115.0 114.0 113.0 116.0 115.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 06:15:00 INFO - PID 19958 | Values: 151.0 151.0 150.0 150.0 150.0 151.0 150.0 149.0 150.0 150.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 06:15:00 INFO - PID 19958 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.50 stddev:2.85 (5.1%) stddev-sans-first:2.99 06:15:00 INFO - PID 19958 | Values: 55.0 55.0 56.0 56.0 55.0 54.0 55.0 56.0 64.0 55.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.00 stddev:2.31 (4.2%) stddev-sans-first:2.44 06:15:00 INFO - PID 19958 | Values: 55.0 55.0 54.0 54.0 56.0 62.0 55.0 56.0 55.0 55.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:88.00 stddev:13.35 (15.2%) stddev-sans-first:13.97 06:15:00 INFO - PID 19958 | Values: 87.0 87.0 85.0 89.0 95.0 88.0 88.0 95.0 130.0 88.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:137.50 stddev:6.00 (4.4%) stddev-sans-first:5.92 06:15:00 INFO - PID 19958 | Values: 129.0 132.0 140.0 141.0 132.0 145.0 128.0 135.0 130.0 141.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.90 Median:198.00 stddev:5.15 (2.6%) stddev-sans-first:4.82 06:15:00 INFO - PID 19958 | Values: 190.0 208.0 198.0 195.0 194.0 198.0 196.0 191.0 198.0 201.0 06:15:00 INFO - PID 19958 | 06:15:00 INFO - PID 19958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.50 stddev:2.12 (2.8%) stddev-sans-first:1.86 06:15:00 INFO - PID 19958 | Values: 77.0 75.0 75.0 76.0 72.0 73.0 72.0 71.0 71.0 74.0 06:15:00 INFO - PID 19958 | -------- Summary: end -------- 06:15:00 INFO - PID 19958 | 06:15:01 INFO - TEST-INFO | 19958: exit 0 06:15:01 INFO - TEST-OK | kraken | took 91893ms 06:15:01 INFO - SUITE-END | took 1234s 06:15:02 INFO - Completed test suite (00:20:35) 06:15:02 INFO - javascript benchmark 06:15:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7617.720248166281, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3098.349346637206, 3098.8140711557307, 3118.3139709263955, 3129.108204161813, 3134.388794185134, 5804.709764511778, 5899.764009439617, 5929.229200203973, 5938.346781853998, 5957.285125784906, 5861.970690146554, 5910.438508341711, 5925.288965324156, 6005.279366476029, 6028.4574388305155, 5337.70642614656, 5401.405845357027, 5406.972965135169, 5423.620346575751, 5446.891062178754, 5501.174823776426, 5539.169124631298, 5551.278333816598, 5565.860853478655, 5609.298837645294, 5381.730913454312, 5410.08028635129, 5452.236686863842, 5457.481539253785, 5485.259489968843, 5482.862928426782, 5483.150111732688, 5492.093804522249, 5561.443855614447, 5561.4716601922755, 5419.051665958442, 5457.781688732446, 5468.890622187574, 5471.206675032138, 5473.616846820724, 5768.134779783024, 5829.766809327664, 5894.440028197314, 5909.881802363929, 5929.762809487615, 6289.7169627366875, 6396.872062558769, 6398.072279519443, 6426.775062872777, 6429.742810287583, 6391.77628782995, 6393.93606063938, 6409.551331406803, 6417.743290268384, 6443.5167362448, 5844.094165404369, 5914.053751399755, 5923.259592550931, 5938.7624495020145, 5962.135490353874, 6386.680665966683, 6423.0686550450855, 6499.642519661464, 6519.152510173742, 6551.8362040948405, 6138.877222455526, 6140.324564297924, 6173.382661733791, 6290.496760259169, 6310.0, 6370.0763389308295, 6384.904226436607, 6386.233651961701, 6395.5203359747275, 6435.22777266731, 6390.552661313756, 6403.711832967434, 6410.61536307823, 6412.7114279857515, 6425.100485931974, 6157.692115394212, 6236.906446403307, 6309.053641953744, 6373.458256048195, 6378.45783108441, 5169.638125331191, 5179.171332586768, 5182.455842136521, 5183.948160518346, 5217.478252174828, 4423.734575925455, 4424.159409712209, 4440.977795111068, 4475.1273501666865, 4478.373027776114, 5461.0, 5480.287562616834, 5543.2793736814765, 5543.891221755665, 5641.153826925994, 6302.936970630235, 6312.747490100436, 6329.0, 6332.620042797447, 6398.912184928573, 5536.252605898233, 5538.806141785019, 5549.611527193058, 5557.694326812064, 5602.2717046783655, 5514.172874068841, 5544.251526043932, 5590.692511911802, 5613.298337707786, 5617.101263797773, 6120.782376608313, 6122.123717501779, 6127.234095738033, 6177.104319873683, 6182.1345011698395, 6391.296957334596, 6393.520485963664, 6395.456386207225, 6399.488040956619, 6404.743810247538, 6110.69446527663, 6160.9383906160365, 6177.722002509808, 6180.505559555315, 6186.257649082139, 6073.089036644362, 6114.844865410725, 6130.0, 6180.320164781961, 6284.874302514016, 6392.328805475544, 6444.9355506444335, 6464.997925321582, 6492.577982431127, 6512.348765123639, 6007.219061521974, 6127.693615319127, 6150.0, 6235.095911092957, 6276.780312689034, 6232.220972378453, 6249.0626406039455, 6251.937480625317, 6258.123862659322, 6267.874642507216, 5988.790392336422, 6184.226971628546, 6184.628922264678, 6198.411150940653, 6209.130721699056, 6130.0312685453755, 6143.481172719164, 6202.317745048132, 6209.068639704081, 6228.128062071404, 6079.452849243589, 6080.118382834553, 6094.11635312886, 6110.205673262448, 6119.082137679384], "value": 5816.105584499741, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.4978765925556, 714.3142583120205, 740.422470473031, 1130.7229728716466, 1139.93730344831, 35846.0, 36484.63515364846, 36750.63249367509, 36793.81603091981, 36818.4477232841, 38995.0, 39057.0, 39308.41037384442, 39465.40801887974, 39466.0, 7269.854602907939, 7356.668949897241, 7428.777136685908, 7526.6236688165645, 7530.58581778002, 7400.074990626172, 7425.10898692155, 7487.925120748777, 7499.73750918718, 7504.474686771928, 7476.401887848959, 7477.700891964315, 7517.36102431294, 7524.247575242487, 7539.509931854412, 7473.364763995067, 7492.625368731542, 7503.174650788382, 7512.0, 7515.0, 7328.706851725925, 7333.1200255969625, 7355.190928997806, 7365.0, 7394.2975417335265, 35438.64561354379, 35472.0, 35546.28907421863, 35589.64410355915, 35736.28527429463, 3462.4286992646184, 3483.372992861284, 3505.3515099706638, 3506.2461570762407, 3527.9823600882087, 28682.426351472855, 28758.0, 28815.85592072047, 28851.0, 28894.71105288941, 3639.5268615080136, 3662.468942003421, 3671.687906527948, 3673.797941113238, 3674.926501469956, 164587.0, 165247.0, 167009.0, 174857.0, 183326.08336958362, 43059.35410968838, 43293.0, 43305.566944330785, 43311.13377732428, 43311.783441082596, 44111.33832992508, 44946.46017256711, 45050.54949450529, 45494.0, 45503.77248113805, 15176.0, 15471.149086800335, 15494.457693980656, 15503.14732689713, 15503.379864805507, 12386.75226495465, 12543.56097536582, 12581.182223155649, 12594.307313097868, 12686.619401417787, 14213.928930355489, 14281.928590356982, 14329.211893345757, 14356.569302920929, 14492.275386230645, 5780.971095144581, 5873.442023007808, 5908.202392676933, 5966.940330596639, 6004.42957918997, 996.6611352140308, 1026.897310268982, 1036.1192985962023, 1037.1702637889657, 1046.199657262195, 22707.545849082926, 24252.0, 24301.39246518851, 24424.464380157853, 24476.14333498319, 1115.3642423818346, 1121.697141771717, 1132.1395739238073, 1153.146671463128, 1153.371412580146, 12336.876631233572, 12991.870081299256, 13187.340632968313, 13189.670258243428, 13213.753661877505, 211975.0, 212222.0, 212553.0, 213072.0, 213692.0, 47285.29072063922, 47611.81046463938, 47763.76118119387, 48124.27813582799, 48246.758766205945, 1406.528812847687, 1466.0397439676815, 1467.801846750675, 1475.7933889255512, 1489.5531340597995, 20667.276645317343, 22313.0, 23580.17469388563, 23608.22268437042, 23674.881625591763, 34871.0, 34911.47632785561, 35105.0, 35148.82425587958, 35159.64840351666, 171909.0, 172621.0, 172803.0, 172950.0, 173277.0, 34302.65697342995, 34558.65441345655, 34583.13542161466, 34742.65257347394, 34802.0, 41455.0, 41729.37405938974, 43262.0, 43436.348454772575, 43518.56481435145, 29833.55249671213, 30985.0, 31029.68970310268, 32120.0, 33036.834815825765, 30495.48316452284, 30623.693763062085, 31615.841920790248, 32818.0, 33103.0, 36206.0, 36235.09412264715, 36382.8180859094, 36400.81799591091, 36432.63567364292, 30297.697023029486, 31115.53326700056, 31639.367212656078, 31945.201369965936, 32103.518447223778, 23130.884345578837, 24593.877030615447, 25101.74898251067, 25258.0, 25566.0], "value": 16478.977174362997, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.21600311399004, 419.6936236547322, 426.32214778502185, 435.649302311639, 437.6498800959232, 14632.707345853076, 15368.846311536881, 20213.59572808545, 21030.579388412243, 21123.894380528094, 21262.255821046267, 22039.228626998058, 22139.446513837163, 22162.22432214873, 22212.11151553936, 5816.651000939946, 5934.792282270121, 6007.15899774032, 6008.068749343837, 6008.279006519224, 5851.093080572518, 5938.0, 5963.254593175853, 5963.463288304052, 5969.253843269591, 5625.80309689161, 5872.882542349172, 5881.0, 5927.347991720929, 5938.406159384049, 5797.0, 5804.129380592903, 5811.302643682764, 5824.068149096145, 5855.443732845373, 5253.737313134328, 5257.263983042377, 5259.737013149327, 5270.183121616155, 5276.736163191864, 24811.379715507257, 24852.50294994108, 25012.124575639766, 25034.24897253085, 25132.0, 1872.7284543741082, 1884.6984482482737, 1890.4423195157462, 1894.1097684088456, 1912.6557219700449, 15804.604884877856, 16750.74873876893, 16945.57636059096, 16951.745723814154, 16955.406560770312, 2231.308294428732, 2250.6173950428465, 2268.3421807675754, 2278.624027035537, 2298.9425264368356, 108426.0, 112191.0, 112856.43571782089, 113063.0, 113356.4332178342, 10825.945870270756, 10887.346759194474, 11043.558257669603, 11043.779124417466, 11487.827682584768, 16634.25145868439, 16709.0, 16718.916405417895, 16784.244708988124, 16878.156092195342, 8805.647774089093, 8976.506292153994, 8994.325425592975, 8999.77500562478, 9114.088591140833, 8516.574171291411, 8561.357898157663, 8655.412631305293, 8736.519491427905, 8742.650293988168, 7486.513376630611, 7533.7363192288, 7647.655855486517, 7704.6532906019365, 7753.6123193840085, 2135.338045205991, 2137.1558234497597, 2143.785621437844, 2151.3438401287444, 2245.809106225989, 930.7068273493828, 969.8496733006396, 981.2689546288061, 1005.5726316315537, 1018.2363227579316, 18696.158672859754, 18824.717629235573, 19495.805041949683, 19728.70406943897, 20026.499337516678, 999.7702825524646, 1008.2841182760322, 1009.5911155981839, 1014.1633152649094, 1017.3692310767372, 10412.68761937143, 10600.204984626183, 10855.402952837512, 10862.72843178911, 10906.0, 418185.0, 424634.0, 428612.0, 430153.0, 432094.0, 98031.50984245034, 100655.0, 103905.0, 108097.4595127035, 109285.0, 1040.7346126737634, 1048.6696690542456, 1088.9237753357188, 1100.9669709908715, 1119.2668801934747, 18686.626267474847, 19171.61656766829, 19583.510412239808, 19918.800811992274, 20159.193632254544, 50743.74628126836, 50901.23648145355, 51083.48916510787, 51611.48388516067, 52315.0, 64169.0, 64456.033159501705, 64552.0, 64978.0, 65606.0, 9871.50642467888, 10022.398656080659, 10022.699319020441, 10089.29374943747, 10097.0, 16188.595285117495, 16848.831511685217, 17682.115894205497, 17791.288348465918, 17878.781819272655, 13539.729205416033, 13816.585502434944, 14647.92676036613, 14658.633534161305, 15175.089494630358, 12869.935650322062, 13043.869561304266, 13239.933800330937, 13524.39140238672, 13672.726545469233, 14929.253537322873, 14929.402823886923, 15091.169985650895, 15244.466443674419, 15272.541823745305, 10151.086402223835, 10254.846177307496, 10262.43556604394, 10266.948665256627, 10282.383057016603, 14072.155670659793, 14339.856601433852, 14673.899457540514, 14742.557723268319, 14767.0], "value": 10253.452163845923, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.8677138900416, 1322.6891680455085, 1325.7348530293943, 1331.7070244546203, 1334.8197993270905, 10443.582256709731, 10923.180761442884, 10937.671869843898, 10937.890621093788, 11249.775004499905, 10596.470176491164, 10773.56905723772, 10786.56853725852, 10794.406307653077, 10825.404602746847, 2325.720913490379, 2365.905363785455, 2370.8221883358733, 2380.821438392119, 2381.226101517005, 2281.9885900570557, 2328.906843726249, 2350.9882450587725, 2368.2066507719846, 2386.0932845518764, 2338.088145623208, 2338.4504641409253, 2347.95304093918, 2358.8584684918874, 2366.065404165354, 2279.3959600705825, 2306.688597039395, 2311.1910831209025, 2313.1903833658084, 2317.733460652021, 2244.1920908472935, 2261.366817291161, 2273.795358417734, 2275.863448193097, 2279.988600057006, 10465.110465610433, 10694.144468442506, 10721.624743133953, 10727.302725322828, 10748.140148788156, 5917.378675239124, 6088.360722124157, 6104.908426373608, 6114.96942515289, 6129.111278864584, 3705.3886108792017, 3778.9433158502643, 3830.71269654777, 3905.9218815623813, 3921.0393453603765, 1304.712963148106, 1311.8819306262387, 1328.7940369242783, 1351.621545967121, 1355.1868878672817, 15463.458778942795, 15829.841701583067, 15937.760933586005, 16016.439424620083, 16076.356945722157, 5031.924521132113, 5062.898742025139, 5101.9744901276, 5125.359330083739, 5146.330976972969, 11307.604233851776, 11379.886201137882, 11399.544018239343, 11409.48657310423, 11421.9440500709, 6050.42520960508, 6136.355682653347, 6142.969285153546, 6147.877042459126, 6156.076588511759, 5700.486956173964, 5740.741666625012, 5745.109508026263, 5759.078547432475, 5824.883502330014, 4042.1509284636154, 4151.958480415157, 4179.1432756284885, 4205.495340559152, 4259.680523960716, 1128.8645362556547, 1133.8866113388594, 1137.8122609769296, 1148.609472779259, 1161.7502237018912, 805.7663277649416, 818.0878320672407, 822.839546288468, 826.4958375391006, 862.5256109140073, 5985.610935289193, 6005.279366475964, 6005.309389420186, 6178.845528861814, 6315.115883776275, 592.4786188154396, 597.5040716205539, 607.298570151467, 614.7510258345377, 616.8581226317972, 3813.1420430402936, 3982.6216509431556, 4280.828766849353, 4479.462464504215, 4511.796969136397, 13090.541831035867, 13742.65643358904, 13809.723805524034, 13867.583972480841, 14008.579742607739, 13233.206007639572, 13633.522826701017, 13789.51736689211, 13916.721665566834, 13921.512747054006, 7570.129435115033, 7835.3731701464885, 8617.698380556776, 8777.824443511094, 8824.955875220583, 6607.7356905725155, 6619.536632435684, 6640.800775976729, 6764.797056088325, 6879.0, 12429.813552796535, 12541.122121451412, 12615.369231538203, 12726.363681816058, 12806.231626102464, 12580.245185288912, 12806.807897881354, 12981.4158362872, 12982.805257921327, 13024.088313817942, 9708.85436718464, 9712.417254964725, 9905.257105717244, 9910.75223119399, 9912.950435247778, 9726.513674316115, 9859.901400986186, 9870.0, 9895.604175833174, 9925.65260215889, 8239.35008531877, 8263.462874913112, 8416.915830841614, 8476.321894248322, 8622.82754344922, 8121.228483294078, 8183.058948220792, 8280.668773249003, 8323.583820809057, 8344.791380215544, 7573.734919278019, 7676.961615191888, 7707.152213256425, 7718.6140692964, 7742.92257077422, 5689.118186681071, 5741.741621626953, 5763.5965482417505, 5832.591718579659, 6062.120992455981, 5715.8571035724435, 5726.112452569859, 5789.623674461147, 5862.296524417097, 5966.164736936919], "value": 5047.978123638943, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.90471834400574, 390.19814281651196, 390.9784961827098, 398.4322340664553, 399.3251405125338, 6014.0, 6081.935661259278, 6117.724702388392, 6154.138420621117, 6189.876202475948, 5815.331236907757, 5913.881722365551, 5945.643261404308, 5956.731947062382, 6003.1895694081395, 4612.884677883063, 4724.149653062439, 4746.76266186691, 4754.857354279377, 4781.3545171401765, 4767.094252092109, 4773.57037866592, 4773.856784296477, 4781.760911954389, 4793.400824896888, 4719.07977944301, 4723.74019428933, 4738.90522189556, 4760.547747963938, 4761.0, 4740.478547359788, 4745.559469384703, 4768.260919557474, 4769.0, 4771.141194584973, 4147.854825081138, 4153.584641535853, 4158.459400277945, 4161.396597493377, 4169.687273454473, 5924.881502369928, 5951.940480595182, 5954.46409823118, 5979.133025711248, 5991.400859914017, 5394.946050539484, 5415.048798404879, 5424.294841670597, 5424.701641409721, 5436.782528698847, 6426.839329016765, 6428.967855160741, 6440.967795161041, 6459.483241340681, 6461.547691661585, 4541.0, 4541.8410355637725, 4556.3393307970155, 4558.293464513005, 4563.224251877189, 6406.359364063556, 6658.800235992928, 6750.257471678112, 6821.249662537117, 6854.629074185183, 4385.144896745168, 4538.205813982606, 4541.977290113528, 4559.586528176276, 4559.908801824011, 4634.026854360554, 4640.141573808856, 4661.184292748755, 4663.414439090726, 4670.0, 5206.219067139959, 5311.52196302327, 5323.1216849219445, 5335.359756829205, 5341.252224688546, 6321.3678632137335, 6349.365063493706, 6351.777687780906, 6358.205224346957, 6379.521535884827, 1593.0998985573115, 1607.638281386702, 1608.340580362046, 1616.4908053962963, 1617.7088124137533, 1060.2578195263347, 1074.4090750087578, 1096.0519150934545, 1098.3080659184823, 1104.315324498816, 5669.319681638147, 5674.233978412862, 5679.119736440858, 5766.884662306814, 5768.278965129359, 6478.352164783484, 6510.869782604416, 6519.478441724651, 6560.671966401661, 6573.276939536647, 5641.323041235078, 5678.517326027251, 5695.515881150149, 5706.3722990471015, 5729.054705973551, 3489.180042689966, 3509.4207606576633, 3524.718022558189, 3530.805805680661, 3543.875964341236, 6394.712237949303, 6401.471418789552, 6420.871582568322, 6432.903506447407, 6452.1289625900845, 6699.196096468455, 6752.63962281116, 6755.8177318969965, 6780.796576102626, 6802.3537763912345, 6350.2055947759145, 6365.299817020032, 6414.61512309263, 6458.12815269942, 6489.935100649028, 6595.373439523238, 6617.172853393326, 6625.668716564249, 6643.734250629921, 6671.633060181736, 6572.277049524453, 6588.301119531667, 6614.305497922841, 6653.168353955755, 6676.132102826601, 5896.8820623586425, 6447.709853056717, 6506.048185544223, 6521.597921403129, 6532.902006469812, 4577.832652673547, 4589.403377560896, 4591.0, 4605.700629459075, 4628.39830821991, 6645.903425934666, 6677.2655007948115, 6678.666066696548, 6692.130023096966, 6697.899531506934, 6262.843428914313, 6427.485801135805, 6433.163688720437, 6483.997282934325, 6518.608883467007, 6453.063855945627, 6500.219973603198, 6500.837479063061, 6501.349865013461, 6518.706658200487, 6425.710843012169, 6426.678666066771, 6427.389398007182, 6444.806655800334, 6448.968165093563, 6470.288268290578, 6493.928501797151, 6502.382273683992, 6503.2846386898345, 6513.413792758674, 6261.373862613702, 6282.717277722422, 6312.936870631419, 6321.557490975588, 6362.109304697438], "value": 4844.869874501176, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.4011071917496, 838.7022606974525, 846.8137009857829, 856.3577317012241, 860.3461369359289, 17226.655466890654, 17543.912280438613, 17558.73661895071, 17737.556561085978, 18773.43679689608, 17267.654646907053, 17429.302827886902, 17491.737623935653, 17578.736318955194, 17607.383741569014, 971.3103696375564, 994.2294721590753, 1002.6390499420203, 1005.3465247589053, 1011.989880101197, 987.8073775613758, 993.2054356514795, 1011.1506334678868, 1014.90865822076, 1023.7952409518089, 1072.7103682005854, 1073.2969904712427, 1073.7423018475588, 1074.591655171038, 1076.0208210528422, 1061.6125114333252, 1061.7451811565206, 1062.0706881478707, 1062.6865074802952, 1070.1813112968507, 773.5436092705331, 775.1008829757454, 783.6747749683874, 785.3442375616368, 786.4887822915093, 15836.28736706851, 15871.761923571155, 15891.60270993223, 15940.840591594051, 16295.103769292684, 17823.376181833573, 18096.0, 18096.0, 18135.274589016422, 18312.450626481226, 14274.143551386846, 14480.203588802611, 14590.781138282828, 14609.634759131, 14637.048591841496, 3380.0, 3407.216340241758, 3418.0429479745712, 3424.092615456906, 3437.535932649085, 83787.5810620949, 83961.0, 84706.0, 85275.57362213211, 85576.99999999937, 12443.37783110859, 12538.185017973803, 12618.116731828868, 12871.935640321739, 12969.481220751064, 23125.653115203284, 23433.179838705564, 23434.882825585762, 23478.0, 23703.40741481442, 7988.400869934778, 8023.879641805378, 8265.710700125466, 8289.336853051742, 8308.210719981593, 3992.5608183099835, 4066.3290557058344, 4073.06319546506, 4080.224757296104, 4104.035551645361, 4073.0835561998315, 4185.414042034056, 4187.958120418757, 4215.178040282177, 4342.544032876503, 761.3300295739714, 771.6720393832599, 775.0312109862672, 786.7875673568104, 788.3417346515723, 664.5348256220665, 690.9170899492093, 692.1140939597324, 708.4828075504807, 709.1915216653019, 11451.0, 12142.271463712206, 12259.938700306442, 12420.695826938221, 12513.3743312834, 687.8889848426242, 694.0803435448051, 694.4305669351083, 701.1761180612759, 704.6371118873784, 5152.351247600732, 5322.467753224647, 5451.781928722886, 5473.75368108436, 5533.557315414757, 93039.53480232555, 93059.0, 93403.53298233465, 96555.51722241344, 97935.0, 81747.0, 81748.59125704333, 82554.58722706468, 82692.58653706813, 83257.0, 63383.0, 70915.64542177255, 71242.2875771246, 71601.28398715946, 74870.0, 11352.148588856035, 11734.94132529332, 12143.33211673331, 12211.389430528616, 12232.87767122353, 28122.71877281201, 28355.291117721397, 28507.144785656463, 28773.568396473653, 29896.551551726305, 36183.63816361803, 36596.63403365932, 36748.81625591855, 37705.43441848429, 55456.44543554674, 16741.24664390081, 16937.407190748265, 16972.66054678924, 16976.490705278862, 17057.14714264257, 18737.531561711065, 18755.156017979498, 18840.246390144788, 19081.236750530377, 19088.045597720335, 16981.23584438728, 17244.482665520056, 17267.481975540755, 17404.12979351053, 17595.736063958793, 16105.436309729103, 16889.831101689317, 17056.0, 17251.309947602458, 17468.82531174672, 16019.759703604223, 16372.426965056165, 16796.664066718353, 16937.153142342588, 17043.829561704224, 11453.713657158638, 11782.764344712887, 11860.347680877634, 11921.284722916653, 12194.634160975185, 12889.935550322189, 13715.519956801463, 14220.928895355457, 14648.414063437343, 14692.191929443556], "value": 8129.942862371201, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 109.0, 109.0, 110.0, 112.0, 110.0, 110.0, 109.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 126.0, 127.0, 171.0, 131.0, 123.0, 123.0, 120.0, 146.0, 125.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 165.0, 162.0, 165.0, 166.0, 169.0, 174.0, 167.0, 164.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 118.0, 73.0, 75.0, 73.0, 76.0, 106.0, 73.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 105.0, 82.0, 82.0, 82.0, 97.0, 83.0, 83.0, 107.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 119.0, 115.0, 114.0, 113.0, 116.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 150.0, 150.0, 151.0, 150.0, 149.0, 150.0, 150.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 55.0, 54.0, 55.0, 56.0, 64.0, 55.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 56.0, 62.0, 55.0, 56.0, 55.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 85.0, 89.0, 95.0, 88.0, 88.0, 95.0, 130.0, 88.0], "value": 93.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 132.0, 140.0, 141.0, 132.0, 145.0, 128.0, 135.0, 130.0, 141.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 208.0, 198.0, 195.0, 194.0, 198.0, 196.0, 191.0, 198.0, 201.0], "value": 196.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 76.0, 72.0, 73.0, 72.0, 71.0, 71.0, 74.0], "value": 73.6, "unit": "score"}]}]} 06:15:02 INFO - Return code: 0 06:15:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:15:02 INFO - # TBPL SUCCESS # 06:15:02 INFO - Running post-action listener: _resource_record_post_action 06:15:02 INFO - [mozharness: 2017-06-02 13:15:02.189022Z] Finished run-tests step (success) 06:15:02 INFO - Running post-run listener: _resource_record_post_run 06:15:02 INFO - Total resource usage - Wall time: 1252s; CPU: 13.0%; Read bytes: 4096; Write bytes: 424349696; Read time: 20; Write time: 297588 06:15:02 INFO - TinderboxPrint: CPU usage
12.7% 06:15:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 06:15:02 INFO - TinderboxPrint: I/O write bytes / time
424,349,696 / 297,588 06:15:02 INFO - TinderboxPrint: CPU idle
8,725.5 (87.3%) 06:15:02 INFO - TinderboxPrint: CPU user
1,212.5 (12.1%) 06:15:02 INFO - TinderboxPrint: Swap in / out
0 / 0 06:15:02 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 102060032; Read time: 0; Write time: 103896 06:15:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:15:02 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 322289664; Read time: 0; Write time: 193692 06:15:02 INFO - Running post-run listener: _upload_blobber_files 06:15:02 INFO - Blob upload gear active. 06:15:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:02 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 06:15:02 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'] 06:15:02 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 06:15:03 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:15:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:15:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:04 INFO - (blobuploader) - INFO - Done attempting. 06:15:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:15:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:10 INFO - (blobuploader) - INFO - Done attempting. 06:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:15:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:11 INFO - (blobuploader) - INFO - Done attempting. 06:15:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:15:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:12 INFO - (blobuploader) - INFO - Done attempting. 06:15:12 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:12 INFO - Return code: 0 06:15:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4df880d640891f760677fdfb5f9b122171bc7f9eed47946e12674fec09d7b2c9c8201f0f5b54c5f7c92450506b6b9cc0cf119a42a6c4f2878d7103a68ea9623", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d9828965e044c8c6edd3a567f84f6f17fb28b54b3c8b8c37241ff195838a092b1b9c1a804949de3c774a5eb476c588f168d4fa236b45b6686d4b61b411032df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/850a536fd1ade0982c9e6b6a84ee6c44b69be3911f81f937e14ce4897cdcdf4213230a0f8547be20a64b78639e88b12205db2bb969149ac598e56fbc3ad809e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4558407ed8c3a9bc80863eef16ba76e6c4bd8038bd8c0ec839f8899923c5dcdb3857fb54e6f3bb09ca63cf59f5c4908a23bb7f187ce66b501d9c14ffe658d52b"} 06:15:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:12 INFO - Contents: 06:15:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4df880d640891f760677fdfb5f9b122171bc7f9eed47946e12674fec09d7b2c9c8201f0f5b54c5f7c92450506b6b9cc0cf119a42a6c4f2878d7103a68ea9623", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d9828965e044c8c6edd3a567f84f6f17fb28b54b3c8b8c37241ff195838a092b1b9c1a804949de3c774a5eb476c588f168d4fa236b45b6686d4b61b411032df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/850a536fd1ade0982c9e6b6a84ee6c44b69be3911f81f937e14ce4897cdcdf4213230a0f8547be20a64b78639e88b12205db2bb969149ac598e56fbc3ad809e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4558407ed8c3a9bc80863eef16ba76e6c4bd8038bd8c0ec839f8899923c5dcdb3857fb54e6f3bb09ca63cf59f5c4908a23bb7f187ce66b501d9c14ffe658d52b"} 06:15:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:12 INFO - Copying logs to upload dir... 06:15:12 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1312.543872 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2017-06-02 06:15:11.862643) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 06:15:11.870652) ========= 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=db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4df880d640891f760677fdfb5f9b122171bc7f9eed47946e12674fec09d7b2c9c8201f0f5b54c5f7c92450506b6b9cc0cf119a42a6c4f2878d7103a68ea9623", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d9828965e044c8c6edd3a567f84f6f17fb28b54b3c8b8c37241ff195838a092b1b9c1a804949de3c774a5eb476c588f168d4fa236b45b6686d4b61b411032df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/850a536fd1ade0982c9e6b6a84ee6c44b69be3911f81f937e14ce4897cdcdf4213230a0f8547be20a64b78639e88b12205db2bb969149ac598e56fbc3ad809e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4558407ed8c3a9bc80863eef16ba76e6c4bd8038bd8c0ec839f8899923c5dcdb3857fb54e6f3bb09ca63cf59f5c4908a23bb7f187ce66b501d9c14ffe658d52b"} build_url:https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/KIyO_hv7Sjqum__yWX1O2A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4df880d640891f760677fdfb5f9b122171bc7f9eed47946e12674fec09d7b2c9c8201f0f5b54c5f7c92450506b6b9cc0cf119a42a6c4f2878d7103a68ea9623", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d9828965e044c8c6edd3a567f84f6f17fb28b54b3c8b8c37241ff195838a092b1b9c1a804949de3c774a5eb476c588f168d4fa236b45b6686d4b61b411032df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/850a536fd1ade0982c9e6b6a84ee6c44b69be3911f81f937e14ce4897cdcdf4213230a0f8547be20a64b78639e88b12205db2bb969149ac598e56fbc3ad809e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4558407ed8c3a9bc80863eef16ba76e6c4bd8038bd8c0ec839f8899923c5dcdb3857fb54e6f3bb09ca63cf59f5c4908a23bb7f187ce66b501d9c14ffe658d52b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 06:15:11.897934) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 06:15:11.898343) ========= 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=db0483c52d987ecb441a263b000001ad-1496407101.766063-1064645448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 06:15:11.979117) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 06:15:11.982466) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 06:15:11.982794) ========= ========= Total master_lag: 0.19 =========