builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1496370134.44 results: success (0) revision: aeb3d0ca558f034cbef1c5a68bd07dd738611494 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 19:22:14.439295) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 19:22:14.439934) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 19:22:14.443380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 19:22:14.459120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:22:14.459390) ========= 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=20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-01 19:22:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-06-01 19:22:15 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130206 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:22:14.603058) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:22:14.606408) ========= 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=20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017409 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:22:14.655910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 19:22:14.659249) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aeb3d0ca558f034cbef1c5a68bd07dd738611494 --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 aeb3d0ca558f034cbef1c5a68bd07dd738611494 --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=20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-01 19:22:16,079 truncating revision to first 12 chars 2017-06-01 19:22:16,079 Setting DEBUG logging. 2017-06-01 19:22:16,079 attempt 1/10 2017-06-01 19:22:16,079 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aeb3d0ca558f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-01 19:22:17,004 unpacking tar archive at: mozilla-central-aeb3d0ca558f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.239715 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 19:22:15.916354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 19:22:15.916875) ========= script_repo_revision: aeb3d0ca558f034cbef1c5a68bd07dd738611494 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 19:22:15.918569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 19:22:15.919047) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 19:22:15.930491) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-01 19:22:15.930912) ========= /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=20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:22:17 INFO - MultiFileLogger online at 20170601 19:22:17 in /builds/slave/test 19:22:17 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 19:22:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:22:17 INFO - {'append_to_log': False, 19:22:17 INFO - 'base_work_dir': '/builds/slave/test', 19:22:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:22:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:22:17 INFO - 'branch': 'Firefox-Non-PGO', 19:22:17 INFO - 'buildbot_json_path': 'buildprops.json', 19:22:17 INFO - 'config_files': ('talos/linux_config.py',), 19:22:17 INFO - 'default_actions': ('clobber', 19:22:17 INFO - 'read-buildbot-config', 19:22:17 INFO - 'download-and-extract', 19:22:17 INFO - 'populate-webroot', 19:22:17 INFO - 'create-virtualenv', 19:22:17 INFO - 'install', 19:22:17 INFO - 'setup-mitmproxy', 19:22:17 INFO - 'run-tests'), 19:22:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:22:17 INFO - 'download_minidump_stackwalk': True, 19:22:17 INFO - 'download_symbols': 'ondemand', 19:22:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:22:17 INFO - 'tooltool.py': '/tools/tooltool.py', 19:22:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:22:17 INFO - '/tools/misc-python/virtualenv.py')}, 19:22:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:22:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:22:17 INFO - 'gecko_profile': False, 19:22:17 INFO - 'gecko_profile_interval': 0, 19:22:17 INFO - 'installer_path': 'installer.exe', 19:22:17 INFO - 'log_level': 'info', 19:22:17 INFO - 'log_name': 'talos', 19:22:17 INFO - 'log_to_console': True, 19:22:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:22:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:22:17 INFO - 'opt_config_files': (), 19:22:17 INFO - 'pip_index': False, 19:22:17 INFO - 'suite': 'dromaeojs-e10s', 19:22:17 INFO - 'system_bits': '32', 19:22:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:22:17 INFO - 'title': 'talos-linux64-ix-015', 19:22:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:22:17 INFO - 'use_talos_json': True, 19:22:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:22:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:22:17 INFO - 'work_dir': 'build'} 19:22:17 INFO - [mozharness: 2017-06-02 02:22:17.453812Z] Running clobber step. 19:22:17 INFO - Running pre-action listener: _resource_record_pre_action 19:22:17 INFO - Running main action method: clobber 19:22:17 INFO - rmtree: /builds/slave/test/build 19:22:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:22:18 INFO - Running post-action listener: _resource_record_post_action 19:22:18 INFO - [mozharness: 2017-06-02 02:22:18.488044Z] Finished clobber step (success) 19:22:18 INFO - [mozharness: 2017-06-02 02:22:18.488145Z] Running read-buildbot-config step. 19:22:18 INFO - Running pre-action listener: _resource_record_pre_action 19:22:18 INFO - Running main action method: read_buildbot_config 19:22:18 INFO - Using buildbot properties: 19:22:18 INFO - { 19:22:18 INFO - "project": "", 19:22:18 INFO - "product": "firefox", 19:22:18 INFO - "who": "kwierso@gmail.com", 19:22:18 INFO - "installer_path": "public/build/target.tar.bz2", 19:22:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:22:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:22:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:22:18 INFO - "stage_platform": "linux64", 19:22:18 INFO - "basedir": "/builds/slave/test", 19:22:18 INFO - "buildnumber": 648, 19:22:18 INFO - "platform": "ubuntu64_hw", 19:22:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:22:18 INFO - "slavebuilddir": "test", 19:22:18 INFO - "taskId": "f1Wysg8lQ267T5QaK_57FQ", 19:22:18 INFO - "branch": "mozilla-central", 19:22:18 INFO - "script_repo_revision": "production", 19:22:18 INFO - "revision": "aeb3d0ca558f034cbef1c5a68bd07dd738611494", 19:22:18 INFO - "slavename": "talos-linux64-ix-015", 19:22:18 INFO - "repo_path": "mozilla-central" 19:22:18 INFO - } 19:22:18 INFO - Finding installer, test and symbols from parent task. 19:22:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f1Wysg8lQ267T5QaK_57FQ'}, attempt #1 19:22:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f1Wysg8lQ267T5QaK_57FQ'}, attempt #1 19:22:19 INFO - Task dependencies: Rggr6v0nShaZDWgOhcwTmQ 19:22:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ'}, attempt #1 19:22:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.tar.bz2 19:22:19 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/test_packages.json 19:22:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.crashreporter-symbols.zip 19:22:19 INFO - Running post-action listener: _resource_record_post_action 19:22:19 INFO - [mozharness: 2017-06-02 02:22:19.850002Z] Finished read-buildbot-config step (success) 19:22:19 INFO - [mozharness: 2017-06-02 02:22:19.850290Z] Running download-and-extract step. 19:22:19 INFO - Running pre-action listener: _resource_record_pre_action 19:22:19 INFO - Running main action method: download_and_extract 19:22:19 INFO - mkdir: /builds/slave/test/build/tests 19:22:19 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')]} 19:22:19 INFO - trying https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.test_packages.json 19:22:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:22:20 INFO - Downloaded 986 bytes. 19:22:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:22:20 INFO - Using the following test package requirements: 19:22:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:22:20 INFO - u'common': [u'target.common.tests.zip'], 19:22:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:22:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:22:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:22:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:22:20 INFO - u'mozbase': [u'target.common.tests.zip'], 19:22:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:22:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:22:20 INFO - u'web-platform': [u'target.common.tests.zip', 19:22:20 INFO - u'target.web-platform.tests.zip'], 19:22:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:22:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:22:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.common.tests.zip 19:22:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:22:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.common.tests.zip into memory 19:22:21 INFO - Content-Length response header: 63535958 19:22:21 INFO - Bytes received: 63535958 19:22:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:22:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.common.tests.zip 19:22:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:22:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.common.tests.zip into memory 19:22:33 INFO - Content-Length response header: 63535958 19:22:33 INFO - Bytes received: 63535958 19:22:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.talos.tests.zip 19:22:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:22:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.talos.tests.zip into memory 19:22:46 INFO - Content-Length response header: 14447425 19:22:46 INFO - Bytes received: 14447425 19:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:46 INFO - trying https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.tar.bz2 19:22:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:22:47 INFO - Downloaded 54184691 bytes. 19:22:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.tar.bz2 19:22:47 INFO - mkdir: /builds/slave/test/properties 19:22:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:22:47 INFO - Writing to file /builds/slave/test/properties/build_url 19:22:47 INFO - Contents: 19:22:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.tar.bz2 19:22:47 INFO - Running post-action listener: _resource_record_post_action 19:22:47 INFO - Running post-action listener: set_extra_try_arguments 19:22:47 INFO - [mozharness: 2017-06-02 02:22:47.500564Z] Finished download-and-extract step (success) 19:22:47 INFO - [mozharness: 2017-06-02 02:22:47.500661Z] Running populate-webroot step. 19:22:47 INFO - Running pre-action listener: _resource_record_pre_action 19:22:47 INFO - Running main action method: populate_webroot 19:22:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:22:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:22:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:22:47 INFO - '--tppagecycles', 19:22:47 INFO - '7'], 19:22:47 INFO - 'tests': ['tsvgm']}}, 19:22:47 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:22:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:22:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:22:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:22:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:22:47 INFO - 'talos_options': ['--disable-e10s'], 19:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:22:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:22:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:22:47 INFO - 'talos_options': ['--disable-e10s'], 19:22:47 INFO - 'tests': ['damp', 'tps']}, 19:22:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:22:47 INFO - 'tests': ['damp', 'tps']}, 19:22:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:22:47 INFO - 'tests': ['dromaeo_dom']}, 19:22:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:22:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:22:47 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:22:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:22:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:22:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:22:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:22:47 INFO - 'tests': ['a11yr', 19:22:47 INFO - 'ts_paint', 19:22:47 INFO - 'tpaint', 19:22:47 INFO - 'sessionrestore', 19:22:47 INFO - 'sessionrestore_no_auto_restore', 19:22:47 INFO - 'tabpaint']}, 19:22:47 INFO - 'other-e10s': {'tests': ['a11yr', 19:22:47 INFO - 'ts_paint', 19:22:47 INFO - 'tpaint', 19:22:47 INFO - 'sessionrestore', 19:22:47 INFO - 'sessionrestore_no_auto_restore', 19:22:47 INFO - 'tabpaint']}, 19:22:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:22:47 INFO - 'ts_paint', 19:22:47 INFO - 'tpaint', 19:22:47 INFO - 'sessionrestore', 19:22:47 INFO - 'sessionrestore_no_auto_restore', 19:22:47 INFO - 'tabpaint']}, 19:22:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:22:47 INFO - 'ts_paint', 19:22:47 INFO - 'tpaint', 19:22:47 INFO - 'sessionrestore', 19:22:47 INFO - 'sessionrestore_no_auto_restore', 19:22:47 INFO - 'tabpaint']}, 19:22:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:22:47 INFO - 'tests': ['a11yr', 19:22:47 INFO - 'ts_paint', 19:22:47 INFO - 'tpaint', 19:22:47 INFO - 'sessionrestore', 19:22:47 INFO - 'sessionrestore_no_auto_restore', 19:22:47 INFO - 'tabpaint']}, 19:22:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:22:47 INFO - 'tests': ['a11yr', 19:22:47 INFO - 'ts_paint', 19:22:47 INFO - 'tpaint', 19:22:47 INFO - 'sessionrestore', 19:22:47 INFO - 'sessionrestore_no_auto_restore', 19:22:47 INFO - 'tabpaint']}, 19:22:47 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 19:22:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 19:22:47 INFO - 'bloom_basic_ref']}, 19:22:47 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 19:22:47 INFO - 'talos_options': ['--mitmproxy', 19:22:47 INFO - 'mitmproxy-recording-1.mp', 19:22:47 INFO - '--firstNonBlankPaint'], 19:22:47 INFO - 'tests': ['Quantum_1']}, 19:22:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:22:47 INFO - 'tests': ['tsvgx', 19:22:47 INFO - 'tsvgr_opacity', 19:22:47 INFO - 'tart', 19:22:47 INFO - 'tscrollx', 19:22:47 INFO - 'cart', 19:22:47 INFO - 'tsvg_static']}, 19:22:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:22:47 INFO - 'tsvgr_opacity', 19:22:47 INFO - 'tart', 19:22:47 INFO - 'tscrollx', 19:22:47 INFO - 'cart', 19:22:47 INFO - 'tsvg_static']}, 19:22:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:22:47 INFO - 'talos_options': ['--disable-e10s'], 19:22:47 INFO - 'tests': ['tp5o']}, 19:22:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:22:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:22:47 INFO - 'talos_options': ['--disable-e10s', 19:22:47 INFO - '--xperf_path', 19:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:22:47 INFO - 'tests': ['tp5n']}, 19:22:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:22:47 INFO - 'talos_options': ['--xperf_path', 19:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:22:47 INFO - 'tests': ['tp5n']}}, 19:22:47 INFO - 'talos.zip': {'path': '', 19:22:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:22:47 INFO - Running post-action listener: _resource_record_post_action 19:22:47 INFO - [mozharness: 2017-06-02 02:22:47.514964Z] Finished populate-webroot step (success) 19:22:47 INFO - [mozharness: 2017-06-02 02:22:47.515061Z] Running create-virtualenv step. 19:22:47 INFO - Running pre-action listener: _resource_record_pre_action 19:22:47 INFO - Running main action method: create_virtualenv 19:22:47 INFO - Creating virtualenv /builds/slave/test/build/venv 19:22:47 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 19:22:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:22:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:22:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:22:47 INFO - Using real prefix '/usr' 19:22:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:22:48 INFO - Installing distribute.............................................................................................................................................................................................done. 19:22:50 INFO - Installing pip.................done. 19:22:50 INFO - Return code: 0 19:22:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:22:50 INFO - Reading from file tmpfile_stdout 19:22:50 INFO - Output received: 19:22:50 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) 19:22:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f0840>, '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 0x19f1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f1bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', '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 19:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:22:50 INFO - Using env: {'DISPLAY': ':0', 19:22:50 INFO - 'HOME': '/home/cltbld', 19:22:50 INFO - 'LANG': 'en_US.UTF-8', 19:22:50 INFO - 'LANGUAGE': 'en_US:en', 19:22:50 INFO - 'LOGNAME': 'cltbld', 19:22:50 INFO - 'MAIL': '/var/mail/cltbld', 19:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:50 INFO - 'MOZ_NO_REMOTE': '1', 19:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:50 INFO - 'NO_EM_RESTART': '1', 19:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:50 INFO - 'PWD': '/builds/slave/test', 19:22:50 INFO - 'SHELL': '/bin/bash', 19:22:50 INFO - 'SHLVL': '1', 19:22:50 INFO - 'TERM': 'linux', 19:22:50 INFO - 'TMOUT': '86400', 19:22:50 INFO - 'USER': 'cltbld', 19:22:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', 19:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:50 INFO - '_': '/tools/buildbot/bin/python'} 19:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:50 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 19:22:50 INFO - Cleaning up... 19:22:50 INFO - Return code: 0 19:22:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f0840>, '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 0x19f1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f1bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', '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 19:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:22:50 INFO - Using env: {'DISPLAY': ':0', 19:22:50 INFO - 'HOME': '/home/cltbld', 19:22:50 INFO - 'LANG': 'en_US.UTF-8', 19:22:50 INFO - 'LANGUAGE': 'en_US:en', 19:22:50 INFO - 'LOGNAME': 'cltbld', 19:22:50 INFO - 'MAIL': '/var/mail/cltbld', 19:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:50 INFO - 'MOZ_NO_REMOTE': '1', 19:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:50 INFO - 'NO_EM_RESTART': '1', 19:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:50 INFO - 'PWD': '/builds/slave/test', 19:22:50 INFO - 'SHELL': '/bin/bash', 19:22:50 INFO - 'SHLVL': '1', 19:22:50 INFO - 'TERM': 'linux', 19:22:50 INFO - 'TMOUT': '86400', 19:22:50 INFO - 'USER': 'cltbld', 19:22:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', 19:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:50 INFO - '_': '/tools/buildbot/bin/python'} 19:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:50 INFO - Downloading/unpacking psutil>=3.1.1 19:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:22:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:22:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:22:51 INFO - Installing collected packages: psutil 19:22:51 INFO - Running setup.py install for psutil 19:22:51 INFO - building 'psutil._psutil_linux' extension 19:22:51 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 19:22:52 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 19:22:52 INFO - building 'psutil._psutil_posix' extension 19:22:52 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 19:22:52 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 19:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:22:52 INFO - Successfully installed psutil 19:22:52 INFO - Cleaning up... 19:22:52 INFO - Return code: 0 19:22:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:22:52 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')]} 19:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:52 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')]} 19:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:52 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 0x16753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f0840>, '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 0x19f1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f1bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', '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 19:22:52 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 19:22:52 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 19:22:52 INFO - Using env: {'DISPLAY': ':0', 19:22:52 INFO - 'HOME': '/home/cltbld', 19:22:52 INFO - 'LANG': 'en_US.UTF-8', 19:22:52 INFO - 'LANGUAGE': 'en_US:en', 19:22:52 INFO - 'LOGNAME': 'cltbld', 19:22:52 INFO - 'MAIL': '/var/mail/cltbld', 19:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:52 INFO - 'MOZ_NO_REMOTE': '1', 19:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:52 INFO - 'NO_EM_RESTART': '1', 19:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:52 INFO - 'PWD': '/builds/slave/test', 19:22:52 INFO - 'SHELL': '/bin/bash', 19:22:52 INFO - 'SHLVL': '1', 19:22:52 INFO - 'TERM': 'linux', 19:22:52 INFO - 'TMOUT': '86400', 19:22:52 INFO - 'USER': 'cltbld', 19:22:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', 19:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:52 INFO - '_': '/tools/buildbot/bin/python'} 19:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:22:53 INFO - Installing collected packages: mozsystemmonitor 19:22:53 INFO - Running setup.py install for mozsystemmonitor 19:22:53 INFO - Successfully installed mozsystemmonitor 19:22:53 INFO - Cleaning up... 19:22:53 INFO - Return code: 0 19:22:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22: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')]} 19:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22: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', '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 0x16753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f0840>, '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 0x19f1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f1bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', '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 19:22: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:22: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 jsonschema==2.5.1 19:22:53 INFO - Using env: {'DISPLAY': ':0', 19:22:53 INFO - 'HOME': '/home/cltbld', 19:22:53 INFO - 'LANG': 'en_US.UTF-8', 19:22:53 INFO - 'LANGUAGE': 'en_US:en', 19:22:53 INFO - 'LOGNAME': 'cltbld', 19:22:53 INFO - 'MAIL': '/var/mail/cltbld', 19:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:53 INFO - 'MOZ_NO_REMOTE': '1', 19:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:53 INFO - 'NO_EM_RESTART': '1', 19:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:53 INFO - 'PWD': '/builds/slave/test', 19:22:53 INFO - 'SHELL': '/bin/bash', 19:22:53 INFO - 'SHLVL': '1', 19:22:53 INFO - 'TERM': 'linux', 19:22:53 INFO - 'TMOUT': '86400', 19:22:53 INFO - 'USER': 'cltbld', 19:22:53 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', 19:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:53 INFO - '_': '/tools/buildbot/bin/python'} 19:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:54 INFO - Downloading/unpacking jsonschema==2.5.1 19:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:22:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:22: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 19:22: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 19:22: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 19:22: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 19:22:55 INFO - Downloading functools32-3.2.3-2.tar.gz 19:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:22:55 INFO - warning: no files found matching '*.txt' 19:22:55 INFO - no previously-included directories found matching 'build' 19:22:55 INFO - no previously-included directories found matching 'dist' 19:22:55 INFO - no previously-included directories found matching '.git*' 19:22:55 INFO - Installing collected packages: jsonschema, functools32 19:22:55 INFO - Running setup.py install for functools32 19:22:55 INFO - warning: no files found matching '*.txt' 19:22:55 INFO - no previously-included directories found matching 'build' 19:22:55 INFO - no previously-included directories found matching 'dist' 19:22:55 INFO - no previously-included directories found matching '.git*' 19:22:55 INFO - Successfully installed jsonschema functools32 19:22:55 INFO - Cleaning up... 19:22:55 INFO - Return code: 0 19:22:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22: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')]} 19:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22: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', '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 0x16753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f0840>, '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 0x19f1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f1bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', '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 19:22: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:22: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 functools32==3.2.3-2 19:22:55 INFO - Using env: {'DISPLAY': ':0', 19:22:55 INFO - 'HOME': '/home/cltbld', 19:22:55 INFO - 'LANG': 'en_US.UTF-8', 19:22:55 INFO - 'LANGUAGE': 'en_US:en', 19:22:55 INFO - 'LOGNAME': 'cltbld', 19:22:55 INFO - 'MAIL': '/var/mail/cltbld', 19:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:55 INFO - 'MOZ_NO_REMOTE': '1', 19:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:55 INFO - 'NO_EM_RESTART': '1', 19:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:55 INFO - 'PWD': '/builds/slave/test', 19:22:55 INFO - 'SHELL': '/bin/bash', 19:22:55 INFO - 'SHLVL': '1', 19:22:55 INFO - 'TERM': 'linux', 19:22:55 INFO - 'TMOUT': '86400', 19:22:55 INFO - 'USER': 'cltbld', 19:22:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', 19:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:55 INFO - '_': '/tools/buildbot/bin/python'} 19:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:22:55 INFO - Cleaning up... 19:22:55 INFO - Return code: 0 19:22:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22: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')]} 19:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22: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', '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 0x16753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f0840>, '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 0x19f1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f1bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', '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 19:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:22: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 blobuploader==1.2.4 19:22:55 INFO - Using env: {'DISPLAY': ':0', 19:22:55 INFO - 'HOME': '/home/cltbld', 19:22:55 INFO - 'LANG': 'en_US.UTF-8', 19:22:55 INFO - 'LANGUAGE': 'en_US:en', 19:22:55 INFO - 'LOGNAME': 'cltbld', 19:22:55 INFO - 'MAIL': '/var/mail/cltbld', 19:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:55 INFO - 'MOZ_NO_REMOTE': '1', 19:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:55 INFO - 'NO_EM_RESTART': '1', 19:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:55 INFO - 'PWD': '/builds/slave/test', 19:22:55 INFO - 'SHELL': '/bin/bash', 19:22:55 INFO - 'SHLVL': '1', 19:22:55 INFO - 'TERM': 'linux', 19:22:55 INFO - 'TMOUT': '86400', 19:22:55 INFO - 'USER': 'cltbld', 19:22:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', 19:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:55 INFO - '_': '/tools/buildbot/bin/python'} 19:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:56 INFO - Downloading/unpacking blobuploader==1.2.4 19:22: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 19:22: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 19:22: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 19:22: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 19:22:57 INFO - Downloading blobuploader-1.2.4.tar.gz 19:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:22:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:22:57 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 19:22:57 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 19:22:57 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 19:22:57 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 19:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:22:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:22:57 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 19:22:57 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 19:22:57 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 19:22:57 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 19:22:57 INFO - Downloading docopt-0.6.1.tar.gz 19:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:22:57 INFO - Installing collected packages: blobuploader, requests, docopt 19:22:57 INFO - Running setup.py install for blobuploader 19:22:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:22:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:22:57 INFO - Running setup.py install for requests 19:22:58 INFO - Running setup.py install for docopt 19:22:58 INFO - Successfully installed blobuploader requests docopt 19:22:58 INFO - Cleaning up... 19:22:58 INFO - Return code: 0 19:22:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22: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')]} 19:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:58 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 0x16753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f0840>, '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 0x19f1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f1bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', '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 19:22:58 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 19:22:58 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 19:22:58 INFO - Using env: {'DISPLAY': ':0', 19:22:58 INFO - 'HOME': '/home/cltbld', 19:22:58 INFO - 'LANG': 'en_US.UTF-8', 19:22:58 INFO - 'LANGUAGE': 'en_US:en', 19:22:58 INFO - 'LOGNAME': 'cltbld', 19:22:58 INFO - 'MAIL': '/var/mail/cltbld', 19:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:58 INFO - 'MOZ_NO_REMOTE': '1', 19:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:58 INFO - 'NO_EM_RESTART': '1', 19:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:58 INFO - 'PWD': '/builds/slave/test', 19:22:58 INFO - 'SHELL': '/bin/bash', 19:22:58 INFO - 'SHLVL': '1', 19:22:58 INFO - 'TERM': 'linux', 19:22:58 INFO - 'TMOUT': '86400', 19:22:58 INFO - 'USER': 'cltbld', 19:22:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', 19:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:58 INFO - '_': '/tools/buildbot/bin/python'} 19:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:22:58 INFO - Running setup.py (path:/tmp/pip-TjYvy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:22:58 INFO - Running setup.py (path:/tmp/pip-qryqNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:22:58 INFO - Running setup.py (path:/tmp/pip-pNo1y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:22:58 INFO - Running setup.py (path:/tmp/pip-JNv3rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:22:58 INFO - Running setup.py (path:/tmp/pip-LELrb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:22:58 INFO - Running setup.py (path:/tmp/pip-Ikm41a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:22:58 INFO - Running setup.py (path:/tmp/pip-SKeZpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:22:59 INFO - Running setup.py (path:/tmp/pip-rgCIeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:22:59 INFO - Running setup.py (path:/tmp/pip-8_WtDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:22:59 INFO - Running setup.py (path:/tmp/pip-fqw03W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:22:59 INFO - Running setup.py (path:/tmp/pip-eBxRiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:22:59 INFO - Running setup.py (path:/tmp/pip-lkz53f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:22:59 INFO - Running setup.py (path:/tmp/pip-BdD2a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:22:59 INFO - Running setup.py (path:/tmp/pip-iDfzhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:59 INFO - Running setup.py (path:/tmp/pip-sxx2hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:22:59 INFO - Running setup.py (path:/tmp/pip-Ii4CFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:22:59 INFO - Running setup.py (path:/tmp/pip-t7kox_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:22:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:22:59 INFO - Running setup.py install for manifestparser 19:22:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:22:59 INFO - Running setup.py install for mozcrash 19:22:59 INFO - Running setup.py install for mozdebug 19:23:00 INFO - Running setup.py install for mozdevice 19:23:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:23:00 INFO - Running setup.py install for mozfile 19:23:00 INFO - Running setup.py install for mozhttpd 19:23:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:23:00 INFO - Running setup.py install for mozinfo 19:23:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:23:00 INFO - Running setup.py install for mozInstall 19:23:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:23:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:23:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:23:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:23:00 INFO - Running setup.py install for mozleak 19:23:00 INFO - Running setup.py install for mozlog 19:23:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:23:00 INFO - Running setup.py install for moznetwork 19:23:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:23:00 INFO - Running setup.py install for mozprocess 19:23:00 INFO - Running setup.py install for mozprofile 19:23:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Running setup.py install for mozrunner 19:23:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Running setup.py install for mozscreenshot 19:23:01 INFO - Running setup.py install for moztest 19:23:01 INFO - Running setup.py install for mozversion 19:23:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:23:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:23:01 INFO - Cleaning up... 19:23:01 INFO - Return code: 0 19:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23: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')]} 19:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23: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')]} 19:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:01 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 0x16753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f0840>, '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 0x19f1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f1bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', '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 19:23:01 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 19:23:01 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 19:23:01 INFO - Using env: {'DISPLAY': ':0', 19:23:01 INFO - 'HOME': '/home/cltbld', 19:23:01 INFO - 'LANG': 'en_US.UTF-8', 19:23:01 INFO - 'LANGUAGE': 'en_US:en', 19:23:01 INFO - 'LOGNAME': 'cltbld', 19:23:01 INFO - 'MAIL': '/var/mail/cltbld', 19:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:01 INFO - 'MOZ_NO_REMOTE': '1', 19:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:01 INFO - 'NO_EM_RESTART': '1', 19:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:01 INFO - 'PWD': '/builds/slave/test', 19:23:01 INFO - 'SHELL': '/bin/bash', 19:23:01 INFO - 'SHLVL': '1', 19:23:01 INFO - 'TERM': 'linux', 19:23:01 INFO - 'TMOUT': '86400', 19:23:01 INFO - 'USER': 'cltbld', 19:23:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', 19:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:01 INFO - '_': '/tools/buildbot/bin/python'} 19:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:23:01 INFO - Running setup.py (path:/tmp/pip-MlxwRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:23:01 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)) 19:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:23:01 INFO - Running setup.py (path:/tmp/pip-07nsxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:23:01 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)) 19:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:23:01 INFO - Running setup.py (path:/tmp/pip-5gXFhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:23:01 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)) 19:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:23:01 INFO - Running setup.py (path:/tmp/pip-pVSld7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:23:02 INFO - Running setup.py (path:/tmp/pip-pgpau3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:23:02 INFO - Running setup.py (path:/tmp/pip-sncAAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:23:02 INFO - Running setup.py (path:/tmp/pip-4Oy7N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:23:02 INFO - Running setup.py (path:/tmp/pip-rxmK1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:23:02 INFO - Running setup.py (path:/tmp/pip-jIOheC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:23:02 INFO - Running setup.py (path:/tmp/pip-Z0Bt7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:23:02 INFO - Running setup.py (path:/tmp/pip-kXwiJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:23:02 INFO - Running setup.py (path:/tmp/pip-rnuC5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:23:02 INFO - Running setup.py (path:/tmp/pip-ZWcdkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:23:02 INFO - Running setup.py (path:/tmp/pip-L5PFPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:02 INFO - Running setup.py (path:/tmp/pip-8EoSwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:23:02 INFO - Running setup.py (path:/tmp/pip-UQKK9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:02 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)) 19:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:02 INFO - Running setup.py (path:/tmp/pip-RTXnXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:02 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)) 19:23:02 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)) 19:23:02 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)) 19:23:02 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)) 19:23:02 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)) 19:23:02 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)) 19:23:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:04 INFO - Downloading blessings-1.6.tar.gz 19:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:23:04 INFO - Installing collected packages: blessings 19:23:04 INFO - Running setup.py install for blessings 19:23:04 INFO - Successfully installed blessings 19:23:04 INFO - Cleaning up... 19:23:04 INFO - Return code: 0 19:23:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:04 INFO - Reading from file tmpfile_stdout 19:23:04 INFO - Current package versions: 19:23:04 INFO - argparse == 1.2.1 19:23:04 INFO - blessings == 1.6 19:23:04 INFO - blobuploader == 1.2.4 19:23:04 INFO - docopt == 0.6.1 19:23:04 INFO - functools32 == 3.2.3-2 19:23:04 INFO - jsonschema == 2.5.1 19:23:04 INFO - manifestparser == 1.1 19:23:04 INFO - mozInstall == 1.12 19:23:04 INFO - mozcrash == 1.0 19:23:04 INFO - mozdebug == 0.1 19:23:04 INFO - mozdevice == 0.51 19:23:04 INFO - mozfile == 1.2 19:23:04 INFO - mozhttpd == 0.7 19:23:04 INFO - mozinfo == 0.9 19:23:04 INFO - mozleak == 0.1 19:23:04 INFO - mozlog == 3.4 19:23:04 INFO - moznetwork == 0.27 19:23:04 INFO - mozprocess == 0.25 19:23:04 INFO - mozprofile == 0.28 19:23:04 INFO - mozrunner == 6.13 19:23:04 INFO - mozscreenshot == 0.1 19:23:04 INFO - mozsystemmonitor == 0.3 19:23:04 INFO - moztest == 0.8 19:23:04 INFO - mozversion == 1.4 19:23:04 INFO - psutil == 3.1.1 19:23:04 INFO - requests == 1.2.3 19:23:04 INFO - wsgiref == 0.1.2 19:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23: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')]} 19:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23: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')]} 19:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:04 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 0x16753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f0840>, '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 0x19f1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f1bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', '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 19:23:04 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 19:23:04 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 19:23:04 INFO - Using env: {'DISPLAY': ':0', 19:23:04 INFO - 'HOME': '/home/cltbld', 19:23:04 INFO - 'LANG': 'en_US.UTF-8', 19:23:04 INFO - 'LANGUAGE': 'en_US:en', 19:23:04 INFO - 'LOGNAME': 'cltbld', 19:23:04 INFO - 'MAIL': '/var/mail/cltbld', 19:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:04 INFO - 'MOZ_NO_REMOTE': '1', 19:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:04 INFO - 'NO_EM_RESTART': '1', 19:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:04 INFO - 'PWD': '/builds/slave/test', 19:23:04 INFO - 'SHELL': '/bin/bash', 19:23:04 INFO - 'SHLVL': '1', 19:23:04 INFO - 'TERM': 'linux', 19:23:04 INFO - 'TMOUT': '86400', 19:23:04 INFO - 'USER': 'cltbld', 19:23:04 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', 19:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:04 INFO - '_': '/tools/buildbot/bin/python'} 19:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:04 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)) 19:23:04 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)) 19:23:04 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)) 19:23:04 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)) 19:23:04 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)) 19:23:04 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)) 19:23:04 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)) 19:23:04 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)) 19:23:04 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)) 19:23:04 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:23:04 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 19:23:04 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 19:23:04 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 19:23:04 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 19:23:05 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:23:05 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)) 19:23:05 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)) 19:23:05 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)) 19:23:05 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)) 19:23:05 INFO - Installing collected packages: marionette-driver 19:23:05 INFO - Running setup.py install for marionette-driver 19:23:06 INFO - Successfully installed marionette-driver 19:23:06 INFO - Cleaning up... 19:23:06 INFO - Return code: 0 19:23:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:23:06 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')]} 19:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:06 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')]} 19:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:06 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 0x16753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f0840>, '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 0x19f1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f1bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', '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 19:23:06 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 19:23:06 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 19:23:06 INFO - Using env: {'DISPLAY': ':0', 19:23:06 INFO - 'HOME': '/home/cltbld', 19:23:06 INFO - 'LANG': 'en_US.UTF-8', 19:23:06 INFO - 'LANGUAGE': 'en_US:en', 19:23:06 INFO - 'LOGNAME': 'cltbld', 19:23:06 INFO - 'MAIL': '/var/mail/cltbld', 19:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:06 INFO - 'MOZ_NO_REMOTE': '1', 19:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:06 INFO - 'NO_EM_RESTART': '1', 19:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:06 INFO - 'PWD': '/builds/slave/test', 19:23:06 INFO - 'SHELL': '/bin/bash', 19:23:06 INFO - 'SHLVL': '1', 19:23:06 INFO - 'TERM': 'linux', 19:23:06 INFO - 'TMOUT': '86400', 19:23:06 INFO - 'USER': 'cltbld', 19:23:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', 19:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:06 INFO - '_': '/tools/buildbot/bin/python'} 19:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:23:06 INFO - Cleaning up... 19:23:06 INFO - Return code: 0 19:23:06 INFO - Running post-action listener: _resource_record_post_action 19:23:06 INFO - Running post-action listener: _start_resource_monitoring 19:23:06 INFO - Starting resource monitoring. 19:23:06 INFO - [mozharness: 2017-06-02 02:23:06.317490Z] Finished create-virtualenv step (success) 19:23:06 INFO - [mozharness: 2017-06-02 02:23:06.318041Z] Running install step. 19:23:06 INFO - Running pre-action listener: _resource_record_pre_action 19:23:06 INFO - Running main action method: install 19:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:06 INFO - Reading from file tmpfile_stdout 19:23:06 INFO - Detecting whether we're running mozinstall >=1.0... 19:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:23:06 INFO - Reading from file tmpfile_stdout 19:23:06 INFO - Output received: 19:23:06 INFO - Usage: mozinstall [options] installer 19:23:06 INFO - Options: 19:23:06 INFO - -h, --help show this help message and exit 19:23:06 INFO - -d DEST, --destination=DEST 19:23:06 INFO - Directory to install application into. [default: 19:23:06 INFO - "/builds/slave/test"] 19:23:06 INFO - --app=APP Application being installed. [default: firefox] 19:23:06 INFO - mkdir: /builds/slave/test/build/application 19:23:06 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'] 19:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:23:22 INFO - Reading from file tmpfile_stdout 19:23:22 INFO - Output received: 19:23:22 INFO - /builds/slave/test/build/application/firefox/firefox 19:23:22 INFO - Running post-action listener: _resource_record_post_action 19:23:22 INFO - [mozharness: 2017-06-02 02:23:22.213471Z] Finished install step (success) 19:23:22 INFO - [mozharness: 2017-06-02 02:23:22.213622Z] Running setup-mitmproxy step. 19:23:22 INFO - Running pre-action listener: _resource_record_pre_action 19:23:22 INFO - Running main action method: setup_mitmproxy 19:23:22 INFO - Skipping: mitmproxy is not required 19:23:22 INFO - Running post-action listener: _resource_record_post_action 19:23:22 INFO - [mozharness: 2017-06-02 02:23:22.214440Z] Finished setup-mitmproxy step (success) 19:23:22 INFO - [mozharness: 2017-06-02 02:23:22.214660Z] Running run-tests step. 19:23:22 INFO - Running pre-action listener: _resource_record_pre_action 19:23:22 INFO - Running main action method: run_tests 19:23:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:23:22 INFO - Python 2.7.3 19:23:22 INFO - Return code: 0 19:23:22 INFO - grabbing minidump binary from tooltool 19:23: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')]} 19:23:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f0840>, '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 0x19f1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f1bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:23:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:23:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:23:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:23:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:23:22 INFO - Return code: 0 19:23:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:23:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:23:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:23:22 INFO - ENV: RUST_BACKTRACE is now 1 19:23:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:23:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:23:22 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/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 19:23:22 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/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 19:23:22 INFO - Using env: {'DISPLAY': ':0', 19:23:22 INFO - 'HOME': '/home/cltbld', 19:23:22 INFO - 'LANG': 'en_US.UTF-8', 19:23:22 INFO - 'LANGUAGE': 'en_US:en', 19:23:22 INFO - 'LOGNAME': 'cltbld', 19:23:22 INFO - 'MAIL': '/var/mail/cltbld', 19:23:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:23:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:22 INFO - 'MOZ_NO_REMOTE': '1', 19:23:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:22 INFO - 'NO_EM_RESTART': '1', 19:23:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:22 INFO - 'PWD': '/builds/slave/test', 19:23:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:23:22 INFO - 'RUST_BACKTRACE': '1', 19:23:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:23:22 INFO - 'SHELL': '/bin/bash', 19:23:22 INFO - 'SHLVL': '1', 19:23:22 INFO - 'TERM': 'linux', 19:23:22 INFO - 'TMOUT': '86400', 19:23:22 INFO - 'USER': 'cltbld', 19:23:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734', 19:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:22 INFO - '_': '/tools/buildbot/bin/python'} 19:23:22 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/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 19:23:22 INFO - mozversion application_buildid: 20170602015025 19:23:22 INFO - mozversion application_changeset: aeb3d0ca558f034cbef1c5a68bd07dd738611494 19:23:22 INFO - mozversion application_display_name: Nightly 19:23:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:23:22 INFO - mozversion application_name: Firefox 19:23:22 INFO - mozversion application_remotingname: firefox 19:23:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:23:22 INFO - mozversion application_vendor: Mozilla 19:23:22 INFO - mozversion application_version: 55.0a1 19:23:22 INFO - mozversion platform_buildid: 20170602015025 19:23:22 INFO - mozversion platform_changeset: aeb3d0ca558f034cbef1c5a68bd07dd738611494 19:23:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:23:22 INFO - mozversion platform_version: 55.0a1 19:23:22 INFO - using testdate: 1496370202 19:23:22 INFO - actual date: 1496370202 19:23:22 INFO - starting webserver on 'localhost:56885' 19:23:22 INFO - SUITE-START | Running 2 tests 19:23:22 INFO - TEST-START | dromaeo_css 19:23:22 INFO - operating with platform_type : linux_ 19:23:22 INFO - Initialising browser for dromaeo_css test... 19:23:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56885/getInfo.html -profile /tmp/tmpd_pjig/profile 19:23:22 INFO - TEST-INFO | started process 6632 (/builds/slave/test/build/application/firefox/firefox http://localhost:56885/getInfo.html) 19:23:57 INFO - TEST-INFO | 6632: killed by SIGTERM 19:23:57 INFO - Browser initialized. 19:23:57 INFO - Running cycle 1/1 for dromaeo_css test... 19:23:57 INFO - TEST-INFO | started process 6837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd_pjig/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:09 INFO - PID 6837 | RSS: Main: 184508416 19:24:09 INFO - PID 6837 | 19:27:13 INFO - PID 6837 | Cycle 1(1): loaded http://localhost:56885/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56885/tests/dromaeo/cssquery-ext.html) 19:27:15 INFO - PID 6837 | RSS: Main: 178438144 19:27:15 INFO - PID 6837 | 19:30:17 INFO - PID 6837 | Cycle 1(1): loaded http://localhost:56885/tests/dromaeo/cssquery-ext.html (next: http://localhost:56885/tests/dromaeo/cssquery-jquery.html) 19:30:17 INFO - PID 6837 | RSS: Main: 184258560 19:30:17 INFO - PID 6837 | 19:33:19 INFO - PID 6837 | Cycle 1(1): loaded http://localhost:56885/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56885/tests/dromaeo/cssquery-mootools.html) 19:33:20 INFO - PID 6837 | RSS: Main: 180895744 19:33:20 INFO - PID 6837 | 19:36:22 INFO - PID 6837 | Cycle 1(1): loaded http://localhost:56885/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56885/tests/dromaeo/cssquery-prototype.html) 19:36:22 INFO - PID 6837 | RSS: Main: 185802752 19:36:22 INFO - PID 6837 | 19:39:25 INFO - PID 6837 | Cycle 1(1): loaded http://localhost:56885/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56885/tests/dromaeo/cssquery-yui.html) 19:39:26 INFO - PID 6837 | RSS: Main: 183492608 19:39:26 INFO - PID 6837 | 19:42:28 INFO - PID 6837 | Cycle 1(1): loaded http://localhost:56885/tests/dromaeo/cssquery-yui.html (next: http://localhost:56885/tests/dromaeo/cssquery-dojo.html) 19:42:28 INFO - PID 6837 | RSS: Main: 183177216 19:42:28 INFO - PID 6837 | 19:42:28 INFO - PID 6837 | __start_tp_report 19:42:28 INFO - PID 6837 | _x_x_mozilla_page_load 19:42:28 INFO - PID 6837 | _x_x_mozilla_page_load_details 19:42:28 INFO - PID 6837 | |i|pagename|runs| 19:42:28 INFO - PID 6837 | |0;dojo.html;2710.8373497590146;2716.877740501677;2731.1123884737453;2754.35272710913;2756.903508377206;5127.974360128203;5161.741912904354;5166;5184.844454666357;5198.428172900978;5112.514311140436;5155.484451554843;5215.217717342401;5245.606579506542;5303.310569625944;4644.303354496818;4659.254519276917;4661.160991021615;4661.953380466186;4698.107359601682;4626.7223966562115;4714.504976977402;4722.315264286676;4742.359781429514;4761.619070474371;4592.035672508777;4630.930536041962;4650.813967441332;4679;4703.482616912154;4561.521040290755;4649.628029757611;4651.279051746985;4680;4698.3187437821325;4603.746793926332;4610.354550362952;4625.028743963771;4625.791839367203;4656.278276867057;5177.559907407875;5178.689278643255;5192.7403629818355;5196.168613021936;5274;5583.35791383992;5595.636283641591;5610.18652295419;5647.3505546862225;5656.547476201894;5566.526845218162;5597.524210442118;5608.130739735307;5608.775648974036;5614.578906581982;5177.456367081478;5178.8964220716125;5198.688078715213;5241.449647787003;5253.947460525345;5699.914501282484;5755.395683453177;5769.134629805562;5785.595008349375;5797.507211887037;5436.972815135978;5497.532709719639;5523.199136125239;5546.168074788814;5594.13290939905;5593.105103183471;5602.887942241132;5605.971970140205;5608.775648973995;5645.915311270334;5448.291722076105;5546.722663866791;5573.108302671634;5574.331080270394;5592.608517403824;5531;5551.666899986014;5600.103983362643;5675.091985282335;5678.630888992202;4545.045540436479;4606.746628935441;4613.930791038137;4615.14619795339;4622.39908811859;3999.4000899864673;4000.0999775050964;4032.274190645653;4052.49343832021;4078.898027549276;4767.046590681877;4767.547083027107;4779.617630589544;4780.760961951889;4811.831585894477;5466.945330546644;5634.3802181759975;5640.605157638925;5648;5724.513416359656;4769.594584460359;4776.976115119472;4789.95210047902;4799.0401919616215;4815.446223684251;4919.3358896549225;4928.162212423897;4928.531789479994;4937.432195297515;4968.478309777493;5172.165035646967;5268.2624432578705;5279.445658205833;5281.234221037851;5282.234076059027;5599;5668.37647858727;5683.630564013326;5695.629784064023;5704.515116215002;5238.004779091961;5257.4742525747115;5260.263563101245;5278.5249327560705;5303.178007408857;5480.232767412645;5486.588505862156;5494.615376923737;5514.641548299348;5546.722663866871;5576.1356989666665;5671.546276297969;5705.572082093942;5779.595428319977;5791.189233507396;5426.213199086032;5501.587380946365;5508.55931525485;5511.421300763523;5523.392426833126;5266.526012658879;5439.265699130567;5439.966406382775;5525.033119204204;5531.308586426697;5390.245365648891;5392.218128371443;5403.216533602685;5410.377806552139;5446.291982042309;5482.616216864941;5503.477169668875;5507.284053073075;5509.752061157337;5510.834674959758;5255.6058295628745;5357;5418.349798024262;5427.511523962862;5438.700871452108 19:42:28 INFO - PID 6837 | |1;ext.html;712.1489819665502;755.9168491465938;777.96888124475;1022.6062965758181;1032.2413026425581;33496.832515837414;34116.48825267623;34122.65877341229;34132.14669633257;34140;35298;35746;35753.46369804455;35766.46350304741;35769.642303576955;6675.566088204276;6823.420009299216;6842.349976752201;6991.755288564901;6998.615076170809;6834.931650683504;6940.167179938415;6941.548799328028;6950.235474097845;6952.443804495653;6893.3795958363735;6934.375906168444;6939;6971.7908462745945;6995.79012629622;6927.9653601731925;6930.61881596512;6938.444924406035;6945.201301850301;6946.79159625212;6681;6760.290169532227;6762.154730658668;6774.796756097325;6779.2881747416795;32494.350112997843;32665.673343266502;32715.50926736101;32832.17919552006;33006.50490242624;3045.558394032875;3056.404001219763;3066.800657957248;3069.217349575866;3072.7234548890483;24744.3813904652;24768.504629907482;24799.752002479923;24836.130735424173;24957.376065598324;2633.9604905926426;2641.1944356971117;2646.431017331283;2647.8411295322344;2662.6671666041743;122040;124614;136883.31558342243;140676;141316;39717;39987.200255994714;39992;40005.1998960025;40085.198296033916;40948.59051409507;40960.79519602383;41225.1754964899;41335.793321033205;41337;12497.625071247878;12620;12620.242785432903;12625.936870315772;12677.429515671816;10117.392956422638;10134.493275336205;10142.340747851365;10155.086042256233;10168.593256269814;12508.562200322946;12522.248665079942;12590.307533085585;12698.238105713686;12897.935510322388;5107.897842043139;5122.667026643331;5132.640715149978;5159.535641792257;5182.32629758129;857.9828403431897;896.4128495835238;903.7785742492999;911.2163539356148;932.9766755831158;20707.585848283252;21770.238041668465;21770.564588708454;21828.672569911465;21953.341399758032;970.6554173268529;980.5048450532436;989.2036910287144;995.7759504111517;1014.1227837920146;10998.780024399468;11145.609903653332;11333.943330283295;11366.374849383197;11387.37369444672;172227;172975;173603;173947;174449;41675.37486937698;41783.791081045005;41810.37284440736;41834.79082604629;41866.79066604647;1152.9077673786078;1203.9518419263306;1216.2216181643755;1223.4311045363947;1232.3468561662332;20461.18155273832;20496.282630107875;21199.7880021204;21231.575368492235;21434.356969290948;29798.404031918806;29807;29815;29833.25416864596;29943.101706948826;153945;154071;154668;154792;155120;28212.43575128527;28438.146855594365;28630.570541441477;29824.552631710107;29881;36253.63746362608;36509.26981460409;36581.63418365782;37280.254394912496;37496.6250337504;27963.58054629223;28017.299567510974;28029.299267518476;28316.716832832233;29588.112356629335;28025.57961630618;28110.156695299174;28153;28951.883179061668;29746.405071898873;31495.582698779068;31593.36813263768;31665;31768;31813;26032.479350413265;26969;27816.72183278141;27854.860725697054;28312.85843570769;20138.697919530925;22541.88729056344;22639;22847.88576057109;22860.4284892879 19:42:28 INFO - PID 6837 | |2;jquery.html;408.75474715170884;411.22894572676233;425.7956181033104;431.1592394830081;435.68630585978104;13187.538436154737;13549.458021679146;17762.64474710505;18374.540636484093;18388.264469421225;18078.819211807877;18770;18791.342303019395;18805;18851.15169817358;5451.563874890019;5604.243427137346;5644.717764111799;5645;5661.631993920382;5498.45015498449;5528.806491772789;5599.860003499904;5600.1599760035915;5613.550915926716;5534.529564986981;5536.169574563807;5551.361593416768;5553.72231388431;5579.972100139514;5350.438203988583;5479.917801232985;5484.341878974528;5508.394076651605;5530.917036244439;4946.109700253953;5000.499950005007;5002.099622068026;5002.699838009695;5016.3980322361185;22012.779872201234;22307.55384892293;22401.215957441575;22423.551528969492;22459.438514037116;1561.461295852929;1631.8368163183704;1632.2002218912767;1633.0365084600144;1633.4772872680746;14636.268186590627;14937.775933361008;15301.234938253043;15435.228238588026;15464.613384665361;2085.7705652378227;2088.498760297533;2106.3365040012345;2127.0853532980814;2144.6890200920934;104727.4763626177;107865.46067269692;109214.45392772985;109244.4537777314;109336.4533177329;10565.418901960466;11114.610988615359;11120.944395277971;11378.772424551627;11824.349660768741;15894.76157857633;15978.201089945456;16078.276477558538;16086.83913160877;16087.919560402122;7464.813379665443;7470.4023678106705;7583.886241706379;7590.620468976529;7852.764417067498;6972.825679358057;6990.895136572955;7008.824779380454;7068.540544864567;7078.575285482888;7245.166805817398;7380.630968451664;7399.631068252283;7464.962675186589;7533.962330188314;2065.648839697255;2071.54426026274;2112.767595564487;2152.2036846366946;2160.341095965714;784.7488803582798;820.0446479850907;821.7699044267615;825.529448214512;849.3799526345803;16859;16918.238679259463;17046.840327062662;17624.20691068905;17760;819.3731795176694;819.8360327934437;838.149278482341;840.3991146330403;855.9358048146289;9177.724668259963;9361.204297634642;9558.761030974143;9571.18644915176;9767.169790567881;396942;398097;400815;405807;408145;83169.58415207885;84195;84473;84544;84614.5769271162;1010.5503051142318;1044.9059584637419;1055.8680164979378;1056.915446764257;1059.89930956559;14810.77783833265;15101.773473398127;15435.22823858825;15662.295196715948;15945.521634350987;43514;43559.56440435555;44048.339274910264;44472.555274446844;44514.77742611266;56027.71986140043;56093;56351.43648563462;56583.71708141433;56656.71671641615;9338.533073346442;9358.953205233931;9564.808703825745;9565.426074435556;9595;11957.461914214055;11981.820272696092;15487.84512154864;15657.451989180325;15677.451289204822;12592.874071259537;12945.288009159587;13059;13063.085584009028;13143.73712525725;11396.94301528487;11673.766524669629;11920.284782913053;11968.76062478728;12035.277883327028;13034.217946922836;13328.333583320602;13401;13408;13416.12795168311;9213.677521286723;9247;9289.72130836076;9310.115539023782;9365.625374984924;12713.8092928608;13273.66815829612;13406.396712147782;13616.38726257301;13946 19:42:28 INFO - PID 6837 | |3;mootools.html;1273.7070473791027;1300.4083142170307;1308.8625694302098;1320.9735805283901;1327.5818117293052;9525.09511596398;9929.553170107336;9941.155001824845;10496.580136794519;10681.893181068186;10566.52450639721;10708;10740.409277489734;10746.301490403119;10779.514921828537;2067.0284966065924;2112.661974084147;2115.027087539726;2115.7038014677955;2122.734658167729;1871.0738184598642;1903.2767548331615;1911.0253770577037;1913.7129430585453;1918.3094086128983;1860.2001139510005;1863.962720745591;1886.641538107762;1889.6031833315021;1891.186789680437;1963;1968.596437730269;1976.3478052242726;1983.4248068060244;1984.394759598322;1737.826217378252;1825.7809062912402;1829.140304057091;1974.5458544534695;2055.486128467883;10051.899481005243;10136.493175341204;10137.341072830242;10146.898531014744;10165.89834101657;5354.812581559666;5591.580631452616;5596.999999999959;5603.075492543725;5605.831825045255;3281.1797050737314;3360.781549199294;3394.7623666343366;3396.3037577296595;3402.931941361159;993.8857031441332;997.7106639074659;1007.2093406675798;1010.7877345757399;1017.8167929772638;14142.929285353508;14234.430622775077;14320.212388318638;14458.710825783426;14584.124952502778;4682.030338389758;4724.740139292372;4810.037992401533;4827.348307978378;4852.272159176152;11104.833427498594;11122.721931951766;11126.499307531181;11132.49903754333;11150.330980141056;5236.790528378899;5356.571474282048;5371.811986580451;5383.7846486140115;5383.919241211385;4819.6867203631655;4911.336969509142;4931.358923340014;4937.7777999990085;4965.205567109245;3759.191773768653;3812.8093595320124;3814.675752561008;3872.8450861965207;3879.7866117363815;1110.2894147745449;1116.2019156303281;1139.4055189022029;1147.6671765188169;1149.9252548584316;604.1783174882157;632.2349956552531;632.8006677896448;637.8660481298979;640.2668944059026;4893.828715994994;5027.296178535008;5032.345795046621;5070.61970352225;5177.637565370388;513;522.1619301021881;817.7692572678081;836.6820608168979;843.9198276163754;3452.58568971725;3467.6822807333556;3615.6745892869767;3637.5271214741915;3785.6592906637984;13270.336483175803;13509.324533773271;13548.59354219375;13592.86407135916;13711.17732936007;13407.329633518286;13409.932950335186;13446.394912228972;13555.59333220005;13569.1858488491;6634.535582509178;6874.896876546856;6959.234484206733;7223.133224013152;7662.233776622405;5630.5214056805635;5808.680522571299;5857.179994800646;5904.704764761831;5975.133605627247;11855.051595872137;12132.75734485323;12243.265404075784;12350.135490515577;12354.44405001795;12026.579069732517;12385.19496232778;12387.132900697225;12388.132830701765;12573.811392828931;8828.337874659297;8905.643774248958;8908.86636700437;8975.910240897769;8978.820423591362;9048.90951090507;9175.724728258163;9179.862302065609;9192.678256260999;9194.12655797698;7405.5926924019695;7582.848343032998;7585.393168546613;7678.078630564145;7834.1382447929545;7161.319674630901;7283;7285.162206346338;7366.373858221897;7375.963120184365;6817.625030623363;6855.314468553105;6873.518853680194;6910.827229319308;6927.134108236471;4957.529034741694;4965.006998600222;5048.5203905628905;5087.54212120896;5240.082985477602;4766.809327626856;4896.2410826321975;4931.3835770528685;4967.081089998362;5045.470225626404 19:42:28 INFO - PID 6837 | |4;prototype.html;330.08895448561975;348.5312255017002;353.1770973631439;353.3921654753822;354.0264273248566;5422.9728851355685;5545.77816887324;5572.6099173057855;5606.831795046145;5613.635113717611;5300.920486192701;5386.676799392029;5402.243685883979;5420.457954204578;5426.050441172789;4107.671386289097;4112.753234805907;4117.855875044374;4117.958820411787;4133.834646614132;4124.855630052949;4148.398482220076;4149;4152.439420678215;4171.353440216772;4095.8736347504528;4104.261232978063;4109.075458021936;4113;4126.525449573308;4115.506139263308;4116.176764647083;4117.958820411803;4118.938215926763;4120.21715873983;3552.928941421157;3578.1233597768455;3588.946165807515;3589.353916295066;3590.8025058621765;5297.496737809902;5345.118055520835;5350.785968561292;5352.91970620441;5369.731513424314;4835.105505481497;4836.274558816171;4838.467768545457;4846.878828029292;4856.465788763233;5786.739596718157;5796.072628379481;5801.882312955783;5806.21616081832;5806.59353845231;4012.478377810895;4028.3554631258858;4028.536718277406;4030.2745505808944;4039.555648878621;5884.470397664188;6057.969710151465;6077.301110372276;6192.411720886508;6194.752209911598;3888.300105980951;4046.393041043867;4077.103037331782;4099.713020088565;4107.301758700968;4127.29835927893;4163.292240319153;4170.207660544487;4176.227397931392;4184.623383895464;4647.233206520954;4783.378160839069;4786.210275304536;4791.95208047922;4794.880127996828;5761.711914404263;5769.1923130761725;5787.450192231731;5788.623739456922;5798.797042103506;1402.5862370600698;1439.4458133618632;1439.6832696806687;1440.8415074341815;1444.162385816224;915.1376947910969;946.4226821638932;962.9181519570775;965.3918031640022;965.560669895196;4971.283024521829;4993.825216117419;5001.7499125043605;5002.674826136289;5022.9748851256245;5988.131720900445;5997.220361352996;6000.729967151488;6011.188489553854;6011.458968692838;4954.430240522314;4996.850724333423;4999.925001124986;5005.874853128701;5021.196608542616;3156.526521021865;3174.333559809771;3178.9682103179134;3189.0387411742076;3196.5684632574303;5602.551795856321;5617.831465056055;5626.409227031103;5642.802501912495;5646.717664116778;6094.2077529920825;6130.264368275835;6152.907706384408;6161.168242287324;6163;5573.247611572467;5583.274174357389;5589.211452335295;5627.846291510149;5628.437156284339;5886.764529418775;5979.701014949148;5984.700764961647;6021.909671354845;6035.245594300713;5887.411258874078;5902.527797776082;5916.26046744157;5925.822225333247;5935.347111817783;5294.590961112607;5559.944400555943;5635.971820140873;5642.435756424325;5656.43435656431;4065.959340406558;4083.428320035257;4088.304988151962;4101.302778527717;4115.074108325723;5959.642421454553;5973.641581505123;5976.731047102804;5976.850578735392;5986.3238293277955;5664.801731939362;5770.336411312753;5841.795537156179;5844.597296648689;5877.118432235028;5835.620684655484;5856.795012174553;5866.325372582208;5879.882402352015;5886.352501224947;5770.855728606818;5775.220345253505;5785;5805.709714514342;5814.389489103753;5873.2658417697785;5900.7049647518315;5913.113033045078;5913.704314784158;5932.228810254812;5704.686242256716;5709.143628455598;5715.2855893013375;5721.568333458346;5764.414785933734 19:42:28 INFO - PID 6837 | |5;yui.html;717.6662851773924;733.4169335378377;739.6412739821186;750.7484992527503;751.6392131776747;12499.937500312497;13313.600591982231;13352.39914203862;14403.351849166786;15945.123018233993;15588.922055389736;15707.84292157078;15825.84174158258;15838.604034899134;15870.920645396785;889.3152272749978;891.8305521950808;897.0356866368679;897.1387468030698;897.4301318662631;815.8449894520052;884.8672699095123;886.2998231397188;908.3686837647838;913.7304495173939;926.5737760630085;930.0234753508822;931.5388882503137;932.3799673217302;932.7388331267256;921.9124183202586;924.6856068936527;925.694520808135;926.0739260739294;927.5825878354767;672.9764458243937;674.6188403552027;676.4216594811463;676.4723515657795;677.5799004617169;14483.420663173565;14539.3457294422;14573.562793116223;14611.78082328766;14691;16739.16304184798;17179.484615461555;17237;17317.393891213746;17346.306147754076;12494.562690305887;13001.739965200737;13053.673658158623;13120.868791312156;13139.27733974631;3019.3961207758534;3028.4851575232265;3036.3016506203476;3037.3773376457775;3046.7105624965593;86315.56842215812;86350.568247159;86554.5672271641;88852;88922.10629458692;13182.802257966137;13185.73628527424;13203.66990825237;13220.867791322156;13270.27013514266;23677.7632223679;24105.879470602536;24110.39724006914;24206.63690044651;24268.75731242665;5535.640183388067;5663.037283661787;5699.686517241592;5729.914051289234;5740.856478588069;2931.0327591894625;2978.9851050744605;3004.2189030852137;3004.4291584598855;3033.0445909538425;3974.7217694761666;4158.7296825706235;4205.990562265034;4209.116085621992;4227.830886764556;695.5722230828004;702.5749421599961;705.9164182979102;707.398711095575;708.9042979197742;533.4239021856386;540.2301720048914;540.2517513244106;544.0913674164156;546.1425561867829;9783.46190959504;10183.490825458697;10457.320274182153;10520.684379468628;10635.149188064936;526.4051621667492;544.9455054494598;550.1225545255311;559.0551967175461;561.7977528089884;4416.24923762961;4547.8635640930825;4576.8626941191815;4583.816647334069;4741.2651039089;89340;89351.55324223338;91433;91473.54263228775;93432.53283733538;77116.61441692755;79970;80289;80296;80452.59773701095;69182;70039.64980175067;70654;71421;71745.64127179331;8979.416337938013;9062.456252624863;9093.272538196796;9152.313576481658;9286.6285348588;29485.26286842846;29975.550366744952;30183.189008659552;30563;30643.54034689526;38203;38451;39148.41277380899;39435.40846887242;40204.597954020086;12595.118341715992;12642.620721378373;12908.290044047291;12931.353432328158;13079.803802943154;14350;14386.712265754835;14531.709365812836;14660.85339146595;14713;11874.287542747463;12697.365131743562;14419.78370324467;14506.637334066732;14757.409703611735;13273.734525309634;13427.12723672958;13557.576454472139;13629.86370136286;14213.857861421253;14474.348654310792;14920.62698432548;15065.246737662854;15073.095614263179;16526.256318465938;10127.7468063299;10466.319689220176;10895.400752958663;11063.170262230204;11099.001089901947;11780.469878855643;12012.519499220283;12179.634610961686;12222.6944326389;12300.446479908605 19:42:28 INFO - PID 6837 | __end_tp_report 19:42:28 INFO - PID 6837 | __start_cc_report 19:42:28 INFO - PID 6837 | _x_x_mozilla_cycle_collect,377 19:42:28 INFO - PID 6837 | __end_cc_report 19:42:28 INFO - PID 6837 | __startTimestamp1496371348294__endTimestamp 19:42:28 INFO - PID 6837 | 19:42:28 INFO - PID 6837 | ------- Summary: start ------- 19:42:28 INFO - PID 6837 | Number of tests: 6 19:42:28 INFO - PID 6837 | 19:42:28 INFO - PID 6837 | [#0] dojo.html Cycles:165 Average:5135.82 Median:5279.45 stddev:601.75 (11.4%) stddev-sans-first:572.74 19:42:28 INFO - PID 6837 | Values: 2710.8 2716.9 2731.1 2754.4 2756.9 5128.0 5161.7 5166.0 5184.8 5198.4 5112.5 5155.5 5215.2 5245.6 5303.3 4644.3 4659.3 4661.2 4662.0 4698.1 4626.7 4714.5 4722.3 4742.4 4761.6 4592.0 4630.9 4650.8 4679.0 4703.5 4561.5 4649.6 4651.3 4680.0 4698.3 4603.7 4610.4 4625.0 4625.8 4656.3 5177.6 5178.7 5192.7 5196.2 5274.0 5583.4 5595.6 5610.2 5647.4 5656.5 5566.5 5597.5 5608.1 5608.8 5614.6 5177.5 5178.9 5198.7 5241.4 5253.9 5699.9 5755.4 5769.1 5785.6 5797.5 5437.0 5497.5 5523.2 5546.2 5594.1 5593.1 5602.9 5606.0 5608.8 5645.9 5448.3 5546.7 5573.1 5574.3 5592.6 5531.0 5551.7 5600.1 5675.1 5678.6 4545.0 4606.7 4613.9 4615.1 4622.4 3999.4 4000.1 4032.3 4052.5 4078.9 4767.0 4767.5 4779.6 4780.8 4811.8 5466.9 5634.4 5640.6 5648.0 5724.5 4769.6 4777.0 4790.0 4799.0 4815.4 4919.3 4928.2 4928.5 4937.4 4968.5 5172.2 5268.3 5279.4 5281.2 5282.2 5599.0 5668.4 5683.6 5695.6 5704.5 5238.0 5257.5 5260.3 5278.5 5303.2 5480.2 5486.6 5494.6 5514.6 5546.7 5576.1 5671.5 5705.6 5779.6 5791.2 5426.2 5501.6 5508.6 5511.4 5523.4 5266.5 5439.3 5440.0 5525.0 5531.3 5390.2 5392.2 5403.2 5410.4 5446.3 5482.6 5503.5 5507.3 5509.8 5510.8 5255.6 5357.0 5418.3 5427.5 5438.7 19:42:28 INFO - PID 6837 | 19:42:28 INFO - PID 6837 | [#1] ext.html Cycles:180 Average:30099.07 Median:29857.13 stddev:39895.65 (133.6%) stddev-sans-first:39946.54 19:42:28 INFO - PID 6837 | Values: 712.1 755.9 778.0 1022.6 1032.2 33496.8 34116.5 34122.7 34132.1 34140.0 35298.0 35746.0 35753.5 35766.5 35769.6 6675.6 6823.4 6842.3 6991.8 6998.6 6834.9 6940.2 6941.5 6950.2 6952.4 6893.4 6934.4 6939.0 6971.8 6995.8 6928.0 6930.6 6938.4 6945.2 6946.8 6681.0 6760.3 6762.2 6774.8 6779.3 32494.4 32665.7 32715.5 32832.2 33006.5 3045.6 3056.4 3066.8 3069.2 3072.7 24744.4 24768.5 24799.8 24836.1 24957.4 2634.0 2641.2 2646.4 2647.8 2662.7 122040.0 124614.0 136883.3 140676.0 141316.0 39717.0 39987.2 39992.0 40005.2 40085.2 40948.6 40960.8 41225.2 41335.8 41337.0 12497.6 12620.0 12620.2 12625.9 12677.4 10117.4 10134.5 10142.3 10155.1 10168.6 12508.6 12522.2 12590.3 12698.2 12897.9 5107.9 5122.7 5132.6 5159.5 5182.3 858.0 896.4 903.8 911.2 933.0 20707.6 21770.2 21770.6 21828.7 21953.3 970.7 980.5 989.2 995.8 1014.1 10998.8 11145.6 11333.9 11366.4 11387.4 172227.0 172975.0 173603.0 173947.0 174449.0 41675.4 41783.8 41810.4 41834.8 41866.8 1152.9 1204.0 1216.2 1223.4 1232.3 20461.2 20496.3 21199.8 21231.6 21434.4 29798.4 29807.0 29815.0 29833.3 29943.1 153945.0 154071.0 154668.0 154792.0 155120.0 28212.4 28438.1 28630.6 29824.6 29881.0 36253.6 36509.3 36581.6 37280.3 37496.6 27963.6 28017.3 28029.3 28316.7 29588.1 28025.6 28110.2 28153.0 28951.9 29746.4 31495.6 31593.4 31665.0 31768.0 31813.0 26032.5 26969.0 27816.7 27854.9 28312.9 20138.7 22541.9 22639.0 22847.9 22860.4 19:42:28 INFO - PID 6837 | 19:42:28 INFO - PID 6837 | [#2] jquery.html Cycles:180 Average:27191.61 Median:397519.50 stddev:67389.70 (17.0%) stddev-sans-first:67548.75 19:42:28 INFO - PID 6837 | Values: 408.8 411.2 425.8 431.2 435.7 13187.5 13549.5 17762.6 18374.5 18388.3 18078.8 18770.0 18791.3 18805.0 18851.2 5451.6 5604.2 5644.7 5645.0 5661.6 5498.5 5528.8 5599.9 5600.2 5613.6 5534.5 5536.2 5551.4 5553.7 5580.0 5350.4 5479.9 5484.3 5508.4 5530.9 4946.1 5000.5 5002.1 5002.7 5016.4 22012.8 22307.6 22401.2 22423.6 22459.4 1561.5 1631.8 1632.2 1633.0 1633.5 14636.3 14937.8 15301.2 15435.2 15464.6 2085.8 2088.5 2106.3 2127.1 2144.7 104727.5 107865.5 109214.5 109244.5 109336.5 10565.4 11114.6 11120.9 11378.8 11824.3 15894.8 15978.2 16078.3 16086.8 16087.9 7464.8 7470.4 7583.9 7590.6 7852.8 6972.8 6990.9 7008.8 7068.5 7078.6 7245.2 7380.6 7399.6 7465.0 7534.0 2065.6 2071.5 2112.8 2152.2 2160.3 784.7 820.0 821.8 825.5 849.4 16859.0 16918.2 17046.8 17624.2 17760.0 819.4 819.8 838.1 840.4 855.9 9177.7 9361.2 9558.8 9571.2 9767.2 396942.0 398097.0 400815.0 405807.0 408145.0 83169.6 84195.0 84473.0 84544.0 84614.6 1010.6 1044.9 1055.9 1056.9 1059.9 14810.8 15101.8 15435.2 15662.3 15945.5 43514.0 43559.6 44048.3 44472.6 44514.8 56027.7 56093.0 56351.4 56583.7 56656.7 9338.5 9359.0 9564.8 9565.4 9595.0 11957.5 11981.8 15487.8 15657.5 15677.5 12592.9 12945.3 13059.0 13063.1 13143.7 11396.9 11673.8 11920.3 11968.8 12035.3 13034.2 13328.3 13401.0 13408.0 13416.1 9213.7 9247.0 9289.7 9310.1 9365.6 12713.8 13273.7 13406.4 13616.4 13946.0 19:42:28 INFO - PID 6837 | 19:42:28 INFO - PID 6837 | [#3] mootools.html Cycles:180 Average:6157.46 Median:3799.23 stddev:4097.40 (107.8%) stddev-sans-first:4092.46 19:42:28 INFO - PID 6837 | Values: 1273.7 1300.4 1308.9 1321.0 1327.6 9525.1 9929.6 9941.2 10496.6 10681.9 10566.5 10708.0 10740.4 10746.3 10779.5 2067.0 2112.7 2115.0 2115.7 2122.7 1871.1 1903.3 1911.0 1913.7 1918.3 1860.2 1864.0 1886.6 1889.6 1891.2 1963.0 1968.6 1976.3 1983.4 1984.4 1737.8 1825.8 1829.1 1974.5 2055.5 10051.9 10136.5 10137.3 10146.9 10165.9 5354.8 5591.6 5597.0 5603.1 5605.8 3281.2 3360.8 3394.8 3396.3 3402.9 993.9 997.7 1007.2 1010.8 1017.8 14142.9 14234.4 14320.2 14458.7 14584.1 4682.0 4724.7 4810.0 4827.3 4852.3 11104.8 11122.7 11126.5 11132.5 11150.3 5236.8 5356.6 5371.8 5383.8 5383.9 4819.7 4911.3 4931.4 4937.8 4965.2 3759.2 3812.8 3814.7 3872.8 3879.8 1110.3 1116.2 1139.4 1147.7 1149.9 604.2 632.2 632.8 637.9 640.3 4893.8 5027.3 5032.3 5070.6 5177.6 513.0 522.2 817.8 836.7 843.9 3452.6 3467.7 3615.7 3637.5 3785.7 13270.3 13509.3 13548.6 13592.9 13711.2 13407.3 13409.9 13446.4 13555.6 13569.2 6634.5 6874.9 6959.2 7223.1 7662.2 5630.5 5808.7 5857.2 5904.7 5975.1 11855.1 12132.8 12243.3 12350.1 12354.4 12026.6 12385.2 12387.1 12388.1 12573.8 8828.3 8905.6 8908.9 8975.9 8978.8 9048.9 9175.7 9179.9 9192.7 9194.1 7405.6 7582.8 7585.4 7678.1 7834.1 7161.3 7283.0 7285.2 7366.4 7376.0 6817.6 6855.3 6873.5 6910.8 6927.1 4957.5 4965.0 5048.5 5087.5 5240.1 4766.8 4896.2 4931.4 4967.1 5045.5 19:42:28 INFO - PID 6837 | 19:42:28 INFO - PID 6837 | [#4] prototype.html Cycles:180 Average:4770.48 Median:5424.51 stddev:1430.53 (26.4%) stddev-sans-first:1395.17 19:42:28 INFO - PID 6837 | Values: 330.1 348.5 353.2 353.4 354.0 5423.0 5545.8 5572.6 5606.8 5613.6 5300.9 5386.7 5402.2 5420.5 5426.1 4107.7 4112.8 4117.9 4118.0 4133.8 4124.9 4148.4 4149.0 4152.4 4171.4 4095.9 4104.3 4109.1 4113.0 4126.5 4115.5 4116.2 4118.0 4118.9 4120.2 3552.9 3578.1 3588.9 3589.4 3590.8 5297.5 5345.1 5350.8 5352.9 5369.7 4835.1 4836.3 4838.5 4846.9 4856.5 5786.7 5796.1 5801.9 5806.2 5806.6 4012.5 4028.4 4028.5 4030.3 4039.6 5884.5 6058.0 6077.3 6192.4 6194.8 3888.3 4046.4 4077.1 4099.7 4107.3 4127.3 4163.3 4170.2 4176.2 4184.6 4647.2 4783.4 4786.2 4792.0 4794.9 5761.7 5769.2 5787.5 5788.6 5798.8 1402.6 1439.4 1439.7 1440.8 1444.2 915.1 946.4 962.9 965.4 965.6 4971.3 4993.8 5001.7 5002.7 5023.0 5988.1 5997.2 6000.7 6011.2 6011.5 4954.4 4996.9 4999.9 5005.9 5021.2 3156.5 3174.3 3179.0 3189.0 3196.6 5602.6 5617.8 5626.4 5642.8 5646.7 6094.2 6130.3 6152.9 6161.2 6163.0 5573.2 5583.3 5589.2 5627.8 5628.4 5886.8 5979.7 5984.7 6021.9 6035.2 5887.4 5902.5 5916.3 5925.8 5935.3 5294.6 5559.9 5636.0 5642.4 5656.4 4066.0 4083.4 4088.3 4101.3 4115.1 5959.6 5973.6 5976.7 5976.9 5986.3 5664.8 5770.3 5841.8 5844.6 5877.1 5835.6 5856.8 5866.3 5879.9 5886.4 5770.9 5775.2 5785.0 5805.7 5814.4 5873.3 5900.7 5913.1 5913.7 5932.2 5704.7 5709.1 5715.3 5721.6 5764.4 19:42:28 INFO - PID 6837 | 19:42:28 INFO - PID 6837 | [#5] yui.html Cycles:180 Average:18025.79 Median:38799.71 stddev:24445.25 (63.0%) stddev-sans-first:24479.27 19:42:28 INFO - PID 6837 | Values: 717.7 733.4 739.6 750.7 751.6 12499.9 13313.6 13352.4 14403.4 15945.1 15588.9 15707.8 15825.8 15838.6 15870.9 889.3 891.8 897.0 897.1 897.4 815.8 884.9 886.3 908.4 913.7 926.6 930.0 931.5 932.4 932.7 921.9 924.7 925.7 926.1 927.6 673.0 674.6 676.4 676.5 677.6 14483.4 14539.3 14573.6 14611.8 14691.0 16739.2 17179.5 17237.0 17317.4 17346.3 12494.6 13001.7 13053.7 13120.9 13139.3 3019.4 3028.5 3036.3 3037.4 3046.7 86315.6 86350.6 86554.6 88852.0 88922.1 13182.8 13185.7 13203.7 13220.9 13270.3 23677.8 24105.9 24110.4 24206.6 24268.8 5535.6 5663.0 5699.7 5729.9 5740.9 2931.0 2979.0 3004.2 3004.4 3033.0 3974.7 4158.7 4206.0 4209.1 4227.8 695.6 702.6 705.9 707.4 708.9 533.4 540.2 540.3 544.1 546.1 9783.5 10183.5 10457.3 10520.7 10635.1 526.4 544.9 550.1 559.1 561.8 4416.2 4547.9 4576.9 4583.8 4741.3 89340.0 89351.6 91433.0 91473.5 93432.5 77116.6 79970.0 80289.0 80296.0 80452.6 69182.0 70039.6 70654.0 71421.0 71745.6 8979.4 9062.5 9093.3 9152.3 9286.6 29485.3 29975.6 30183.2 30563.0 30643.5 38203.0 38451.0 39148.4 39435.4 40204.6 12595.1 12642.6 12908.3 12931.4 13079.8 14350.0 14386.7 14531.7 14660.9 14713.0 11874.3 12697.4 14419.8 14506.6 14757.4 13273.7 13427.1 13557.6 13629.9 14213.9 14474.3 14920.6 15065.2 15073.1 16526.3 10127.7 10466.3 10895.4 11063.2 11099.0 11780.5 12012.5 12179.6 12222.7 12300.4 19:42:28 INFO - PID 6837 | -------- Summary: end -------- 19:42:28 INFO - PID 6837 | 19:42:29 INFO - TEST-INFO | 6837: exit 0 19:42:29 INFO - TEST-OK | dromaeo_css | took 1146711ms 19:42:29 INFO - TEST-START | kraken 19:42:29 INFO - operating with platform_type : linux_ 19:42:29 INFO - Initialising browser for kraken test... 19:42:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56885/getInfo.html -profile /tmp/tmphMkYwW/profile 19:42:29 INFO - TEST-INFO | started process 7241 (/builds/slave/test/build/application/firefox/firefox http://localhost:56885/getInfo.html) 19:43:04 INFO - TEST-INFO | 7241: killed by SIGTERM 19:43:04 INFO - Browser initialized. 19:43:04 INFO - Running cycle 1/1 for kraken test... 19:43:04 INFO - TEST-INFO | started process 7446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphMkYwW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:43:16 INFO - PID 7446 | RSS: Main: 184573952 19:43:16 INFO - PID 7446 | 19:43:18 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56885/tests/kraken/driver.html?testName=audio-beat-detection) 19:43:19 INFO - PID 7446 | RSS: Main: 188506112 19:43:19 INFO - PID 7446 | 19:43:22 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56885/tests/kraken/driver.html?testName=audio-dft) 19:43:23 INFO - PID 7446 | RSS: Main: 187314176 19:43:23 INFO - PID 7446 | 19:43:26 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56885/tests/kraken/driver.html?testName=audio-fft) 19:43:26 INFO - PID 7446 | RSS: Main: 181932032 19:43:26 INFO - PID 7446 | 19:43:28 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56885/tests/kraken/driver.html?testName=audio-oscillator) 19:43:29 INFO - PID 7446 | RSS: Main: 182530048 19:43:29 INFO - PID 7446 | 19:43:31 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56885/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:43:32 INFO - PID 7446 | RSS: Main: 182640640 19:43:32 INFO - PID 7446 | 19:43:35 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56885/tests/kraken/driver.html?testName=imaging-darkroom) 19:43:35 INFO - PID 7446 | RSS: Main: 183926784 19:43:35 INFO - PID 7446 | 19:43:39 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56885/tests/kraken/driver.html?testName=imaging-desaturate) 19:43:40 INFO - PID 7446 | RSS: Main: 183427072 19:43:40 INFO - PID 7446 | 19:43:43 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56885/tests/kraken/driver.html?testName=json-parse-financial) 19:43:43 INFO - PID 7446 | RSS: Main: 184086528 19:43:43 INFO - PID 7446 | 19:43:45 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56885/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:43:45 INFO - PID 7446 | RSS: Main: 184201216 19:43:45 INFO - PID 7446 | 19:43:47 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56885/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:43:48 INFO - PID 7446 | RSS: Main: 183476224 19:43:48 INFO - PID 7446 | 19:43:50 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56885/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:43:51 INFO - PID 7446 | RSS: Main: 183222272 19:43:51 INFO - PID 7446 | 19:43:54 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:43:54 INFO - PID 7446 | RSS: Main: 183746560 19:43:54 INFO - PID 7446 | 19:43:57 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:43:58 INFO - PID 7446 | RSS: Main: 183635968 19:43:58 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | Cycle 1(1): loaded http://localhost:56885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56885/tests/kraken/driver.html?testName=ai-astar) 19:44:00 INFO - PID 7446 | RSS: Main: 184893440 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | __start_tp_report 19:44:00 INFO - PID 7446 | _x_x_mozilla_page_load 19:44:00 INFO - PID 7446 | _x_x_mozilla_page_load_details 19:44:00 INFO - PID 7446 | |i|pagename|runs| 19:44:00 INFO - PID 7446 | |0;ai-astar;102;111;112;110;110;112;112;109;111;111 19:44:00 INFO - PID 7446 | |1;audio-beat-detection;149;123;123;170;124;127;131;124;165;122 19:44:00 INFO - PID 7446 | |2;audio-dft;165;163;162;163;164;169;167;174;165;164 19:44:00 INFO - PID 7446 | |3;audio-fft;74;82;75;110;75;75;77;78;101;78 19:44:00 INFO - PID 7446 | |4;audio-oscillator;83;83;109;84;83;83;97;84;84;112 19:44:00 INFO - PID 7446 | |5;imaging-gaussian-blur;113;115;114;113;115;113;114;115;114;114 19:44:00 INFO - PID 7446 | |6;imaging-darkroom;151;150;150;151;150;150;151;152;150;150 19:44:00 INFO - PID 7446 | |7;imaging-desaturate;95;95;95;94;95;99;96;95;94;95 19:44:00 INFO - PID 7446 | |8;json-parse-financial;54;55;54;56;55;55;57;57;57;58 19:44:00 INFO - PID 7446 | |9;json-stringify-tinderbox;56;56;59;55;55;56;56;57;56;56 19:44:00 INFO - PID 7446 | |10;stanford-crypto-aes;86;94;87;88;86;86;89;88;136;86 19:44:00 INFO - PID 7446 | |11;stanford-crypto-ccm;131;133;131;130;136;129;130;129;133;140 19:44:00 INFO - PID 7446 | |12;stanford-crypto-pbkdf2;201;189;195;196;183;192;197;196;191;203 19:44:00 INFO - PID 7446 | |13;stanford-crypto-sha256-iterative;75;78;71;75;71;74;74;71;72;72 19:44:00 INFO - PID 7446 | __end_tp_report 19:44:00 INFO - PID 7446 | __start_cc_report 19:44:00 INFO - PID 7446 | _x_x_mozilla_cycle_collect,1044 19:44:00 INFO - PID 7446 | __end_cc_report 19:44:00 INFO - PID 7446 | __startTimestamp1496371440532__endTimestamp 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | ------- Summary: start ------- 19:44:00 INFO - PID 7446 | Number of tests: 14 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.98 (2.7%) stddev-sans-first:1.05 19:44:00 INFO - PID 7446 | Values: 102.0 111.0 112.0 110.0 110.0 112.0 112.0 109.0 111.0 111.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:129.00 stddev:18.54 (14.4%) stddev-sans-first:19.04 19:44:00 INFO - PID 7446 | Values: 149.0 123.0 123.0 170.0 124.0 127.0 131.0 124.0 165.0 122.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:3.60 (2.2%) stddev-sans-first:3.81 19:44:00 INFO - PID 7446 | Values: 165.0 163.0 162.0 163.0 164.0 169.0 167.0 174.0 165.0 164.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:12.52 (16.5%) stddev-sans-first:12.89 19:44:00 INFO - PID 7446 | Values: 74.0 82.0 75.0 110.0 75.0 75.0 77.0 78.0 101.0 78.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:83.50 stddev:11.54 (13.8%) stddev-sans-first:11.94 19:44:00 INFO - PID 7446 | Values: 83.0 83.0 109.0 84.0 83.0 83.0 97.0 84.0 84.0 112.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 19:44:00 INFO - PID 7446 | Values: 113.0 115.0 114.0 113.0 115.0 113.0 114.0 115.0 114.0 114.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 19:44:00 INFO - PID 7446 | Values: 151.0 150.0 150.0 151.0 150.0 150.0 151.0 152.0 150.0 150.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.42 (1.5%) stddev-sans-first:1.50 19:44:00 INFO - PID 7446 | Values: 95.0 95.0 95.0 94.0 95.0 99.0 96.0 95.0 94.0 95.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.50 stddev:1.40 (2.5%) stddev-sans-first:1.32 19:44:00 INFO - PID 7446 | Values: 54.0 55.0 54.0 56.0 55.0 55.0 57.0 57.0 57.0 58.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:1.14 (2.0%) stddev-sans-first:1.20 19:44:00 INFO - PID 7446 | Values: 56.0 56.0 59.0 55.0 55.0 56.0 56.0 57.0 56.0 56.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:87.50 stddev:15.44 (17.6%) stddev-sans-first:16.19 19:44:00 INFO - PID 7446 | Values: 86.0 94.0 87.0 88.0 86.0 86.0 89.0 88.0 136.0 86.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:132.00 stddev:3.49 (2.6%) stddev-sans-first:3.67 19:44:00 INFO - PID 7446 | Values: 131.0 133.0 131.0 130.0 136.0 129.0 130.0 129.0 133.0 140.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.30 Median:196.00 stddev:5.83 (3.0%) stddev-sans-first:5.66 19:44:00 INFO - PID 7446 | Values: 201.0 189.0 195.0 196.0 183.0 192.0 197.0 196.0 191.0 203.0 19:44:00 INFO - PID 7446 | 19:44:00 INFO - PID 7446 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:74.00 stddev:2.31 (3.1%) stddev-sans-first:2.37 19:44:00 INFO - PID 7446 | Values: 75.0 78.0 71.0 75.0 71.0 74.0 74.0 71.0 72.0 72.0 19:44:00 INFO - PID 7446 | -------- Summary: end -------- 19:44:00 INFO - PID 7446 | 19:44:01 INFO - TEST-INFO | 7446: exit 0 19:44:01 INFO - TEST-OK | kraken | took 92611ms 19:44:01 INFO - SUITE-END | took 1239s 19:44:02 INFO - Completed test suite (00:20:39) 19:44:02 INFO - javascript benchmark 19:44:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6759.422446531355, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2710.8373497590146, 2716.877740501677, 2731.1123884737453, 2754.35272710913, 2756.903508377206, 5127.974360128203, 5161.741912904354, 5166.0, 5184.844454666357, 5198.428172900978, 5112.514311140436, 5155.484451554843, 5215.217717342401, 5245.606579506542, 5303.310569625944, 4644.303354496818, 4659.254519276917, 4661.160991021615, 4661.953380466186, 4698.107359601682, 4626.7223966562115, 4714.504976977402, 4722.315264286676, 4742.359781429514, 4761.619070474371, 4592.035672508777, 4630.930536041962, 4650.813967441332, 4679.0, 4703.482616912154, 4561.521040290755, 4649.628029757611, 4651.279051746985, 4680.0, 4698.3187437821325, 4603.746793926332, 4610.354550362952, 4625.028743963771, 4625.791839367203, 4656.278276867057, 5177.559907407875, 5178.689278643255, 5192.7403629818355, 5196.168613021936, 5274.0, 5583.35791383992, 5595.636283641591, 5610.18652295419, 5647.3505546862225, 5656.547476201894, 5566.526845218162, 5597.524210442118, 5608.130739735307, 5608.775648974036, 5614.578906581982, 5177.456367081478, 5178.8964220716125, 5198.688078715213, 5241.449647787003, 5253.947460525345, 5699.914501282484, 5755.395683453177, 5769.134629805562, 5785.595008349375, 5797.507211887037, 5436.972815135978, 5497.532709719639, 5523.199136125239, 5546.168074788814, 5594.13290939905, 5593.105103183471, 5602.887942241132, 5605.971970140205, 5608.775648973995, 5645.915311270334, 5448.291722076105, 5546.722663866791, 5573.108302671634, 5574.331080270394, 5592.608517403824, 5531.0, 5551.666899986014, 5600.103983362643, 5675.091985282335, 5678.630888992202, 4545.045540436479, 4606.746628935441, 4613.930791038137, 4615.14619795339, 4622.39908811859, 3999.4000899864673, 4000.0999775050964, 4032.274190645653, 4052.49343832021, 4078.898027549276, 4767.046590681877, 4767.547083027107, 4779.617630589544, 4780.760961951889, 4811.831585894477, 5466.945330546644, 5634.3802181759975, 5640.605157638925, 5648.0, 5724.513416359656, 4769.594584460359, 4776.976115119472, 4789.95210047902, 4799.0401919616215, 4815.446223684251, 4919.3358896549225, 4928.162212423897, 4928.531789479994, 4937.432195297515, 4968.478309777493, 5172.165035646967, 5268.2624432578705, 5279.445658205833, 5281.234221037851, 5282.234076059027, 5599.0, 5668.37647858727, 5683.630564013326, 5695.629784064023, 5704.515116215002, 5238.004779091961, 5257.4742525747115, 5260.263563101245, 5278.5249327560705, 5303.178007408857, 5480.232767412645, 5486.588505862156, 5494.615376923737, 5514.641548299348, 5546.722663866871, 5576.1356989666665, 5671.546276297969, 5705.572082093942, 5779.595428319977, 5791.189233507396, 5426.213199086032, 5501.587380946365, 5508.55931525485, 5511.421300763523, 5523.392426833126, 5266.526012658879, 5439.265699130567, 5439.966406382775, 5525.033119204204, 5531.308586426697, 5390.245365648891, 5392.218128371443, 5403.216533602685, 5410.377806552139, 5446.291982042309, 5482.616216864941, 5503.477169668875, 5507.284053073075, 5509.752061157337, 5510.834674959758, 5255.6058295628745, 5357.0, 5418.349798024262, 5427.511523962862, 5438.700871452108], "value": 5092.41789235089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.1489819665502, 755.9168491465938, 777.96888124475, 1022.6062965758181, 1032.2413026425581, 33496.832515837414, 34116.48825267623, 34122.65877341229, 34132.14669633257, 34140.0, 35298.0, 35746.0, 35753.46369804455, 35766.46350304741, 35769.642303576955, 6675.566088204276, 6823.420009299216, 6842.349976752201, 6991.755288564901, 6998.615076170809, 6834.931650683504, 6940.167179938415, 6941.548799328028, 6950.235474097845, 6952.443804495653, 6893.3795958363735, 6934.375906168444, 6939.0, 6971.7908462745945, 6995.79012629622, 6927.9653601731925, 6930.61881596512, 6938.444924406035, 6945.201301850301, 6946.79159625212, 6681.0, 6760.290169532227, 6762.154730658668, 6774.796756097325, 6779.2881747416795, 32494.350112997843, 32665.673343266502, 32715.50926736101, 32832.17919552006, 33006.50490242624, 3045.558394032875, 3056.404001219763, 3066.800657957248, 3069.217349575866, 3072.7234548890483, 24744.3813904652, 24768.504629907482, 24799.752002479923, 24836.130735424173, 24957.376065598324, 2633.9604905926426, 2641.1944356971117, 2646.431017331283, 2647.8411295322344, 2662.6671666041743, 122040.0, 124614.0, 136883.31558342243, 140676.0, 141316.0, 39717.0, 39987.200255994714, 39992.0, 40005.1998960025, 40085.198296033916, 40948.59051409507, 40960.79519602383, 41225.1754964899, 41335.793321033205, 41337.0, 12497.625071247878, 12620.0, 12620.242785432903, 12625.936870315772, 12677.429515671816, 10117.392956422638, 10134.493275336205, 10142.340747851365, 10155.086042256233, 10168.593256269814, 12508.562200322946, 12522.248665079942, 12590.307533085585, 12698.238105713686, 12897.935510322388, 5107.897842043139, 5122.667026643331, 5132.640715149978, 5159.535641792257, 5182.32629758129, 857.9828403431897, 896.4128495835238, 903.7785742492999, 911.2163539356148, 932.9766755831158, 20707.585848283252, 21770.238041668465, 21770.564588708454, 21828.672569911465, 21953.341399758032, 970.6554173268529, 980.5048450532436, 989.2036910287144, 995.7759504111517, 1014.1227837920146, 10998.780024399468, 11145.609903653332, 11333.943330283295, 11366.374849383197, 11387.37369444672, 172227.0, 172975.0, 173603.0, 173947.0, 174449.0, 41675.37486937698, 41783.791081045005, 41810.37284440736, 41834.79082604629, 41866.79066604647, 1152.9077673786078, 1203.9518419263306, 1216.2216181643755, 1223.4311045363947, 1232.3468561662332, 20461.18155273832, 20496.282630107875, 21199.7880021204, 21231.575368492235, 21434.356969290948, 29798.404031918806, 29807.0, 29815.0, 29833.25416864596, 29943.101706948826, 153945.0, 154071.0, 154668.0, 154792.0, 155120.0, 28212.43575128527, 28438.146855594365, 28630.570541441477, 29824.552631710107, 29881.0, 36253.63746362608, 36509.26981460409, 36581.63418365782, 37280.254394912496, 37496.6250337504, 27963.58054629223, 28017.299567510974, 28029.299267518476, 28316.716832832233, 29588.112356629335, 28025.57961630618, 28110.156695299174, 28153.0, 28951.883179061668, 29746.405071898873, 31495.582698779068, 31593.36813263768, 31665.0, 31768.0, 31813.0, 26032.479350413265, 26969.0, 27816.72183278141, 27854.860725697054, 28312.85843570769, 20138.697919530925, 22541.88729056344, 22639.0, 22847.88576057109, 22860.4284892879], "value": 14466.869830227526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.75474715170884, 411.22894572676233, 425.7956181033104, 431.1592394830081, 435.68630585978104, 13187.538436154737, 13549.458021679146, 17762.64474710505, 18374.540636484093, 18388.264469421225, 18078.819211807877, 18770.0, 18791.342303019395, 18805.0, 18851.15169817358, 5451.563874890019, 5604.243427137346, 5644.717764111799, 5645.0, 5661.631993920382, 5498.45015498449, 5528.806491772789, 5599.860003499904, 5600.1599760035915, 5613.550915926716, 5534.529564986981, 5536.169574563807, 5551.361593416768, 5553.72231388431, 5579.972100139514, 5350.438203988583, 5479.917801232985, 5484.341878974528, 5508.394076651605, 5530.917036244439, 4946.109700253953, 5000.499950005007, 5002.099622068026, 5002.699838009695, 5016.3980322361185, 22012.779872201234, 22307.55384892293, 22401.215957441575, 22423.551528969492, 22459.438514037116, 1561.461295852929, 1631.8368163183704, 1632.2002218912767, 1633.0365084600144, 1633.4772872680746, 14636.268186590627, 14937.775933361008, 15301.234938253043, 15435.228238588026, 15464.613384665361, 2085.7705652378227, 2088.498760297533, 2106.3365040012345, 2127.0853532980814, 2144.6890200920934, 104727.4763626177, 107865.46067269692, 109214.45392772985, 109244.4537777314, 109336.4533177329, 10565.418901960466, 11114.610988615359, 11120.944395277971, 11378.772424551627, 11824.349660768741, 15894.76157857633, 15978.201089945456, 16078.276477558538, 16086.83913160877, 16087.919560402122, 7464.813379665443, 7470.4023678106705, 7583.886241706379, 7590.620468976529, 7852.764417067498, 6972.825679358057, 6990.895136572955, 7008.824779380454, 7068.540544864567, 7078.575285482888, 7245.166805817398, 7380.630968451664, 7399.631068252283, 7464.962675186589, 7533.962330188314, 2065.648839697255, 2071.54426026274, 2112.767595564487, 2152.2036846366946, 2160.341095965714, 784.7488803582798, 820.0446479850907, 821.7699044267615, 825.529448214512, 849.3799526345803, 16859.0, 16918.238679259463, 17046.840327062662, 17624.20691068905, 17760.0, 819.3731795176694, 819.8360327934437, 838.149278482341, 840.3991146330403, 855.9358048146289, 9177.724668259963, 9361.204297634642, 9558.761030974143, 9571.18644915176, 9767.169790567881, 396942.0, 398097.0, 400815.0, 405807.0, 408145.0, 83169.58415207885, 84195.0, 84473.0, 84544.0, 84614.5769271162, 1010.5503051142318, 1044.9059584637419, 1055.8680164979378, 1056.915446764257, 1059.89930956559, 14810.77783833265, 15101.773473398127, 15435.22823858825, 15662.295196715948, 15945.521634350987, 43514.0, 43559.56440435555, 44048.339274910264, 44472.555274446844, 44514.77742611266, 56027.71986140043, 56093.0, 56351.43648563462, 56583.71708141433, 56656.71671641615, 9338.533073346442, 9358.953205233931, 9564.808703825745, 9565.426074435556, 9595.0, 11957.461914214055, 11981.820272696092, 15487.84512154864, 15657.451989180325, 15677.451289204822, 12592.874071259537, 12945.288009159587, 13059.0, 13063.085584009028, 13143.73712525725, 11396.94301528487, 11673.766524669629, 11920.284782913053, 11968.76062478728, 12035.277883327028, 13034.217946922836, 13328.333583320602, 13401.0, 13408.0, 13416.12795168311, 9213.677521286723, 9247.0, 9289.72130836076, 9310.115539023782, 9365.625374984924, 12713.8092928608, 13273.66815829612, 13406.396712147782, 13616.38726257301, 13946.0], "value": 9242.355457487582, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.7070473791027, 1300.4083142170307, 1308.8625694302098, 1320.9735805283901, 1327.5818117293052, 9525.09511596398, 9929.553170107336, 9941.155001824845, 10496.580136794519, 10681.893181068186, 10566.52450639721, 10708.0, 10740.409277489734, 10746.301490403119, 10779.514921828537, 2067.0284966065924, 2112.661974084147, 2115.027087539726, 2115.7038014677955, 2122.734658167729, 1871.0738184598642, 1903.2767548331615, 1911.0253770577037, 1913.7129430585453, 1918.3094086128983, 1860.2001139510005, 1863.962720745591, 1886.641538107762, 1889.6031833315021, 1891.186789680437, 1963.0, 1968.596437730269, 1976.3478052242726, 1983.4248068060244, 1984.394759598322, 1737.826217378252, 1825.7809062912402, 1829.140304057091, 1974.5458544534695, 2055.486128467883, 10051.899481005243, 10136.493175341204, 10137.341072830242, 10146.898531014744, 10165.89834101657, 5354.812581559666, 5591.580631452616, 5596.999999999959, 5603.075492543725, 5605.831825045255, 3281.1797050737314, 3360.781549199294, 3394.7623666343366, 3396.3037577296595, 3402.931941361159, 993.8857031441332, 997.7106639074659, 1007.2093406675798, 1010.7877345757399, 1017.8167929772638, 14142.929285353508, 14234.430622775077, 14320.212388318638, 14458.710825783426, 14584.124952502778, 4682.030338389758, 4724.740139292372, 4810.037992401533, 4827.348307978378, 4852.272159176152, 11104.833427498594, 11122.721931951766, 11126.499307531181, 11132.49903754333, 11150.330980141056, 5236.790528378899, 5356.571474282048, 5371.811986580451, 5383.7846486140115, 5383.919241211385, 4819.6867203631655, 4911.336969509142, 4931.358923340014, 4937.7777999990085, 4965.205567109245, 3759.191773768653, 3812.8093595320124, 3814.675752561008, 3872.8450861965207, 3879.7866117363815, 1110.2894147745449, 1116.2019156303281, 1139.4055189022029, 1147.6671765188169, 1149.9252548584316, 604.1783174882157, 632.2349956552531, 632.8006677896448, 637.8660481298979, 640.2668944059026, 4893.828715994994, 5027.296178535008, 5032.345795046621, 5070.61970352225, 5177.637565370388, 513.0, 522.1619301021881, 817.7692572678081, 836.6820608168979, 843.9198276163754, 3452.58568971725, 3467.6822807333556, 3615.6745892869767, 3637.5271214741915, 3785.6592906637984, 13270.336483175803, 13509.324533773271, 13548.59354219375, 13592.86407135916, 13711.17732936007, 13407.329633518286, 13409.932950335186, 13446.394912228972, 13555.59333220005, 13569.1858488491, 6634.535582509178, 6874.896876546856, 6959.234484206733, 7223.133224013152, 7662.233776622405, 5630.5214056805635, 5808.680522571299, 5857.179994800646, 5904.704764761831, 5975.133605627247, 11855.051595872137, 12132.75734485323, 12243.265404075784, 12350.135490515577, 12354.44405001795, 12026.579069732517, 12385.19496232778, 12387.132900697225, 12388.132830701765, 12573.811392828931, 8828.337874659297, 8905.643774248958, 8908.86636700437, 8975.910240897769, 8978.820423591362, 9048.90951090507, 9175.724728258163, 9179.862302065609, 9192.678256260999, 9194.12655797698, 7405.5926924019695, 7582.848343032998, 7585.393168546613, 7678.078630564145, 7834.1382447929545, 7161.319674630901, 7283.0, 7285.162206346338, 7366.373858221897, 7375.963120184365, 6817.625030623363, 6855.314468553105, 6873.518853680194, 6910.827229319308, 6927.134108236471, 4957.529034741694, 4965.006998600222, 5048.5203905628905, 5087.54212120896, 5240.082985477602, 4766.809327626856, 4896.2410826321975, 4931.3835770528685, 4967.081089998362, 5045.470225626404], "value": 4544.443177817019, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.08895448561975, 348.5312255017002, 353.1770973631439, 353.3921654753822, 354.0264273248566, 5422.9728851355685, 5545.77816887324, 5572.6099173057855, 5606.831795046145, 5613.635113717611, 5300.920486192701, 5386.676799392029, 5402.243685883979, 5420.457954204578, 5426.050441172789, 4107.671386289097, 4112.753234805907, 4117.855875044374, 4117.958820411787, 4133.834646614132, 4124.855630052949, 4148.398482220076, 4149.0, 4152.439420678215, 4171.353440216772, 4095.8736347504528, 4104.261232978063, 4109.075458021936, 4113.0, 4126.525449573308, 4115.506139263308, 4116.176764647083, 4117.958820411803, 4118.938215926763, 4120.21715873983, 3552.928941421157, 3578.1233597768455, 3588.946165807515, 3589.353916295066, 3590.8025058621765, 5297.496737809902, 5345.118055520835, 5350.785968561292, 5352.91970620441, 5369.731513424314, 4835.105505481497, 4836.274558816171, 4838.467768545457, 4846.878828029292, 4856.465788763233, 5786.739596718157, 5796.072628379481, 5801.882312955783, 5806.21616081832, 5806.59353845231, 4012.478377810895, 4028.3554631258858, 4028.536718277406, 4030.2745505808944, 4039.555648878621, 5884.470397664188, 6057.969710151465, 6077.301110372276, 6192.411720886508, 6194.752209911598, 3888.300105980951, 4046.393041043867, 4077.103037331782, 4099.713020088565, 4107.301758700968, 4127.29835927893, 4163.292240319153, 4170.207660544487, 4176.227397931392, 4184.623383895464, 4647.233206520954, 4783.378160839069, 4786.210275304536, 4791.95208047922, 4794.880127996828, 5761.711914404263, 5769.1923130761725, 5787.450192231731, 5788.623739456922, 5798.797042103506, 1402.5862370600698, 1439.4458133618632, 1439.6832696806687, 1440.8415074341815, 1444.162385816224, 915.1376947910969, 946.4226821638932, 962.9181519570775, 965.3918031640022, 965.560669895196, 4971.283024521829, 4993.825216117419, 5001.7499125043605, 5002.674826136289, 5022.9748851256245, 5988.131720900445, 5997.220361352996, 6000.729967151488, 6011.188489553854, 6011.458968692838, 4954.430240522314, 4996.850724333423, 4999.925001124986, 5005.874853128701, 5021.196608542616, 3156.526521021865, 3174.333559809771, 3178.9682103179134, 3189.0387411742076, 3196.5684632574303, 5602.551795856321, 5617.831465056055, 5626.409227031103, 5642.802501912495, 5646.717664116778, 6094.2077529920825, 6130.264368275835, 6152.907706384408, 6161.168242287324, 6163.0, 5573.247611572467, 5583.274174357389, 5589.211452335295, 5627.846291510149, 5628.437156284339, 5886.764529418775, 5979.701014949148, 5984.700764961647, 6021.909671354845, 6035.245594300713, 5887.411258874078, 5902.527797776082, 5916.26046744157, 5925.822225333247, 5935.347111817783, 5294.590961112607, 5559.944400555943, 5635.971820140873, 5642.435756424325, 5656.43435656431, 4065.959340406558, 4083.428320035257, 4088.304988151962, 4101.302778527717, 4115.074108325723, 5959.642421454553, 5973.641581505123, 5976.731047102804, 5976.850578735392, 5986.3238293277955, 5664.801731939362, 5770.336411312753, 5841.795537156179, 5844.597296648689, 5877.118432235028, 5835.620684655484, 5856.795012174553, 5866.325372582208, 5879.882402352015, 5886.352501224947, 5770.855728606818, 5775.220345253505, 5785.0, 5805.709714514342, 5814.389489103753, 5873.2658417697785, 5900.7049647518315, 5913.113033045078, 5913.704314784158, 5932.228810254812, 5704.686242256716, 5709.143628455598, 5715.2855893013375, 5721.568333458346, 5764.414785933734], "value": 4317.732917343599, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.6662851773924, 733.4169335378377, 739.6412739821186, 750.7484992527503, 751.6392131776747, 12499.937500312497, 13313.600591982231, 13352.39914203862, 14403.351849166786, 15945.123018233993, 15588.922055389736, 15707.84292157078, 15825.84174158258, 15838.604034899134, 15870.920645396785, 889.3152272749978, 891.8305521950808, 897.0356866368679, 897.1387468030698, 897.4301318662631, 815.8449894520052, 884.8672699095123, 886.2998231397188, 908.3686837647838, 913.7304495173939, 926.5737760630085, 930.0234753508822, 931.5388882503137, 932.3799673217302, 932.7388331267256, 921.9124183202586, 924.6856068936527, 925.694520808135, 926.0739260739294, 927.5825878354767, 672.9764458243937, 674.6188403552027, 676.4216594811463, 676.4723515657795, 677.5799004617169, 14483.420663173565, 14539.3457294422, 14573.562793116223, 14611.78082328766, 14691.0, 16739.16304184798, 17179.484615461555, 17237.0, 17317.393891213746, 17346.306147754076, 12494.562690305887, 13001.739965200737, 13053.673658158623, 13120.868791312156, 13139.27733974631, 3019.3961207758534, 3028.4851575232265, 3036.3016506203476, 3037.3773376457775, 3046.7105624965593, 86315.56842215812, 86350.568247159, 86554.5672271641, 88852.0, 88922.10629458692, 13182.802257966137, 13185.73628527424, 13203.66990825237, 13220.867791322156, 13270.27013514266, 23677.7632223679, 24105.879470602536, 24110.39724006914, 24206.63690044651, 24268.75731242665, 5535.640183388067, 5663.037283661787, 5699.686517241592, 5729.914051289234, 5740.856478588069, 2931.0327591894625, 2978.9851050744605, 3004.2189030852137, 3004.4291584598855, 3033.0445909538425, 3974.7217694761666, 4158.7296825706235, 4205.990562265034, 4209.116085621992, 4227.830886764556, 695.5722230828004, 702.5749421599961, 705.9164182979102, 707.398711095575, 708.9042979197742, 533.4239021856386, 540.2301720048914, 540.2517513244106, 544.0913674164156, 546.1425561867829, 9783.46190959504, 10183.490825458697, 10457.320274182153, 10520.684379468628, 10635.149188064936, 526.4051621667492, 544.9455054494598, 550.1225545255311, 559.0551967175461, 561.7977528089884, 4416.24923762961, 4547.8635640930825, 4576.8626941191815, 4583.816647334069, 4741.2651039089, 89340.0, 89351.55324223338, 91433.0, 91473.54263228775, 93432.53283733538, 77116.61441692755, 79970.0, 80289.0, 80296.0, 80452.59773701095, 69182.0, 70039.64980175067, 70654.0, 71421.0, 71745.64127179331, 8979.416337938013, 9062.456252624863, 9093.272538196796, 9152.313576481658, 9286.6285348588, 29485.26286842846, 29975.550366744952, 30183.189008659552, 30563.0, 30643.54034689526, 38203.0, 38451.0, 39148.41277380899, 39435.40846887242, 40204.597954020086, 12595.118341715992, 12642.620721378373, 12908.290044047291, 12931.353432328158, 13079.803802943154, 14350.0, 14386.712265754835, 14531.709365812836, 14660.85339146595, 14713.0, 11874.287542747463, 12697.365131743562, 14419.78370324467, 14506.637334066732, 14757.409703611735, 13273.734525309634, 13427.12723672958, 13557.576454472139, 13629.86370136286, 14213.857861421253, 14474.348654310792, 14920.62698432548, 15065.246737662854, 15073.095614263179, 16526.256318465938, 10127.7468063299, 10466.319689220176, 10895.400752958663, 11063.170262230204, 11099.001089901947, 11780.469878855643, 12012.519499220283, 12179.634610961686, 12222.6944326389, 12300.446479908605], "value": 7138.484808409376, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 110.0, 110.0, 112.0, 112.0, 109.0, 111.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 123.0, 170.0, 124.0, 127.0, 131.0, 124.0, 165.0, 122.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 163.0, 164.0, 169.0, 167.0, 174.0, 165.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 75.0, 110.0, 75.0, 75.0, 77.0, 78.0, 101.0, 78.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 109.0, 84.0, 83.0, 83.0, 97.0, 84.0, 84.0, 112.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 113.0, 115.0, 113.0, 114.0, 115.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 151.0, 150.0, 150.0, 151.0, 152.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 99.0, 96.0, 95.0, 94.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 56.0, 55.0, 55.0, 57.0, 57.0, 57.0, 58.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 59.0, 55.0, 55.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 94.0, 87.0, 88.0, 86.0, 86.0, 89.0, 88.0, 136.0, 86.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 131.0, 130.0, 136.0, 129.0, 130.0, 129.0, 133.0, 140.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 189.0, 195.0, 196.0, 183.0, 192.0, 197.0, 196.0, 191.0, 203.0], "value": 194.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 71.0, 75.0, 71.0, 74.0, 74.0, 71.0, 72.0, 72.0], "value": 73.3, "unit": "score"}]}]} 19:44:02 INFO - Return code: 0 19:44:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:44:02 INFO - # TBPL SUCCESS # 19:44:02 INFO - Running post-action listener: _resource_record_post_action 19:44:02 INFO - [mozharness: 2017-06-02 02:44:02.432572Z] Finished run-tests step (success) 19:44:02 INFO - Running post-run listener: _resource_record_post_run 19:44:02 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 8192; Write bytes: 403255296; Read time: 188; Write time: 236364 19:44:02 INFO - TinderboxPrint: CPU usage
12.7% 19:44:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 188 19:44:02 INFO - TinderboxPrint: I/O write bytes / time
403,255,296 / 236,364 19:44:02 INFO - TinderboxPrint: CPU idle
8,748.6 (87.3%) 19:44:02 INFO - TinderboxPrint: CPU user
1,218.6 (12.2%) 19:44:02 INFO - TinderboxPrint: Swap in / out
0 / 0 19:44:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 60641280; Read time: 0; Write time: 32088 19:44:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:44:02 INFO - run-tests - Wall time: 1240s; CPU: 13.0%; Read bytes: 8192; Write bytes: 305737728; Read time: 188; Write time: 145176 19:44:03 INFO - Running post-run listener: _upload_blobber_files 19:44:03 INFO - Blob upload gear active. 19:44:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:44:03 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 19:44:03 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'] 19:44:03 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 19:44:03 INFO - (blobuploader) - INFO - Open directory for files ... 19:44:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:44:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:44:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:04 INFO - (blobuploader) - INFO - Done attempting. 19:44:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:44:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:44:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:10 INFO - (blobuploader) - INFO - Done attempting. 19:44:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:44:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:44:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:11 INFO - (blobuploader) - INFO - Done attempting. 19:44:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:44:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:44:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:12 INFO - (blobuploader) - INFO - Done attempting. 19:44:12 INFO - (blobuploader) - INFO - Iteration through files over. 19:44:12 INFO - Return code: 0 19:44:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:44:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:44:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f5057b603f3a87ed24741096073424e4b82d101143e2d6f88a74f7adaee06db13abedbbf4761172ab7188d0292a1595d5f596af309e3729ae38a301d0083256", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/918c9f2bedba6b8e0a35a8939502ceaaaee15a3d7c60772d20efef0c952f2bddc005bcf876c6dd8e6a0afe9ff64ec3946a1cc78178a9b7e398698312be1bbf3a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ad0f9e265895825abcb60db56892b9e75ed0f7ca649ce8eca7453d4bff986b9f9f0ccd278cae4c0de9f9cfb2a351d01deaa964cf520001fd0ea6c7b710ca466", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/676deb837d004c069200b2be36614f544c5b14d74c5b31ec9bdb47196cfba66bea8a6d3ff220bbaa1230c7867c26fac92cacc68cc379232fe52dbf30ba427923"} 19:44:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:44:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:44:12 INFO - Contents: 19:44:12 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f5057b603f3a87ed24741096073424e4b82d101143e2d6f88a74f7adaee06db13abedbbf4761172ab7188d0292a1595d5f596af309e3729ae38a301d0083256", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/918c9f2bedba6b8e0a35a8939502ceaaaee15a3d7c60772d20efef0c952f2bddc005bcf876c6dd8e6a0afe9ff64ec3946a1cc78178a9b7e398698312be1bbf3a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ad0f9e265895825abcb60db56892b9e75ed0f7ca649ce8eca7453d4bff986b9f9f0ccd278cae4c0de9f9cfb2a351d01deaa964cf520001fd0ea6c7b710ca466", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/676deb837d004c069200b2be36614f544c5b14d74c5b31ec9bdb47196cfba66bea8a6d3ff220bbaa1230c7867c26fac92cacc68cc379232fe52dbf30ba427923"} 19:44:12 INFO - Running post-run listener: copy_logs_to_upload_dir 19:44:12 INFO - Copying logs to upload dir... 19:44:12 INFO - mkdir: /builds/slave/test/build/upload/logs 19:44:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.179073 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-01 19:44:11.191652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 19:44:11.196690) ========= 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=20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f5057b603f3a87ed24741096073424e4b82d101143e2d6f88a74f7adaee06db13abedbbf4761172ab7188d0292a1595d5f596af309e3729ae38a301d0083256", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/918c9f2bedba6b8e0a35a8939502ceaaaee15a3d7c60772d20efef0c952f2bddc005bcf876c6dd8e6a0afe9ff64ec3946a1cc78178a9b7e398698312be1bbf3a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ad0f9e265895825abcb60db56892b9e75ed0f7ca649ce8eca7453d4bff986b9f9f0ccd278cae4c0de9f9cfb2a351d01deaa964cf520001fd0ea6c7b710ca466", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/676deb837d004c069200b2be36614f544c5b14d74c5b31ec9bdb47196cfba66bea8a6d3ff220bbaa1230c7867c26fac92cacc68cc379232fe52dbf30ba427923"} build_url:https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/Rggr6v0nShaZDWgOhcwTmQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f5057b603f3a87ed24741096073424e4b82d101143e2d6f88a74f7adaee06db13abedbbf4761172ab7188d0292a1595d5f596af309e3729ae38a301d0083256", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/918c9f2bedba6b8e0a35a8939502ceaaaee15a3d7c60772d20efef0c952f2bddc005bcf876c6dd8e6a0afe9ff64ec3946a1cc78178a9b7e398698312be1bbf3a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ad0f9e265895825abcb60db56892b9e75ed0f7ca649ce8eca7453d4bff986b9f9f0ccd278cae4c0de9f9cfb2a351d01deaa964cf520001fd0ea6c7b710ca466", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/676deb837d004c069200b2be36614f544c5b14d74c5b31ec9bdb47196cfba66bea8a6d3ff220bbaa1230c7867c26fac92cacc68cc379232fe52dbf30ba427923"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 19:44:11.223846) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:44:11.224181) ========= 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=20e666a3d4cfbb71505a330e000001b4-1496357747.893521-1083914734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:44:11.305824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 19:44:11.306112) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 19:44:11.309395) ========= ========= Total master_lag: 0.24 =========