builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1496370696.43 results: success (0) revision: aeb3d0ca558f034cbef1c5a68bd07dd738611494 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.430448) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.430963) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.431262) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.453691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.454228) ========= 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=3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-01 19:31:36-- 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% 219M=0s 2017-06-01 19:31:37 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.406578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.875688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.876062) ========= 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=3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019822 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.930047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.930536) ========= 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=3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-01 19:31:37,338 truncating revision to first 12 chars 2017-06-01 19:31:37,338 Setting DEBUG logging. 2017-06-01 19:31:37,338 attempt 1/10 2017-06-01 19:31:37,338 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:31:37,650 unpacking tar archive at: mozilla-central-aeb3d0ca558f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.710123 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:37.653505) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:37.653814) ========= script_repo_revision: aeb3d0ca558f034cbef1c5a68bd07dd738611494 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:37.654235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:37.654526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:37.662425) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-06-01 19:31:37.662826) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:31:38 INFO - MultiFileLogger online at 20170601 19:31:38 in /builds/slave/test 19:31:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:31:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:31:38 INFO - {'append_to_log': False, 19:31:38 INFO - 'base_work_dir': '/builds/slave/test', 19:31:38 INFO - 'blob_upload_branch': 'Firefox', 19:31:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:31:38 INFO - 'branch': 'Firefox', 19:31:38 INFO - 'buildbot_json_path': 'buildprops.json', 19:31:38 INFO - 'config_files': ('talos/linux_config.py',), 19:31:38 INFO - 'default_actions': ('clobber', 19:31:38 INFO - 'read-buildbot-config', 19:31:38 INFO - 'download-and-extract', 19:31:38 INFO - 'populate-webroot', 19:31:38 INFO - 'create-virtualenv', 19:31:38 INFO - 'install', 19:31:38 INFO - 'setup-mitmproxy', 19:31:38 INFO - 'run-tests'), 19:31:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:31:38 INFO - 'download_minidump_stackwalk': True, 19:31:38 INFO - 'download_symbols': 'ondemand', 19:31:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:31:38 INFO - 'tooltool.py': '/tools/tooltool.py', 19:31:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:31:38 INFO - '/tools/misc-python/virtualenv.py')}, 19:31:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:31:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:31:38 INFO - 'gecko_profile': False, 19:31:38 INFO - 'gecko_profile_interval': 0, 19:31:38 INFO - 'installer_path': 'installer.exe', 19:31:38 INFO - 'log_level': 'info', 19:31:38 INFO - 'log_name': 'talos', 19:31:38 INFO - 'log_to_console': True, 19:31:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:31:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:31:38 INFO - 'opt_config_files': (), 19:31:38 INFO - 'pip_index': False, 19:31:38 INFO - 'suite': 'dromaeojs-e10s', 19:31:38 INFO - 'system_bits': '32', 19:31:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:31:38 INFO - 'title': 'talos-linux64-ix-030', 19:31:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:31:38 INFO - 'use_talos_json': True, 19:31:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:31:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:31:38 INFO - 'work_dir': 'build'} 19:31:38 INFO - [mozharness: 2017-06-02 02:31:38.170315Z] Running clobber step. 19:31:38 INFO - Running pre-action listener: _resource_record_pre_action 19:31:38 INFO - Running main action method: clobber 19:31:38 INFO - rmtree: /builds/slave/test/build 19:31:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:31:39 INFO - Running post-action listener: _resource_record_post_action 19:31:39 INFO - [mozharness: 2017-06-02 02:31:39.719835Z] Finished clobber step (success) 19:31:39 INFO - [mozharness: 2017-06-02 02:31:39.719935Z] Running read-buildbot-config step. 19:31:39 INFO - Running pre-action listener: _resource_record_pre_action 19:31:39 INFO - Running main action method: read_buildbot_config 19:31:39 INFO - Using buildbot properties: 19:31:39 INFO - { 19:31:39 INFO - "project": "", 19:31:39 INFO - "product": "firefox", 19:31:39 INFO - "who": "kwierso@gmail.com", 19:31:39 INFO - "installer_path": "public/build/target.tar.bz2", 19:31:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 19:31:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:31:39 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 19:31:39 INFO - "stage_platform": "linux64-stylo", 19:31:39 INFO - "basedir": "/builds/slave/test", 19:31:39 INFO - "buildnumber": 130, 19:31:39 INFO - "platform": "ubuntu64_hw_stylo", 19:31:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:31:39 INFO - "slavebuilddir": "test", 19:31:39 INFO - "taskId": "ceDKO46FQ3CSYO221BGLaQ", 19:31:39 INFO - "branch": "mozilla-central", 19:31:39 INFO - "script_repo_revision": "production", 19:31:39 INFO - "revision": "aeb3d0ca558f034cbef1c5a68bd07dd738611494", 19:31:39 INFO - "slavename": "talos-linux64-ix-030", 19:31:39 INFO - "repo_path": "mozilla-central" 19:31:39 INFO - } 19:31:39 INFO - Finding installer, test and symbols from parent task. 19:31:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ceDKO46FQ3CSYO221BGLaQ'}, attempt #1 19:31:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ceDKO46FQ3CSYO221BGLaQ'}, attempt #1 19:31:40 INFO - Task dependencies: Iq4sCn0zRVu1rgKF7Vu6yg 19:31:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg'}, attempt #1 19:31:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2 19:31:41 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/test_packages.json 19:31:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.crashreporter-symbols.zip 19:31:41 INFO - Running post-action listener: _resource_record_post_action 19:31:41 INFO - [mozharness: 2017-06-02 02:31:41.075759Z] Finished read-buildbot-config step (success) 19:31:41 INFO - [mozharness: 2017-06-02 02:31:41.075980Z] Running download-and-extract step. 19:31:41 INFO - Running pre-action listener: _resource_record_pre_action 19:31:41 INFO - Running main action method: download_and_extract 19:31:41 INFO - mkdir: /builds/slave/test/build/tests 19:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:41 INFO - trying https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.test_packages.json 19:31:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:31:41 INFO - Downloaded 986 bytes. 19:31:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:31:41 INFO - Using the following test package requirements: 19:31:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:31:41 INFO - u'common': [u'target.common.tests.zip'], 19:31:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:31:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:31:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:31:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:31:41 INFO - u'mozbase': [u'target.common.tests.zip'], 19:31:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:31:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:31:41 INFO - u'web-platform': [u'target.common.tests.zip', 19:31:41 INFO - u'target.web-platform.tests.zip'], 19:31:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:31:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:31:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.common.tests.zip 19:31:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:31:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.common.tests.zip into memory 19:31:42 INFO - Content-Length response header: 63544019 19:31:42 INFO - Bytes received: 63544019 19:31:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:31:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.common.tests.zip 19:31:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:31:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.common.tests.zip into memory 19:31:55 INFO - Content-Length response header: 63544019 19:31:55 INFO - Bytes received: 63544019 19:32:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.talos.tests.zip 19:32:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:32:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.talos.tests.zip into memory 19:32:07 INFO - Content-Length response header: 14447425 19:32:07 INFO - Bytes received: 14447425 19:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:07 INFO - trying https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2 19:32:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:32:09 INFO - Downloaded 55954854 bytes. 19:32:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2 19:32:09 INFO - mkdir: /builds/slave/test/properties 19:32:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:32:09 INFO - Writing to file /builds/slave/test/properties/build_url 19:32:09 INFO - Contents: 19:32:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2 19:32:09 INFO - Running post-action listener: _resource_record_post_action 19:32:09 INFO - Running post-action listener: set_extra_try_arguments 19:32:09 INFO - [mozharness: 2017-06-02 02:32:09.028531Z] Finished download-and-extract step (success) 19:32:09 INFO - [mozharness: 2017-06-02 02:32:09.028628Z] Running populate-webroot step. 19:32:09 INFO - Running pre-action listener: _resource_record_pre_action 19:32:09 INFO - Running main action method: populate_webroot 19:32:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:32:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:32:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:32:09 INFO - '--tppagecycles', 19:32:09 INFO - '7'], 19:32:09 INFO - 'tests': ['tsvgm']}}, 19:32:09 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:32:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:32:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:32:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:32:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:32:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['damp', 'tps']}, 19:32:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'tests': ['damp', 'tps']}, 19:32:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['dromaeo_dom']}, 19:32:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:32:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:32:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:32:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:32:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['a11yr', 19:32:09 INFO - 'ts_paint', 19:32:09 INFO - 'tpaint', 19:32:09 INFO - 'sessionrestore', 19:32:09 INFO - 'sessionrestore_no_auto_restore', 19:32:09 INFO - 'tabpaint']}, 19:32:09 INFO - 'other-e10s': {'tests': ['a11yr', 19:32:09 INFO - 'ts_paint', 19:32:09 INFO - 'tpaint', 19:32:09 INFO - 'sessionrestore', 19:32:09 INFO - 'sessionrestore_no_auto_restore', 19:32:09 INFO - 'tabpaint']}, 19:32:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:32:09 INFO - 'ts_paint', 19:32:09 INFO - 'tpaint', 19:32:09 INFO - 'sessionrestore', 19:32:09 INFO - 'sessionrestore_no_auto_restore', 19:32:09 INFO - 'tabpaint']}, 19:32:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:32:09 INFO - 'ts_paint', 19:32:09 INFO - 'tpaint', 19:32:09 INFO - 'sessionrestore', 19:32:09 INFO - 'sessionrestore_no_auto_restore', 19:32:09 INFO - 'tabpaint']}, 19:32:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['a11yr', 19:32:09 INFO - 'ts_paint', 19:32:09 INFO - 'tpaint', 19:32:09 INFO - 'sessionrestore', 19:32:09 INFO - 'sessionrestore_no_auto_restore', 19:32:09 INFO - 'tabpaint']}, 19:32:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['a11yr', 19:32:09 INFO - 'ts_paint', 19:32:09 INFO - 'tpaint', 19:32:09 INFO - 'sessionrestore', 19:32:09 INFO - 'sessionrestore_no_auto_restore', 19:32:09 INFO - 'tabpaint']}, 19:32:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 19:32:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 19:32:09 INFO - 'bloom_basic_ref']}, 19:32:09 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 19:32:09 INFO - 'talos_options': ['--mitmproxy', 19:32:09 INFO - 'mitmproxy-recording-1.mp', 19:32:09 INFO - '--firstNonBlankPaint'], 19:32:09 INFO - 'tests': ['Quantum_1']}, 19:32:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['tsvgx', 19:32:09 INFO - 'tsvgr_opacity', 19:32:09 INFO - 'tart', 19:32:09 INFO - 'tscrollx', 19:32:09 INFO - 'cart', 19:32:09 INFO - 'tsvg_static']}, 19:32:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:32:09 INFO - 'tsvgr_opacity', 19:32:09 INFO - 'tart', 19:32:09 INFO - 'tscrollx', 19:32:09 INFO - 'cart', 19:32:09 INFO - 'tsvg_static']}, 19:32:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['tp5o']}, 19:32:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:32:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'talos_options': ['--disable-e10s', 19:32:09 INFO - '--xperf_path', 19:32:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:32:09 INFO - 'tests': ['tp5n']}, 19:32:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'talos_options': ['--xperf_path', 19:32:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:32:09 INFO - 'tests': ['tp5n']}}, 19:32:09 INFO - 'talos.zip': {'path': '', 19:32:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:32:09 INFO - Running post-action listener: _resource_record_post_action 19:32:09 INFO - [mozharness: 2017-06-02 02:32:09.043116Z] Finished populate-webroot step (success) 19:32:09 INFO - [mozharness: 2017-06-02 02:32:09.043210Z] Running create-virtualenv step. 19:32:09 INFO - Running pre-action listener: _resource_record_pre_action 19:32:09 INFO - Running main action method: create_virtualenv 19:32:09 INFO - Creating virtualenv /builds/slave/test/build/venv 19:32:09 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:32:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:32:09 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:32:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:32:09 INFO - Using real prefix '/usr' 19:32:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:32:09 INFO - Installing distribute.............................................................................................................................................................................................done. 19:32:11 INFO - Installing pip.................done. 19:32:11 INFO - Return code: 0 19:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:32:11 INFO - Reading from file tmpfile_stdout 19:32:11 INFO - Output received: 19:32:11 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:32:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f253b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0840>, '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 0x22a1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a1bd0>, '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': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', '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:32:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:32:11 INFO - Using env: {'DISPLAY': ':0', 19:32:11 INFO - 'HOME': '/home/cltbld', 19:32:11 INFO - 'LANG': 'en_US.UTF-8', 19:32:11 INFO - 'LANGUAGE': 'en_US:en', 19:32:11 INFO - 'LOGNAME': 'cltbld', 19:32:11 INFO - 'MAIL': '/var/mail/cltbld', 19:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:11 INFO - 'MOZ_NO_REMOTE': '1', 19:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:11 INFO - 'NO_EM_RESTART': '1', 19:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:11 INFO - 'PWD': '/builds/slave/test', 19:32:11 INFO - 'SHELL': '/bin/bash', 19:32:11 INFO - 'SHLVL': '1', 19:32:11 INFO - 'TERM': 'linux', 19:32:11 INFO - 'TMOUT': '86400', 19:32:11 INFO - 'USER': 'cltbld', 19:32:11 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', 19:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:11 INFO - '_': '/tools/buildbot/bin/python'} 19:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:12 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:32:12 INFO - Cleaning up... 19:32:12 INFO - Return code: 0 19:32:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:32:12 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:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:12 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:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:12 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 0x1f253b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0840>, '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 0x22a1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a1bd0>, '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': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', '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:32:12 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:32:12 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:32:12 INFO - Using env: {'DISPLAY': ':0', 19:32:12 INFO - 'HOME': '/home/cltbld', 19:32:12 INFO - 'LANG': 'en_US.UTF-8', 19:32:12 INFO - 'LANGUAGE': 'en_US:en', 19:32:12 INFO - 'LOGNAME': 'cltbld', 19:32:12 INFO - 'MAIL': '/var/mail/cltbld', 19:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:12 INFO - 'MOZ_NO_REMOTE': '1', 19:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:12 INFO - 'NO_EM_RESTART': '1', 19:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:12 INFO - 'PWD': '/builds/slave/test', 19:32:12 INFO - 'SHELL': '/bin/bash', 19:32:12 INFO - 'SHLVL': '1', 19:32:12 INFO - 'TERM': 'linux', 19:32:12 INFO - 'TMOUT': '86400', 19:32:12 INFO - 'USER': 'cltbld', 19:32:12 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', 19:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:12 INFO - '_': '/tools/buildbot/bin/python'} 19:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:12 INFO - Downloading/unpacking psutil>=3.1.1 19:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:32:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:32:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:32:13 INFO - Installing collected packages: psutil 19:32:13 INFO - Running setup.py install for psutil 19:32:13 INFO - building 'psutil._psutil_linux' extension 19:32:13 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:32:13 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:32:13 INFO - building 'psutil._psutil_posix' extension 19:32:13 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:32:13 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:32:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:32:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:32:13 INFO - Successfully installed psutil 19:32:13 INFO - Cleaning up... 19:32:13 INFO - Return code: 0 19:32:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f253b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0840>, '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 0x22a1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a1bd0>, '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': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', '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:32:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:32:13 INFO - Using env: {'DISPLAY': ':0', 19:32:13 INFO - 'HOME': '/home/cltbld', 19:32:13 INFO - 'LANG': 'en_US.UTF-8', 19:32:13 INFO - 'LANGUAGE': 'en_US:en', 19:32:13 INFO - 'LOGNAME': 'cltbld', 19:32:13 INFO - 'MAIL': '/var/mail/cltbld', 19:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:13 INFO - 'MOZ_NO_REMOTE': '1', 19:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:13 INFO - 'NO_EM_RESTART': '1', 19:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:13 INFO - 'PWD': '/builds/slave/test', 19:32:13 INFO - 'SHELL': '/bin/bash', 19:32:13 INFO - 'SHLVL': '1', 19:32:13 INFO - 'TERM': 'linux', 19:32:13 INFO - 'TMOUT': '86400', 19:32:13 INFO - 'USER': 'cltbld', 19:32:13 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', 19:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:13 INFO - '_': '/tools/buildbot/bin/python'} 19:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:32:15 INFO - Installing collected packages: mozsystemmonitor 19:32:15 INFO - Running setup.py install for mozsystemmonitor 19:32:15 INFO - Successfully installed mozsystemmonitor 19:32:15 INFO - Cleaning up... 19:32:15 INFO - Return code: 0 19:32:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f253b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0840>, '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 0x22a1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a1bd0>, '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': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', '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:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:32:15 INFO - Using env: {'DISPLAY': ':0', 19:32:15 INFO - 'HOME': '/home/cltbld', 19:32:15 INFO - 'LANG': 'en_US.UTF-8', 19:32:15 INFO - 'LANGUAGE': 'en_US:en', 19:32:15 INFO - 'LOGNAME': 'cltbld', 19:32:15 INFO - 'MAIL': '/var/mail/cltbld', 19:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:15 INFO - 'MOZ_NO_REMOTE': '1', 19:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:15 INFO - 'NO_EM_RESTART': '1', 19:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:15 INFO - 'PWD': '/builds/slave/test', 19:32:15 INFO - 'SHELL': '/bin/bash', 19:32:15 INFO - 'SHLVL': '1', 19:32:15 INFO - 'TERM': 'linux', 19:32:15 INFO - 'TMOUT': '86400', 19:32:15 INFO - 'USER': 'cltbld', 19:32:15 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', 19:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:15 INFO - '_': '/tools/buildbot/bin/python'} 19:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:15 INFO - Downloading/unpacking jsonschema==2.5.1 19:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:32:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:16 INFO - Downloading functools32-3.2.3-2.tar.gz 19:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:32:16 INFO - warning: no files found matching '*.txt' 19:32:16 INFO - no previously-included directories found matching 'build' 19:32:16 INFO - no previously-included directories found matching 'dist' 19:32:16 INFO - no previously-included directories found matching '.git*' 19:32:16 INFO - Installing collected packages: jsonschema, functools32 19:32:16 INFO - Running setup.py install for functools32 19:32:17 INFO - warning: no files found matching '*.txt' 19:32:17 INFO - no previously-included directories found matching 'build' 19:32:17 INFO - no previously-included directories found matching 'dist' 19:32:17 INFO - no previously-included directories found matching '.git*' 19:32:17 INFO - Successfully installed jsonschema functools32 19:32:17 INFO - Cleaning up... 19:32:17 INFO - Return code: 0 19:32:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:17 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 0x1f253b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0840>, '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 0x22a1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a1bd0>, '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': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', '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:32:17 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:32:17 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:32:17 INFO - Using env: {'DISPLAY': ':0', 19:32:17 INFO - 'HOME': '/home/cltbld', 19:32:17 INFO - 'LANG': 'en_US.UTF-8', 19:32:17 INFO - 'LANGUAGE': 'en_US:en', 19:32:17 INFO - 'LOGNAME': 'cltbld', 19:32:17 INFO - 'MAIL': '/var/mail/cltbld', 19:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:17 INFO - 'MOZ_NO_REMOTE': '1', 19:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:17 INFO - 'NO_EM_RESTART': '1', 19:32:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:17 INFO - 'PWD': '/builds/slave/test', 19:32:17 INFO - 'SHELL': '/bin/bash', 19:32:17 INFO - 'SHLVL': '1', 19:32:17 INFO - 'TERM': 'linux', 19:32:17 INFO - 'TMOUT': '86400', 19:32:17 INFO - 'USER': 'cltbld', 19:32:17 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', 19:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:17 INFO - '_': '/tools/buildbot/bin/python'} 19:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:32:17 INFO - Cleaning up... 19:32:17 INFO - Return code: 0 19:32:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:17 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 0x1f253b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0840>, '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 0x22a1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a1bd0>, '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': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', '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:32:17 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:32:17 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:32:17 INFO - Using env: {'DISPLAY': ':0', 19:32:17 INFO - 'HOME': '/home/cltbld', 19:32:17 INFO - 'LANG': 'en_US.UTF-8', 19:32:17 INFO - 'LANGUAGE': 'en_US:en', 19:32:17 INFO - 'LOGNAME': 'cltbld', 19:32:17 INFO - 'MAIL': '/var/mail/cltbld', 19:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:17 INFO - 'MOZ_NO_REMOTE': '1', 19:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:17 INFO - 'NO_EM_RESTART': '1', 19:32:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:17 INFO - 'PWD': '/builds/slave/test', 19:32:17 INFO - 'SHELL': '/bin/bash', 19:32:17 INFO - 'SHLVL': '1', 19:32:17 INFO - 'TERM': 'linux', 19:32:17 INFO - 'TMOUT': '86400', 19:32:17 INFO - 'USER': 'cltbld', 19:32:17 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', 19:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:17 INFO - '_': '/tools/buildbot/bin/python'} 19:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:17 INFO - Downloading/unpacking blobuploader==1.2.4 19:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:18 INFO - Downloading blobuploader-1.2.4.tar.gz 19:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:32:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:32:18 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:32:18 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:32:18 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:32:18 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:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:32:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:32:19 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:32:19 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:32:19 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:32:19 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:32:19 INFO - Downloading docopt-0.6.1.tar.gz 19:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:32:19 INFO - Installing collected packages: blobuploader, requests, docopt 19:32:19 INFO - Running setup.py install for blobuploader 19:32:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:32:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:32:19 INFO - Running setup.py install for requests 19:32:19 INFO - Running setup.py install for docopt 19:32:19 INFO - Successfully installed blobuploader requests docopt 19:32:19 INFO - Cleaning up... 19:32:19 INFO - Return code: 0 19:32:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32: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:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32: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:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:19 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 0x1f253b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0840>, '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 0x22a1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a1bd0>, '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': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', '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:32:19 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:32:19 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:32:19 INFO - Using env: {'DISPLAY': ':0', 19:32:19 INFO - 'HOME': '/home/cltbld', 19:32:19 INFO - 'LANG': 'en_US.UTF-8', 19:32:19 INFO - 'LANGUAGE': 'en_US:en', 19:32:19 INFO - 'LOGNAME': 'cltbld', 19:32:19 INFO - 'MAIL': '/var/mail/cltbld', 19:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:19 INFO - 'MOZ_NO_REMOTE': '1', 19:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:19 INFO - 'NO_EM_RESTART': '1', 19:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:19 INFO - 'PWD': '/builds/slave/test', 19:32:19 INFO - 'SHELL': '/bin/bash', 19:32:19 INFO - 'SHLVL': '1', 19:32:19 INFO - 'TERM': 'linux', 19:32:19 INFO - 'TMOUT': '86400', 19:32:19 INFO - 'USER': 'cltbld', 19:32:19 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', 19:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:19 INFO - '_': '/tools/buildbot/bin/python'} 19:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:32:20 INFO - Running setup.py (path:/tmp/pip-NbtWB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:32:20 INFO - Running setup.py (path:/tmp/pip-Y9QroO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:32:20 INFO - Running setup.py (path:/tmp/pip-hkZ7MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:32:20 INFO - Running setup.py (path:/tmp/pip-eDjImh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:32:20 INFO - Running setup.py (path:/tmp/pip-3aQIaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:32:20 INFO - Running setup.py (path:/tmp/pip-jq9BHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:32:20 INFO - Running setup.py (path:/tmp/pip-Tf4HZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:32:20 INFO - Running setup.py (path:/tmp/pip-9yoOdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:32:20 INFO - Running setup.py (path:/tmp/pip-wteBpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:32:20 INFO - Running setup.py (path:/tmp/pip-bmWz29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:32:20 INFO - Running setup.py (path:/tmp/pip-exKcDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:32:20 INFO - Running setup.py (path:/tmp/pip-UhHdoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:32:20 INFO - Running setup.py (path:/tmp/pip-H0sYXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:32:20 INFO - Running setup.py (path:/tmp/pip-nvrxqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:21 INFO - Running setup.py (path:/tmp/pip-dxbhdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:32:21 INFO - Running setup.py (path:/tmp/pip-3gT61r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:32:21 INFO - Running setup.py (path:/tmp/pip-AZPpiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:32:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:32:21 INFO - Running setup.py install for manifestparser 19:32:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:32:21 INFO - Running setup.py install for mozcrash 19:32:21 INFO - Running setup.py install for mozdebug 19:32:21 INFO - Running setup.py install for mozdevice 19:32:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:32:21 INFO - Running setup.py install for mozfile 19:32:21 INFO - Running setup.py install for mozhttpd 19:32:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:32:21 INFO - Running setup.py install for mozinfo 19:32:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:32:21 INFO - Running setup.py install for mozInstall 19:32:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:32:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:32:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:32:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:32:22 INFO - Running setup.py install for mozleak 19:32:22 INFO - Running setup.py install for mozlog 19:32:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:32:22 INFO - Running setup.py install for moznetwork 19:32:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:32:22 INFO - Running setup.py install for mozprocess 19:32:22 INFO - Running setup.py install for mozprofile 19:32:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:32:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:32:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:32:22 INFO - Running setup.py install for mozrunner 19:32:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:32:22 INFO - Running setup.py install for mozscreenshot 19:32:22 INFO - Running setup.py install for moztest 19:32:22 INFO - Running setup.py install for mozversion 19:32:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:32:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:32:23 INFO - Cleaning up... 19:32:23 INFO - Return code: 0 19:32:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:23 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:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:23 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:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:23 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 0x1f253b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0840>, '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 0x22a1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a1bd0>, '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': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', '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:32:23 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:32:23 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:32:23 INFO - Using env: {'DISPLAY': ':0', 19:32:23 INFO - 'HOME': '/home/cltbld', 19:32:23 INFO - 'LANG': 'en_US.UTF-8', 19:32:23 INFO - 'LANGUAGE': 'en_US:en', 19:32:23 INFO - 'LOGNAME': 'cltbld', 19:32:23 INFO - 'MAIL': '/var/mail/cltbld', 19:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:23 INFO - 'MOZ_NO_REMOTE': '1', 19:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:23 INFO - 'NO_EM_RESTART': '1', 19:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:23 INFO - 'PWD': '/builds/slave/test', 19:32:23 INFO - 'SHELL': '/bin/bash', 19:32:23 INFO - 'SHLVL': '1', 19:32:23 INFO - 'TERM': 'linux', 19:32:23 INFO - 'TMOUT': '86400', 19:32:23 INFO - 'USER': 'cltbld', 19:32:23 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', 19:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:23 INFO - '_': '/tools/buildbot/bin/python'} 19:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:32:23 INFO - Running setup.py (path:/tmp/pip-xaH3BT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:32:23 INFO - Running setup.py (path:/tmp/pip-KTz79r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:32:23 INFO - Running setup.py (path:/tmp/pip-XlmCO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:32:23 INFO - Running setup.py (path:/tmp/pip-Mhoqu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:32:23 INFO - Running setup.py (path:/tmp/pip-Sh8BDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:32:23 INFO - Running setup.py (path:/tmp/pip-XXZsL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:32:23 INFO - Running setup.py (path:/tmp/pip-qNR0vX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:32:23 INFO - Running setup.py (path:/tmp/pip-dt9hRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:32:23 INFO - Running setup.py (path:/tmp/pip-njWAhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:32:23 INFO - Running setup.py (path:/tmp/pip-30Blbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:32:23 INFO - Running setup.py (path:/tmp/pip-3HQaDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:32:24 INFO - Running setup.py (path:/tmp/pip-m2vkU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:32:24 INFO - Running setup.py (path:/tmp/pip-xiOmaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:32:24 INFO - Running setup.py (path:/tmp/pip-tr3v1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:24 INFO - Running setup.py (path:/tmp/pip-pLr7QA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:32:24 INFO - Running setup.py (path:/tmp/pip-n2lUkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:32:24 INFO - Running setup.py (path:/tmp/pip-a7SMBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:32:24 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:32:24 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:32:24 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:32:24 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:32:24 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:32:24 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:32:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:25 INFO - Downloading blessings-1.6.tar.gz 19:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:32:25 INFO - Installing collected packages: blessings 19:32:25 INFO - Running setup.py install for blessings 19:32:25 INFO - Successfully installed blessings 19:32:25 INFO - Cleaning up... 19:32:25 INFO - Return code: 0 19:32:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:32:25 INFO - Reading from file tmpfile_stdout 19:32:25 INFO - Current package versions: 19:32:25 INFO - argparse == 1.2.1 19:32:25 INFO - blessings == 1.6 19:32:25 INFO - blobuploader == 1.2.4 19:32:25 INFO - docopt == 0.6.1 19:32:25 INFO - functools32 == 3.2.3-2 19:32:25 INFO - jsonschema == 2.5.1 19:32:25 INFO - manifestparser == 1.1 19:32:25 INFO - mozInstall == 1.12 19:32:25 INFO - mozcrash == 1.0 19:32:25 INFO - mozdebug == 0.1 19:32:25 INFO - mozdevice == 0.51 19:32:25 INFO - mozfile == 1.2 19:32:25 INFO - mozhttpd == 0.7 19:32:25 INFO - mozinfo == 0.9 19:32:25 INFO - mozleak == 0.1 19:32:25 INFO - mozlog == 3.4 19:32:25 INFO - moznetwork == 0.27 19:32:25 INFO - mozprocess == 0.25 19:32:25 INFO - mozprofile == 0.28 19:32:25 INFO - mozrunner == 6.13 19:32:25 INFO - mozscreenshot == 0.1 19:32:25 INFO - mozsystemmonitor == 0.3 19:32:25 INFO - moztest == 0.8 19:32:25 INFO - mozversion == 1.4 19:32:25 INFO - psutil == 3.1.1 19:32:25 INFO - requests == 1.2.3 19:32:25 INFO - wsgiref == 0.1.2 19:32:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:25 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:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:25 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:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:26 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 0x1f253b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0840>, '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 0x22a1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a1bd0>, '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': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', '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:32:26 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:32:26 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:32:26 INFO - Using env: {'DISPLAY': ':0', 19:32:26 INFO - 'HOME': '/home/cltbld', 19:32:26 INFO - 'LANG': 'en_US.UTF-8', 19:32:26 INFO - 'LANGUAGE': 'en_US:en', 19:32:26 INFO - 'LOGNAME': 'cltbld', 19:32:26 INFO - 'MAIL': '/var/mail/cltbld', 19:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:26 INFO - 'MOZ_NO_REMOTE': '1', 19:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:26 INFO - 'NO_EM_RESTART': '1', 19:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:26 INFO - 'PWD': '/builds/slave/test', 19:32:26 INFO - 'SHELL': '/bin/bash', 19:32:26 INFO - 'SHLVL': '1', 19:32:26 INFO - 'TERM': 'linux', 19:32:26 INFO - 'TMOUT': '86400', 19:32:26 INFO - 'USER': 'cltbld', 19:32:26 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', 19:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:26 INFO - '_': '/tools/buildbot/bin/python'} 19:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:26 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:32:26 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:32:26 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:32:26 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:32:26 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:32:26 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:32:26 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:32:26 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:32:26 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:32:26 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:32:26 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:32:26 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:32:26 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:32:26 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:32:27 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:32:27 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:32:27 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:32:27 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:32:27 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:32:27 INFO - Installing collected packages: marionette-driver 19:32:27 INFO - Running setup.py install for marionette-driver 19:32:27 INFO - Successfully installed marionette-driver 19:32:27 INFO - Cleaning up... 19:32:27 INFO - Return code: 0 19:32:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f253b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0840>, '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 0x22a1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a1bd0>, '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': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', '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:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:32:27 INFO - Using env: {'DISPLAY': ':0', 19:32:27 INFO - 'HOME': '/home/cltbld', 19:32:27 INFO - 'LANG': 'en_US.UTF-8', 19:32:27 INFO - 'LANGUAGE': 'en_US:en', 19:32:27 INFO - 'LOGNAME': 'cltbld', 19:32:27 INFO - 'MAIL': '/var/mail/cltbld', 19:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:27 INFO - 'MOZ_NO_REMOTE': '1', 19:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:27 INFO - 'NO_EM_RESTART': '1', 19:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:27 INFO - 'PWD': '/builds/slave/test', 19:32:27 INFO - 'SHELL': '/bin/bash', 19:32:27 INFO - 'SHLVL': '1', 19:32:27 INFO - 'TERM': 'linux', 19:32:27 INFO - 'TMOUT': '86400', 19:32:27 INFO - 'USER': 'cltbld', 19:32:27 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', 19:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:27 INFO - '_': '/tools/buildbot/bin/python'} 19:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:32:27 INFO - Cleaning up... 19:32:27 INFO - Return code: 0 19:32:27 INFO - Running post-action listener: _resource_record_post_action 19:32:27 INFO - Running post-action listener: _start_resource_monitoring 19:32:27 INFO - Starting resource monitoring. 19:32:27 INFO - [mozharness: 2017-06-02 02:32:27.801813Z] Finished create-virtualenv step (success) 19:32:27 INFO - [mozharness: 2017-06-02 02:32:27.802329Z] Running install step. 19:32:27 INFO - Running pre-action listener: _resource_record_pre_action 19:32:27 INFO - Running main action method: install 19:32:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:32:28 INFO - Reading from file tmpfile_stdout 19:32:28 INFO - Detecting whether we're running mozinstall >=1.0... 19:32:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:32:28 INFO - Reading from file tmpfile_stdout 19:32:28 INFO - Output received: 19:32:28 INFO - Usage: mozinstall [options] installer 19:32:28 INFO - Options: 19:32:28 INFO - -h, --help show this help message and exit 19:32:28 INFO - -d DEST, --destination=DEST 19:32:28 INFO - Directory to install application into. [default: 19:32:28 INFO - "/builds/slave/test"] 19:32:28 INFO - --app=APP Application being installed. [default: firefox] 19:32:28 INFO - mkdir: /builds/slave/test/build/application 19:32:28 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:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:32:44 INFO - Reading from file tmpfile_stdout 19:32:44 INFO - Output received: 19:32:44 INFO - /builds/slave/test/build/application/firefox/firefox 19:32:44 INFO - Running post-action listener: _resource_record_post_action 19:32:44 INFO - [mozharness: 2017-06-02 02:32:44.166560Z] Finished install step (success) 19:32:44 INFO - [mozharness: 2017-06-02 02:32:44.166839Z] Running setup-mitmproxy step. 19:32:44 INFO - Running pre-action listener: _resource_record_pre_action 19:32:44 INFO - Running main action method: setup_mitmproxy 19:32:44 INFO - Skipping: mitmproxy is not required 19:32:44 INFO - Running post-action listener: _resource_record_post_action 19:32:44 INFO - [mozharness: 2017-06-02 02:32:44.167962Z] Finished setup-mitmproxy step (success) 19:32:44 INFO - [mozharness: 2017-06-02 02:32:44.168184Z] Running run-tests step. 19:32:44 INFO - Running pre-action listener: _resource_record_pre_action 19:32:44 INFO - Running main action method: run_tests 19:32:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:32:44 INFO - Python 2.7.3 19:32:44 INFO - Return code: 0 19:32:44 INFO - grabbing minidump binary from tooltool 19:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:44 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 0x22a0840>, '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 0x22a1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a1bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:32:44 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:32:44 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:32:44 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:32:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:32:44 INFO - Return code: 0 19:32:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:32:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:32:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:32:44 INFO - ENV: RUST_BACKTRACE is now 1 19:32:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:32:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:32:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --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:32:44 INFO - Using env: {'DISPLAY': ':0', 19:32:44 INFO - 'HOME': '/home/cltbld', 19:32:44 INFO - 'LANG': 'en_US.UTF-8', 19:32:44 INFO - 'LANGUAGE': 'en_US:en', 19:32:44 INFO - 'LOGNAME': 'cltbld', 19:32:44 INFO - 'MAIL': '/var/mail/cltbld', 19:32:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:32:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:44 INFO - 'MOZ_NO_REMOTE': '1', 19:32:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:44 INFO - 'NO_EM_RESTART': '1', 19:32:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:44 INFO - 'PWD': '/builds/slave/test', 19:32:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:32:44 INFO - 'RUST_BACKTRACE': '1', 19:32:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:32:44 INFO - 'SHELL': '/bin/bash', 19:32:44 INFO - 'SHLVL': '1', 19:32:44 INFO - 'TERM': 'linux', 19:32:44 INFO - 'TMOUT': '86400', 19:32:44 INFO - 'USER': 'cltbld', 19:32:44 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268', 19:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:44 INFO - '_': '/tools/buildbot/bin/python'} 19:32:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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:32:44 INFO - mozversion application_buildid: 20170602015025 19:32:44 INFO - mozversion application_changeset: aeb3d0ca558f034cbef1c5a68bd07dd738611494 19:32:44 INFO - mozversion application_display_name: Nightly 19:32:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:32:44 INFO - mozversion application_name: Firefox 19:32:44 INFO - mozversion application_remotingname: firefox 19:32:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:32:44 INFO - mozversion application_vendor: Mozilla 19:32:44 INFO - mozversion application_version: 55.0a1 19:32:44 INFO - mozversion platform_buildid: 20170602015025 19:32:44 INFO - mozversion platform_changeset: aeb3d0ca558f034cbef1c5a68bd07dd738611494 19:32:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:32:44 INFO - mozversion platform_version: 55.0a1 19:32:44 INFO - using testdate: 1496370764 19:32:44 INFO - actual date: 1496370764 19:32:44 INFO - starting webserver on 'localhost:56472' 19:32:44 INFO - SUITE-START | Running 2 tests 19:32:44 INFO - TEST-START | dromaeo_css 19:32:44 INFO - operating with platform_type : linux_ 19:32:44 INFO - Initialising browser for dromaeo_css test... 19:32:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56472/getInfo.html -profile /tmp/tmp5Km1Eq/profile 19:32:44 INFO - TEST-INFO | started process 31215 (/builds/slave/test/build/application/firefox/firefox http://localhost:56472/getInfo.html) 19:33:19 INFO - TEST-INFO | 31215: killed by SIGTERM 19:33:19 INFO - Browser initialized. 19:33:19 INFO - Running cycle 1/1 for dromaeo_css test... 19:33:19 INFO - TEST-INFO | started process 31442 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Km1Eq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:33:31 INFO - PID 31442 | RSS: Main: 188776448 19:33:31 INFO - PID 31442 | 19:36:35 INFO - PID 31442 | Cycle 1(1): loaded http://localhost:56472/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56472/tests/dromaeo/cssquery-ext.html) 19:36:37 INFO - PID 31442 | RSS: Main: 184590336 19:36:37 INFO - PID 31442 | 19:39:39 INFO - PID 31442 | Cycle 1(1): loaded http://localhost:56472/tests/dromaeo/cssquery-ext.html (next: http://localhost:56472/tests/dromaeo/cssquery-jquery.html) 19:39:40 INFO - PID 31442 | RSS: Main: 187711488 19:39:40 INFO - PID 31442 | 19:42:42 INFO - PID 31442 | Cycle 1(1): loaded http://localhost:56472/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56472/tests/dromaeo/cssquery-mootools.html) 19:42:42 INFO - PID 31442 | RSS: Main: 186621952 19:42:42 INFO - PID 31442 | 19:45:44 INFO - PID 31442 | Cycle 1(1): loaded http://localhost:56472/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56472/tests/dromaeo/cssquery-prototype.html) 19:45:45 INFO - PID 31442 | RSS: Main: 188567552 19:45:45 INFO - PID 31442 | 19:48:48 INFO - PID 31442 | Cycle 1(1): loaded http://localhost:56472/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56472/tests/dromaeo/cssquery-yui.html) 19:48:48 INFO - PID 31442 | RSS: Main: 189009920 19:48:48 INFO - PID 31442 | 19:51:50 INFO - PID 31442 | Cycle 1(1): loaded http://localhost:56472/tests/dromaeo/cssquery-yui.html (next: http://localhost:56472/tests/dromaeo/cssquery-dojo.html) 19:51:51 INFO - PID 31442 | RSS: Main: 185864192 19:51:51 INFO - PID 31442 | 19:51:51 INFO - PID 31442 | __start_tp_report 19:51:51 INFO - PID 31442 | _x_x_mozilla_page_load 19:51:51 INFO - PID 31442 | _x_x_mozilla_page_load_details 19:51:51 INFO - PID 31442 | |i|pagename|runs| 19:51:51 INFO - PID 31442 | |0;dojo.html;2690.9999999999995;2698.8920443182274;2722.4963381774373;2736.6168736376912;2744.4648293582745;5070.391553013635;5150.072986862363;5173.073007959717;5210.947890521104;5220.112580861253;5128.871778205546;5138.768755406007;5176.352955880515;5208.270842082112;5252.3171987641645;4514.322851572258;4565;4584.037352156051;4599.563041511068;4623.214053610895;4601;4628.190066738307;4631.328457373679;4633.2818413146015;4678.017616300581;4519.050999290153;4558.179527685015;4580.725156490621;4585.174668559658;4639.76801159944;4588.7476188809605;4607.262837945946;4625.722456652578;4641.698289611165;4670.995735916794;4569.908601827945;4571;4574.702644328141;4580.5190455002075;4609.953900460986;5057.8735531612;5102.489751024905;5177.611679124043;5178.844634660966;5181.740912954375;5575.107982722786;5609.747561359749;5653;5662.292213473316;5668.546516278688;5589;5609.607327487078;5612.663240205601;5621.831345059655;5650.576206784508;5257.132573125392;5259.395169555473;5262.447443018428;5262.552683021986;5308.177232528887;5619.241402410704;5691.004074286983;5694.202811606296;5699.259096317535;5784.537237021028;5502.752376143083;5504.752286147133;5538.224648549206;5557.083081291542;5568.638038527482;5577.972110139423;5579.7489112990015;5593.636413633101;5606.887862242732;5614.522765564891;5420.864478387993;5438.646487978348;5497.505224529811;5553.305836770403;5619.129034999582;5496.285482887199;5523.861903452445;5562.332520097533;5569.526590239794;5576.972115139399;4645.39609850724;4661.440627124767;4673.976630116827;4675.7895894684825;4696.037312351028;3999.0402303446963;3999.140184860269;4029.6776257899296;4049.8785036448953;4056.918861622751;4551.886202844956;4599.632029437637;4609.285560738091;4642.326862604971;4673.929891051637;5562.721863906789;5566.2207290979295;5574.358948720868;5586.972065139729;5622.325320961429;4608.124456353349;4621.745803980813;4630.699004564693;4642.280446530793;4654.813807447732;4830.806767729322;4897.045076210176;4899.191633380524;4909.784698767541;4910.386201724713;5185.844424667266;5200.791968321225;5222.033923724123;5236.581073514186;5260.44765299638;5404.432534583812;5480.890382192413;5496.340439147328;5574.358948720949;5592.245046918777;5132.46109158533;5159.045576568196;5162.6386152968935;5195.246689230116;5209.114450543492;5415.48552887475;5466.289382380265;5484.067708489646;5484.862878428071;5527.861803454945;5527.391986881359;5568.331800184003;5595.104783234826;5595.972020139873;5604.355499117653;5351.331083614548;5359.303290572357;5425.864353391039;5426.891462170814;5439.619226654097;5357.571394288526;5367.409584945731;5371.973140134431;5378.784848606168;5423.864403389789;5246.055709972242;5294.814681486129;5302.681839089667;5306.204069389622;5325.573954083741;5324.254604355471;5391.406945236099;5421.5391691706645;5442.156465747657;5540.667559946416;5329.360476742816;5330.706811125426;5337.119375303031;5338.97330513345;5354.598405119554 19:51:51 INFO - PID 31442 | |1;ext.html;672.3646154384106;722.6820199112391;745.4222977192677;1057.6086847866286;1075.7848430313938;31178.844105779466;32133.83933080334;32197;32224.355512889757;32240.516392254136;33063;33421;33435.83282083592;33476.83261583689;33479.66520334796;6636.73453061877;6815.965920170393;6857.348551887575;6977.755778547752;6983.336583024605;6800.319968003209;6880.724771009153;6901.654917254143;6908.75819346323;6918.584884906922;6868.141482314711;6910.205326387454;6917.169939607229;6931.72273109075;6935.791926242196;6811.978203269499;6841.521093523405;6849.726010959555;6868.7252509899545;6875.656217189121;6693.431058360045;6723.260441351447;6781.932180678179;6788.08360871281;6800.421964133055;30317.393652127055;30381.240468988453;30412.239694007607;30470.085897423112;30580.235494112825;2876.4103358811603;2888.5522743974716;2891.6385451818524;2937.0601407549593;2960.718731720483;24068.27795166148;24100.15649452261;24114;24128.276151715476;24198.516029679486;2977.8213307201636;2979.865906034234;2996.730294273526;3044.9086527404215;3061.081675497342;121658;122396;129550.35224823815;142477.2876135623;142711;36253.45619815705;36431.4535281971;36604.816975915484;36719.63280367215;36851.447228291596;37976.43035354472;38028.295755636325;38093.80953095217;38182.23635527274;38280.617193827704;11764.58823941158;11933.224340417844;11936.224145430519;11976.760464790656;11985.28088314704;9429.2928030398;9512.619495220251;9526.380785248937;9583.233341332676;9587.760305992266;11846.881531184577;11876.465559049864;11921.403929803475;11989.580364687194;12113.33376664292;5220.738963051908;5289.629725919226;5292.894142117136;5368.436314187033;5375.543078838343;825.3520986025941;856.0626114404841;877.4252864373846;888.5512816027865;895.3329769321766;19690.31083912056;20642.348612111295;20656;20732.378028659165;21068.15727370888;917.6237742525666;925.5200446321744;928.7306681062416;941.8838676168625;943.2595412601212;10906.672799816019;10945.124390048777;10974.231803773659;11028.613998510174;11252.66242012741;156595;160766;161801;162157;171292;41461;41850.58149418528;42190.57809421867;42666.78666606647;43092.78453607774;1122.5958654884234;1132.2866594045863;1136.0343707848428;1143.1826244235244;1160.1704781081567;22878.885605571864;24256.272311830675;24669.753302466746;24742.25773226806;24756.876215618806;27508;27801.304967375978;28281.292967675974;28287.71712282933;28314.43371132607;145234;145499;146087;146166;146573.26713366364;28224.576631350137;28475.28811779722;28632.856835715687;28793.56809647899;28860.855695721388;33582.160445989044;33596;33641.327173456884;33833.83083084569;33931.15172120717;24777.87611061933;25523;25722.485550289264;26644.60033099544;26798.464030719668;25051.87474062618;26334.73665263323;26471.73528264693;26747;27080.32299192536;28502.144935651962;28623.713762862106;31463.528047078853;32895;33065.66934330626;34780.304393912484;34853.82573087118;35162.82418587993;35254.471182932786;35323.46765323447;22466.663000055338;25507.23478295654;27167.45665086727;27179.456410872066;27220.183394498195 19:51:51 INFO - PID 31442 | |2;jquery.html;400.69346949583576;408.8822726708845;412.66780241905275;422.66609378590914;432.36442429628454;12840.101192916476;13302.46790128396;17252.223649935753;17822.554436139086;17837.108144592767;17900.55248618785;18677.346292879753;18690.90654546729;18714.71927921079;18771.53071173221;5365.678059316434;5526.171074338841;5537.141743029817;5550.084236101038;5552.500274975251;5401.864953376158;5477.370102438231;5494.230807686907;5498.340199176105;5509.228707980886;5387.272718183034;5431.755570999295;5446.2375267462585;5467.972660136694;5469.206964990074;5100.209467532539;5324.440933701983;5337.653052551611;5348.572114230852;5378.435264297232;4847.781849816767;4850.296706977469;4875.439324477659;4880.633952453581;4882.584980276681;22069;22431.775682243133;22451.32646020622;22456.550868982693;22461;1409.8026276321323;1435.1891181482429;1439.3091316168193;1439.4098419647894;1439.8488158743392;14659.26703664823;14730.70538589233;14930.701385972328;14955.102693838297;15397.461088861948;2013.144413624204;2028.8985550722552;2039.1231770338748;2045.110376986001;2056.0644906567477;101025.4948725259;104592.99999999924;105411;105939;106054.46972765164;10473.423961682181;11012.50443730034;11078.667639970814;11119.499622517005;11368.431578421212;15139;15176.544703658908;15213;15224.162671053198;15260;7269.236730143364;7277.38142257914;7361.2638736125955;7385.778426647209;7420.666070026754;6763.188417389846;6844.28135045813;6869;6869.003994420881;6892.586444813327;6729.663516824139;6749.300279887986;6810.693518791666;6813.4889883257965;6834.555753875982;1892.1107079672531;1894.6589613869635;1907.3801014670287;1919.6832522633608;2009.708592254115;815.649270813544;826.1696994520588;849.4860609331389;884.062893333069;885.4288983605538;17144.828551714323;17629.294828206985;20000.19999200045;21521.67717484239;21843.344699659036;828.1180542721982;850.37497439382;864.8486514859875;882.1002577371046;882.955852207387;9067.183953444222;9342.439453632804;9422.90577094234;9603.855942160873;9758.853617195748;375616;376236;380161;380823;382490;90530.54734726416;93669;93721.06278937124;94320;94642.526787367;919.3977944446265;1038.3458421194598;1040.953157107932;1085.685151306128;1087.4345340422935;14699.485518006819;17442;17710.734338985185;18075.276988920297;18395.632087358445;42998.14003719846;43601.78199108984;44814;45046.324305136106;45085.77457112693;54865;55004;55397.72301138468;55461.44538554563;55558.44441555694;8666.78333041679;8693.870001849587;8742.650293988168;8793.516356600192;8812.295016398544;10577.947110264708;11164.497597607964;13540.526081587492;13611;13871.653208669864;12019.91820736138;12095.274283543016;12126.029917606747;12181.451834667638;12645.178063425848;11443.427828608703;11886.643400697993;12030.63908082759;12347.62957111288;12722.936385318384;13021.739565208452;13025.153365031243;13287.66780830487;13290.13614115118;13313;9406.05939406054;9484.525773711424;9491.671166036622;9495.815962328841;9655.806883862142;12973.351332433529;13073.084884058024;13279.734405312032;13291.268980206181;13373.799393008918 19:51:51 INFO - PID 31442 | |3;mootools.html;1237.6843904804275;1282.56392826439;1290.9870901290985;1291.2704322058037;1306.97386052279;9458.432494050361;9746.70759877203;9854.605815767369;9895.356801807895;9990.25073119517;9540.713778586654;9768.267379946497;9784.510774461283;9792.951035244832;9821.459819709913;2139.668351405535;2171.880546569938;2181.040342249405;2189.2447105748493;2197.7802219778055;1930.4594713480249;1951.980480195194;1954.902254887257;1955.8630895837298;1965.3219639224444;2047.3039166683325;2064.8348132149467;2070.81362677359;2071.968920466194;2072.274703853654;2026.5744193719336;2031.0860112949158;2038.5820906714162;2045.98977005114;2046.2326627514683;1746.6070134219826;1810.7374430707605;1895.5924476237537;1934.9164467898022;1959.6080783843147;9868.851967220497;9947.502624868728;9952.154066904322;9952.4028558286;9956;4925.433575138869;5135.024345374404;5137.306463627438;5139.717315547643;5140.742962851842;2946.2634341414646;3046.7714921380984;3109.362580670957;3114.205877501223;3118.23603217211;946.3233787841657;958.7746879483316;975.9609615615437;978.0659470205936;982.6904525074578;14065.226412547307;14219.36012879423;14230.28848557568;14231.359588818425;14285.78571321431;4225.746455212636;4226.492820861455;4285.871423857289;4359.956400436018;4401.097774956126;10953.34279943206;10974.506147223394;10978.780424391467;11030.889691103146;11174.944125279322;5196.558292545101;5323.973380133075;5336.332958380202;5355.758990845421;5360.303160589098;4761.166795810719;4899.510048995072;4930.580900623416;4931.605471562267;4936.531029552187;3813.542374915028;3873.709471789627;3904.492415985904;3960.207958408272;3979.2041591681777;1125.5610311978335;1126.2904370246856;1136.534021051365;1140.8345789860423;1153.5039932828963;673.8382788130912;710.591409939287;712.0600806934797;729.2233771033832;730.1493759769809;5452.754626041838;5549.750261238254;5583.748731307101;5587.106063029895;5653.23681303027;512.3365242011604;525.8238490105781;527.8442859356499;532.2362409941669;534.7005676820993;3484.9651503484642;3836.36699944506;3867.8259478323544;3881.825317860703;3920.9215815684097;11816.46825892837;12166.39168041612;12177.391130443442;12178.695532611755;12233.327167005722;12021.278723276631;12050.216735912138;12138.211016283913;12158.088143389281;12167.513299467922;6709.865802683919;6716.731330746716;6781.321867813278;7024.754133605299;7135.6432178391915;5520;5743.827685169452;5815.912761308499;5859.9121013183985;6071.817845464643;11401.771964560496;11591;11594.6521604352;11715.648530544097;11737;12068.39658017078;12256.938715306367;12298.754024919273;12361.752764944831;12441.377931103227;7723.266289702469;7839.843203135792;7844.80387990282;7858.0570331560575;7861.2531809478005;8964.103589640983;9072.682456114004;9081.500517471603;9092.363534552518;9133.725988220363;7538.623068846426;7571.924280757122;7632.923670763222;7717.6141192939;7850.293473587404;7606.04924384452;7691;7696.037995250594;7784.377249820114;7818.374530037697;6872.41584465306;7001.124859392576;7020.964895175695;7022.578645281095;7082.610456424946;4810.350602668595;4915.43472500667;4961.479044700399;4972.588294677006;5039.966806804523;4907.705537667752;4957.405111386656;4964.925526117039;4987.900241995212;5032.295478632921 19:51:51 INFO - PID 31442 | |4;prototype.html;347.7478827849808;356.0369201310455;356.4510653593466;366.1614901874707;370.1523511159446;5351.545118664909;5470.316210473686;5476.424975377583;5494.917576236359;5497.7904860930585;5222.3472065991755;5302.125149350362;5302.284191634129;5327.893442131165;5336.493033161843;4067.7966101694947;4080.3879418087226;4091.304478238692;4098.098418347959;4111.259973204822;4120.526139493952;4121.814518346681;4126.484189476316;4128.62842344189;4129.318662420697;4082.836686532535;4086.3053280942313;4096.5698601646845;4099.856505022325;4107.829268658433;4087.7751723655188;4092.1815636872598;4095.2219078375015;4104.835806567734;4114.753114813121;3602.009447401985;3604.6662734788033;3613.2231570212266;3618.149734812317;3630.473581330719;5266.760942020668;5268.525832675039;5292.179712144585;5310.522053015208;5327.600429967768;4826.444958829745;4827.903441931142;4851.248056551205;4856.077345304416;4861.78121984508;5686.800961966353;5691.9146212806845;5692.288463942007;5705.74324155414;5716.371199168088;4054.2702313583545;4070.1859628074503;4074.857379991716;4075.246079475277;4079.3676980068135;5748.712564371806;5965.135055416984;6031.849203769897;6113.205283313186;6132.264128304588;4029.2948733972025;4037.475128233311;4072.592740725963;4075.1034772350035;4083.0608959938786;4109.301418758818;4118.361653943583;4128.6284234419045;4130.215259100822;4136.110736191733;4624.213883639722;4726.007538416971;4731.692439991459;4732.763361831895;4732.787024583902;5678.21136342051;5726.594830171338;5731.140328950691;5738.340090889517;5741.770329186869;1423.1318895473753;1445.5591044731457;1447.7900704398014;1448.2903377345026;1450.7968884356198;956.2159029595804;977.8973207813077;987.7728122531857;988.0662773678948;991.9256055795844;4876.658633895664;4887.315775791392;4891.73095479752;4898.951010489921;4901.975490122527;5876.353601103875;5878.2064421302575;5887.882242355129;5917.763289468459;5939.346671866091;4855.1018061658;4860.878478038077;4864.562189402971;4870.95129048705;4871.902561948812;3101.8138911665374;3142.795718278305;3147.213196700825;3147.874085036619;3148.889788857379;5524.889502209933;5526.253955716007;5531.529819965268;5534.391216966131;5541.5289700375115;6072.605280656743;6073.384227986674;6109.5112391008615;6120.234970628671;6150.477209437248;5471.37079235893;5476.370217424967;5481.588880834033;5487.6158668892795;5499.945000550103;5906.940930590639;5937.3468918418075;5941.435563621449;5952.345242023287;5956.255468066492;5788.363280039108;5804.796832110856;5864.824055278348;5870.236869206976;5875.6474611523445;5227.294315267391;5325.760340784596;5380.488853558905;5488.204210389551;5516.558675306046;4107.630313271819;4117.75293482392;4119.46446961905;4128.504579450485;4163.6669066474005;5889.49939255151;5903.144044113494;5914.378990205966;5927.762889484545;5951.345352011189;5559.193916881949;5671.6597004179885;5710.743016564182;5734.483896449173;5754.6547207167705;5692.036247494608;5719.342275638355;5729.512991395778;5735.13972904051;5783.624064435799;5638.520725738194;5639.859003524781;5641.069223578063;5647.491725744702;5676.091825307931;5754.827355179351;5756.913646295393;5782.971085144715;5786.479216870502;5788.247527821356;5597.80407685729;5597.888042239214;5617.859553511195;5633.661980281032;5635.239242702182 19:51:51 INFO - PID 31442 | |5;yui.html;677.5054210426389;679.687343821842;680.8910574308112;697.5082566790413;699.0283505926761;12920.612381628554;13369.39837707303;13445.731085378298;15399.92300038501;16638;15316.234188290597;15410.229488525585;15444.5366639001;15456.149911754848;15500.06999580026;807.8020884883197;816.7958010497375;817.5380909785952;817.5380909785981;818.8403261364036;800.2997377294867;823.0617096509983;823.407146854267;828.8052307707684;852.5651917522047;861.8448679237734;862.9352798540135;866.1035827918106;866.4931015356025;868.2489646455833;859.4198915731856;861.8190180062195;863.0894406401244;863.4171933944593;865.2515574028483;633.2812258087105;633.5280216238931;634.5241069198102;635.2059925093633;635.942765151134;14091.577252682437;14323.427062917472;14328.355224014944;14388.424463021467;14388.712225755426;13940.302984850818;14871;15012.699746005019;15044.924775376054;15073;11532.769344613145;12128.939355303255;12153.508530751174;12263.816042759367;12340.629781106582;2966.1991262359256;2975.062855200605;2977.077106097117;2980.910572682823;2991.820490770561;73769;75116;76794.61602692006;76832;79027.20972790313;11443.656690299304;11692.415379231004;11774.05807535395;11785.646430607096;11789.469473873696;19304.32434864773;20386.28647997313;20462.079206435745;20518.89740551288;20566.177352906016;5788.710564471759;5929.6145750526075;5937.52499800015;5940.584159108907;5941.168236446901;2753.2979090331837;2801.761850242752;2805.9158225253277;2836.1633318170775;2891.5951766752673;3331.900042998714;3410.686885549032;3416.906589891261;3423.3153369326233;3426.5716785401823;679.0154276299386;686.1594546680277;686.5297271369028;689.2349492063805;690.0305071374727;492.2493197873272;505.1463027483541;505.2724077328635;507.6471852062781;524.1875093604897;10333.121684656739;10386;10566.577336906437;10607.416592087355;10897.346159230472;506.2153661824158;510.54306395775575;511.759473047667;516.1741214057553;518.2511271213136;4139.4683966931825;4345.456817897762;4378.211921854033;4481.238189507726;4498.6626003049905;85897;86754;86818;87403;87556;75607.62196188983;75810;75842.62078689571;76898;77069;61221.38778612246;62794;63510;63730;66436.66781666157;8490.57547122629;8554.700585479479;8602.655893764178;8617.526036067826;8636.481811091355;28446;29569.556456652736;29648.110556683336;30145.849270753504;30721.846390767903;35975.92072237837;36472.27055458823;36656.81671591625;37132.62867371292;37576.62423375731;11217.495212715285;13029.15310504814;13832.170069795844;13897.305134743425;13970.650733731738;14805.259737013323;16087.839121608635;16100.67798643997;16272.430464934145;16480.917595412426;13603.659908502366;13675.794863076862;13746.725065498835;13863.79204311916;14008.719825603635;13307.135036222615;13538.86461135376;13670.11144275619;13692.794608081085;14615.269236537917;14213.431462741375;14239.35922883452;14369.56891293263;14392;14607;9841.1635011022;9890.901090988998;10181.694549163536;10399.948000260252;10589.4705264738;10753.279475283916;11426.143039271921;11537;11745.29528228309;11747.47136378848 19:51:51 INFO - PID 31442 | __end_tp_report 19:51:51 INFO - PID 31442 | __start_cc_report 19:51:51 INFO - PID 31442 | _x_x_mozilla_cycle_collect,378 19:51:51 INFO - PID 31442 | __end_cc_report 19:51:51 INFO - PID 31442 | __startTimestamp1496371911151__endTimestamp 19:51:51 INFO - PID 31442 | 19:51:51 INFO - PID 31442 | ------- Summary: start ------- 19:51:51 INFO - PID 31442 | Number of tests: 6 19:51:51 INFO - PID 31442 | 19:51:51 INFO - PID 31442 | [#0] dojo.html Cycles:165 Average:5085.14 Median:5260.45 stddev:597.38 (11.4%) stddev-sans-first:568.93 19:51:51 INFO - PID 31442 | Values: 2691.0 2698.9 2722.5 2736.6 2744.5 5070.4 5150.1 5173.1 5210.9 5220.1 5128.9 5138.8 5176.4 5208.3 5252.3 4514.3 4565.0 4584.0 4599.6 4623.2 4601.0 4628.2 4631.3 4633.3 4678.0 4519.1 4558.2 4580.7 4585.2 4639.8 4588.7 4607.3 4625.7 4641.7 4671.0 4569.9 4571.0 4574.7 4580.5 4610.0 5057.9 5102.5 5177.6 5178.8 5181.7 5575.1 5609.7 5653.0 5662.3 5668.5 5589.0 5609.6 5612.7 5621.8 5650.6 5257.1 5259.4 5262.4 5262.6 5308.2 5619.2 5691.0 5694.2 5699.3 5784.5 5502.8 5504.8 5538.2 5557.1 5568.6 5578.0 5579.7 5593.6 5606.9 5614.5 5420.9 5438.6 5497.5 5553.3 5619.1 5496.3 5523.9 5562.3 5569.5 5577.0 4645.4 4661.4 4674.0 4675.8 4696.0 3999.0 3999.1 4029.7 4049.9 4056.9 4551.9 4599.6 4609.3 4642.3 4673.9 5562.7 5566.2 5574.4 5587.0 5622.3 4608.1 4621.7 4630.7 4642.3 4654.8 4830.8 4897.0 4899.2 4909.8 4910.4 5185.8 5200.8 5222.0 5236.6 5260.4 5404.4 5480.9 5496.3 5574.4 5592.2 5132.5 5159.0 5162.6 5195.2 5209.1 5415.5 5466.3 5484.1 5484.9 5527.9 5527.4 5568.3 5595.1 5596.0 5604.4 5351.3 5359.3 5425.9 5426.9 5439.6 5357.6 5367.4 5372.0 5378.8 5423.9 5246.1 5294.8 5302.7 5306.2 5325.6 5324.3 5391.4 5421.5 5442.2 5540.7 5329.4 5330.7 5337.1 5339.0 5354.6 19:51:51 INFO - PID 31442 | 19:51:51 INFO - PID 31442 | [#1] ext.html Cycles:180 Average:29168.02 Median:16757.50 stddev:37939.48 (226.4%) stddev-sans-first:37985.56 19:51:51 INFO - PID 31442 | Values: 672.4 722.7 745.4 1057.6 1075.8 31178.8 32133.8 32197.0 32224.4 32240.5 33063.0 33421.0 33435.8 33476.8 33479.7 6636.7 6816.0 6857.3 6977.8 6983.3 6800.3 6880.7 6901.7 6908.8 6918.6 6868.1 6910.2 6917.2 6931.7 6935.8 6812.0 6841.5 6849.7 6868.7 6875.7 6693.4 6723.3 6781.9 6788.1 6800.4 30317.4 30381.2 30412.2 30470.1 30580.2 2876.4 2888.6 2891.6 2937.1 2960.7 24068.3 24100.2 24114.0 24128.3 24198.5 2977.8 2979.9 2996.7 3044.9 3061.1 121658.0 122396.0 129550.4 142477.3 142711.0 36253.5 36431.5 36604.8 36719.6 36851.4 37976.4 38028.3 38093.8 38182.2 38280.6 11764.6 11933.2 11936.2 11976.8 11985.3 9429.3 9512.6 9526.4 9583.2 9587.8 11846.9 11876.5 11921.4 11989.6 12113.3 5220.7 5289.6 5292.9 5368.4 5375.5 825.4 856.1 877.4 888.6 895.3 19690.3 20642.3 20656.0 20732.4 21068.2 917.6 925.5 928.7 941.9 943.3 10906.7 10945.1 10974.2 11028.6 11252.7 156595.0 160766.0 161801.0 162157.0 171292.0 41461.0 41850.6 42190.6 42666.8 43092.8 1122.6 1132.3 1136.0 1143.2 1160.2 22878.9 24256.3 24669.8 24742.3 24756.9 27508.0 27801.3 28281.3 28287.7 28314.4 145234.0 145499.0 146087.0 146166.0 146573.3 28224.6 28475.3 28632.9 28793.6 28860.9 33582.2 33596.0 33641.3 33833.8 33931.2 24777.9 25523.0 25722.5 26644.6 26798.5 25051.9 26334.7 26471.7 26747.0 27080.3 28502.1 28623.7 31463.5 32895.0 33065.7 34780.3 34853.8 35162.8 35254.5 35323.5 22466.7 25507.2 27167.5 27179.5 27220.2 19:51:51 INFO - PID 31442 | 19:51:51 INFO - PID 31442 | [#2] jquery.html Cycles:180 Average:26623.31 Median:378198.50 stddev:63989.74 (16.9%) stddev-sans-first:64138.96 19:51:51 INFO - PID 31442 | Values: 400.7 408.9 412.7 422.7 432.4 12840.1 13302.5 17252.2 17822.6 17837.1 17900.6 18677.3 18690.9 18714.7 18771.5 5365.7 5526.2 5537.1 5550.1 5552.5 5401.9 5477.4 5494.2 5498.3 5509.2 5387.3 5431.8 5446.2 5468.0 5469.2 5100.2 5324.4 5337.7 5348.6 5378.4 4847.8 4850.3 4875.4 4880.6 4882.6 22069.0 22431.8 22451.3 22456.6 22461.0 1409.8 1435.2 1439.3 1439.4 1439.8 14659.3 14730.7 14930.7 14955.1 15397.5 2013.1 2028.9 2039.1 2045.1 2056.1 101025.5 104593.0 105411.0 105939.0 106054.5 10473.4 11012.5 11078.7 11119.5 11368.4 15139.0 15176.5 15213.0 15224.2 15260.0 7269.2 7277.4 7361.3 7385.8 7420.7 6763.2 6844.3 6869.0 6869.0 6892.6 6729.7 6749.3 6810.7 6813.5 6834.6 1892.1 1894.7 1907.4 1919.7 2009.7 815.6 826.2 849.5 884.1 885.4 17144.8 17629.3 20000.2 21521.7 21843.3 828.1 850.4 864.8 882.1 883.0 9067.2 9342.4 9422.9 9603.9 9758.9 375616.0 376236.0 380161.0 380823.0 382490.0 90530.5 93669.0 93721.1 94320.0 94642.5 919.4 1038.3 1041.0 1085.7 1087.4 14699.5 17442.0 17710.7 18075.3 18395.6 42998.1 43601.8 44814.0 45046.3 45085.8 54865.0 55004.0 55397.7 55461.4 55558.4 8666.8 8693.9 8742.7 8793.5 8812.3 10577.9 11164.5 13540.5 13611.0 13871.7 12019.9 12095.3 12126.0 12181.5 12645.2 11443.4 11886.6 12030.6 12347.6 12722.9 13021.7 13025.2 13287.7 13290.1 13313.0 9406.1 9484.5 9491.7 9495.8 9655.8 12973.4 13073.1 13279.7 13291.3 13373.8 19:51:51 INFO - PID 31442 | 19:51:51 INFO - PID 31442 | [#3] mootools.html Cycles:180 Average:5981.53 Median:4928.01 stddev:3871.61 (78.6%) stddev-sans-first:3866.06 19:51:51 INFO - PID 31442 | Values: 1237.7 1282.6 1291.0 1291.3 1307.0 9458.4 9746.7 9854.6 9895.4 9990.3 9540.7 9768.3 9784.5 9793.0 9821.5 2139.7 2171.9 2181.0 2189.2 2197.8 1930.5 1952.0 1954.9 1955.9 1965.3 2047.3 2064.8 2070.8 2072.0 2072.3 2026.6 2031.1 2038.6 2046.0 2046.2 1746.6 1810.7 1895.6 1934.9 1959.6 9868.9 9947.5 9952.2 9952.4 9956.0 4925.4 5135.0 5137.3 5139.7 5140.7 2946.3 3046.8 3109.4 3114.2 3118.2 946.3 958.8 976.0 978.1 982.7 14065.2 14219.4 14230.3 14231.4 14285.8 4225.7 4226.5 4285.9 4360.0 4401.1 10953.3 10974.5 10978.8 11030.9 11174.9 5196.6 5324.0 5336.3 5355.8 5360.3 4761.2 4899.5 4930.6 4931.6 4936.5 3813.5 3873.7 3904.5 3960.2 3979.2 1125.6 1126.3 1136.5 1140.8 1153.5 673.8 710.6 712.1 729.2 730.1 5452.8 5549.8 5583.7 5587.1 5653.2 512.3 525.8 527.8 532.2 534.7 3485.0 3836.4 3867.8 3881.8 3920.9 11816.5 12166.4 12177.4 12178.7 12233.3 12021.3 12050.2 12138.2 12158.1 12167.5 6709.9 6716.7 6781.3 7024.8 7135.6 5520.0 5743.8 5815.9 5859.9 6071.8 11401.8 11591.0 11594.7 11715.6 11737.0 12068.4 12256.9 12298.8 12361.8 12441.4 7723.3 7839.8 7844.8 7858.1 7861.3 8964.1 9072.7 9081.5 9092.4 9133.7 7538.6 7571.9 7632.9 7717.6 7850.3 7606.0 7691.0 7696.0 7784.4 7818.4 6872.4 7001.1 7021.0 7022.6 7082.6 4810.4 4915.4 4961.5 4972.6 5040.0 4907.7 4957.4 4964.9 4987.9 5032.3 19:51:51 INFO - PID 31442 | 19:51:51 INFO - PID 31442 | [#4] prototype.html Cycles:180 Average:4712.97 Median:5332.19 stddev:1392.17 (26.1%) stddev-sans-first:1356.97 19:51:51 INFO - PID 31442 | Values: 347.7 356.0 356.5 366.2 370.2 5351.5 5470.3 5476.4 5494.9 5497.8 5222.3 5302.1 5302.3 5327.9 5336.5 4067.8 4080.4 4091.3 4098.1 4111.3 4120.5 4121.8 4126.5 4128.6 4129.3 4082.8 4086.3 4096.6 4099.9 4107.8 4087.8 4092.2 4095.2 4104.8 4114.8 3602.0 3604.7 3613.2 3618.1 3630.5 5266.8 5268.5 5292.2 5310.5 5327.6 4826.4 4827.9 4851.2 4856.1 4861.8 5686.8 5691.9 5692.3 5705.7 5716.4 4054.3 4070.2 4074.9 4075.2 4079.4 5748.7 5965.1 6031.8 6113.2 6132.3 4029.3 4037.5 4072.6 4075.1 4083.1 4109.3 4118.4 4128.6 4130.2 4136.1 4624.2 4726.0 4731.7 4732.8 4732.8 5678.2 5726.6 5731.1 5738.3 5741.8 1423.1 1445.6 1447.8 1448.3 1450.8 956.2 977.9 987.8 988.1 991.9 4876.7 4887.3 4891.7 4899.0 4902.0 5876.4 5878.2 5887.9 5917.8 5939.3 4855.1 4860.9 4864.6 4871.0 4871.9 3101.8 3142.8 3147.2 3147.9 3148.9 5524.9 5526.3 5531.5 5534.4 5541.5 6072.6 6073.4 6109.5 6120.2 6150.5 5471.4 5476.4 5481.6 5487.6 5499.9 5906.9 5937.3 5941.4 5952.3 5956.3 5788.4 5804.8 5864.8 5870.2 5875.6 5227.3 5325.8 5380.5 5488.2 5516.6 4107.6 4117.8 4119.5 4128.5 4163.7 5889.5 5903.1 5914.4 5927.8 5951.3 5559.2 5671.7 5710.7 5734.5 5754.7 5692.0 5719.3 5729.5 5735.1 5783.6 5638.5 5639.9 5641.1 5647.5 5676.1 5754.8 5756.9 5783.0 5786.5 5788.2 5597.8 5597.9 5617.9 5633.7 5635.2 19:51:51 INFO - PID 31442 | 19:51:51 INFO - PID 31442 | [#5] yui.html Cycles:180 Average:16945.17 Median:3420.11 stddev:22554.99 (659.5%) stddev-sans-first:22585.18 19:51:51 INFO - PID 31442 | Values: 677.5 679.7 680.9 697.5 699.0 12920.6 13369.4 13445.7 15399.9 16638.0 15316.2 15410.2 15444.5 15456.1 15500.1 807.8 816.8 817.5 817.5 818.8 800.3 823.1 823.4 828.8 852.6 861.8 862.9 866.1 866.5 868.2 859.4 861.8 863.1 863.4 865.3 633.3 633.5 634.5 635.2 635.9 14091.6 14323.4 14328.4 14388.4 14388.7 13940.3 14871.0 15012.7 15044.9 15073.0 11532.8 12128.9 12153.5 12263.8 12340.6 2966.2 2975.1 2977.1 2980.9 2991.8 73769.0 75116.0 76794.6 76832.0 79027.2 11443.7 11692.4 11774.1 11785.6 11789.5 19304.3 20386.3 20462.1 20518.9 20566.2 5788.7 5929.6 5937.5 5940.6 5941.2 2753.3 2801.8 2805.9 2836.2 2891.6 3331.9 3410.7 3416.9 3423.3 3426.6 679.0 686.2 686.5 689.2 690.0 492.2 505.1 505.3 507.6 524.2 10333.1 10386.0 10566.6 10607.4 10897.3 506.2 510.5 511.8 516.2 518.3 4139.5 4345.5 4378.2 4481.2 4498.7 85897.0 86754.0 86818.0 87403.0 87556.0 75607.6 75810.0 75842.6 76898.0 77069.0 61221.4 62794.0 63510.0 63730.0 66436.7 8490.6 8554.7 8602.7 8617.5 8636.5 28446.0 29569.6 29648.1 30145.8 30721.8 35975.9 36472.3 36656.8 37132.6 37576.6 11217.5 13029.2 13832.2 13897.3 13970.7 14805.3 16087.8 16100.7 16272.4 16480.9 13603.7 13675.8 13746.7 13863.8 14008.7 13307.1 13538.9 13670.1 13692.8 14615.3 14213.4 14239.4 14369.6 14392.0 14607.0 9841.2 9890.9 10181.7 10399.9 10589.5 10753.3 11426.1 11537.0 11745.3 11747.5 19:51:51 INFO - PID 31442 | -------- Summary: end -------- 19:51:51 INFO - PID 31442 | 19:51:52 INFO - TEST-INFO | 31442: exit 0 19:51:52 INFO - TEST-OK | dromaeo_css | took 1147617ms 19:51:52 INFO - TEST-START | kraken 19:51:52 INFO - operating with platform_type : linux_ 19:51:52 INFO - Initialising browser for kraken test... 19:51:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56472/getInfo.html -profile /tmp/tmpcRoMFN/profile 19:51:52 INFO - TEST-INFO | started process 31863 (/builds/slave/test/build/application/firefox/firefox http://localhost:56472/getInfo.html) 19:52:27 INFO - TEST-INFO | 31863: killed by SIGTERM 19:52:27 INFO - Browser initialized. 19:52:27 INFO - Running cycle 1/1 for kraken test... 19:52:27 INFO - TEST-INFO | started process 32090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcRoMFN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:39 INFO - PID 32090 | RSS: Main: 188227584 19:52:39 INFO - PID 32090 | 19:52:41 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56472/tests/kraken/driver.html?testName=audio-beat-detection) 19:52:42 INFO - PID 32090 | RSS: Main: 191959040 19:52:42 INFO - PID 32090 | 19:52:45 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56472/tests/kraken/driver.html?testName=audio-dft) 19:52:46 INFO - PID 32090 | RSS: Main: 190312448 19:52:46 INFO - PID 32090 | 19:52:49 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56472/tests/kraken/driver.html?testName=audio-fft) 19:52:49 INFO - PID 32090 | RSS: Main: 186003456 19:52:49 INFO - PID 32090 | 19:52:51 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56472/tests/kraken/driver.html?testName=audio-oscillator) 19:52:52 INFO - PID 32090 | RSS: Main: 186155008 19:52:52 INFO - PID 32090 | 19:52:54 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56472/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:52:55 INFO - PID 32090 | RSS: Main: 186220544 19:52:55 INFO - PID 32090 | 19:52:58 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56472/tests/kraken/driver.html?testName=imaging-darkroom) 19:52:59 INFO - PID 32090 | RSS: Main: 187944960 19:52:59 INFO - PID 32090 | 19:53:02 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56472/tests/kraken/driver.html?testName=imaging-desaturate) 19:53:03 INFO - PID 32090 | RSS: Main: 187527168 19:53:03 INFO - PID 32090 | 19:53:06 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56472/tests/kraken/driver.html?testName=json-parse-financial) 19:53:06 INFO - PID 32090 | RSS: Main: 187637760 19:53:06 INFO - PID 32090 | 19:53:08 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56472/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:53:09 INFO - PID 32090 | RSS: Main: 188289024 19:53:09 INFO - PID 32090 | 19:53:10 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56472/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:53:11 INFO - PID 32090 | RSS: Main: 187592704 19:53:11 INFO - PID 32090 | 19:53:13 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56472/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:53:14 INFO - PID 32090 | RSS: Main: 187858944 19:53:14 INFO - PID 32090 | 19:53:17 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:53:17 INFO - PID 32090 | RSS: Main: 187346944 19:53:17 INFO - PID 32090 | 19:53:21 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:53:21 INFO - PID 32090 | RSS: Main: 187363328 19:53:21 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | Cycle 1(1): loaded http://localhost:56472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56472/tests/kraken/driver.html?testName=ai-astar) 19:53:23 INFO - PID 32090 | RSS: Main: 188694528 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | __start_tp_report 19:53:23 INFO - PID 32090 | _x_x_mozilla_page_load 19:53:23 INFO - PID 32090 | _x_x_mozilla_page_load_details 19:53:23 INFO - PID 32090 | |i|pagename|runs| 19:53:23 INFO - PID 32090 | |0;ai-astar;102;111;109;110;110;111;111;109;109;113 19:53:23 INFO - PID 32090 | |1;audio-beat-detection;159;126;123;168;124;128;125;121;154;122 19:53:23 INFO - PID 32090 | |2;audio-dft;162;163;167;162;166;169;166;167;164;163 19:53:23 INFO - PID 32090 | |3;audio-fft;76;73;74;110;74;74;75;73;95;76 19:53:23 INFO - PID 32090 | |4;audio-oscillator;82;84;105;83;82;84;97;82;82;116 19:53:23 INFO - PID 32090 | |5;imaging-gaussian-blur;114;119;117;115;114;117;118;114;114;115 19:53:23 INFO - PID 32090 | |6;imaging-darkroom;151;150;150;150;153;150;150;152;152;154 19:53:23 INFO - PID 32090 | |7;imaging-desaturate;94;96;94;94;94;96;94;95;95;95 19:53:23 INFO - PID 32090 | |8;json-parse-financial;55;56;55;55;55;54;58;57;60;56 19:53:23 INFO - PID 32090 | |9;json-stringify-tinderbox;55;56;57;56;56;56;56;62;71;56 19:53:23 INFO - PID 32090 | |10;stanford-crypto-aes;87;104;89;87;95;87;87;90;124;86 19:53:23 INFO - PID 32090 | |11;stanford-crypto-ccm;142;135;149;131;136;136;134;138;146;156 19:53:23 INFO - PID 32090 | |12;stanford-crypto-pbkdf2;187;196;193;200;198;203;208;194;196;195 19:53:23 INFO - PID 32090 | |13;stanford-crypto-sha256-iterative;74;71;75;73;77;73;71;70;73;73 19:53:23 INFO - PID 32090 | __end_tp_report 19:53:23 INFO - PID 32090 | __start_cc_report 19:53:23 INFO - PID 32090 | _x_x_mozilla_cycle_collect,1039 19:53:23 INFO - PID 32090 | __end_cc_report 19:53:23 INFO - PID 32090 | __startTimestamp1496372003887__endTimestamp 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | ------- Summary: start ------- 19:53:23 INFO - PID 32090 | Number of tests: 14 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.92 (2.6%) stddev-sans-first:1.32 19:53:23 INFO - PID 32090 | Values: 102.0 111.0 109.0 110.0 110.0 111.0 111.0 109.0 109.0 113.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:127.00 stddev:17.91 (14.1%) stddev-sans-first:16.76 19:53:23 INFO - PID 32090 | Values: 159.0 126.0 123.0 168.0 124.0 128.0 125.0 121.0 154.0 122.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#2] audio-dft Cycles:10 Average:164.90 Median:166.00 stddev:2.42 (1.5%) stddev-sans-first:2.33 19:53:23 INFO - PID 32090 | Values: 162.0 163.0 167.0 162.0 166.0 169.0 166.0 167.0 164.0 163.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#3] audio-fft Cycles:10 Average:80.00 Median:74.50 stddev:12.42 (16.7%) stddev-sans-first:13.09 19:53:23 INFO - PID 32090 | Values: 76.0 73.0 74.0 110.0 74.0 74.0 75.0 73.0 95.0 76.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.50 stddev:12.14 (14.7%) stddev-sans-first:12.55 19:53:23 INFO - PID 32090 | Values: 82.0 84.0 105.0 83.0 82.0 84.0 97.0 82.0 82.0 116.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:116.00 stddev:1.89 (1.6%) stddev-sans-first:1.90 19:53:23 INFO - PID 32090 | Values: 114.0 119.0 117.0 115.0 114.0 117.0 118.0 114.0 114.0 115.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.50 stddev:1.48 (1.0%) stddev-sans-first:1.56 19:53:23 INFO - PID 32090 | Values: 151.0 150.0 150.0 150.0 153.0 150.0 150.0 152.0 152.0 154.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 19:53:23 INFO - PID 32090 | Values: 94.0 96.0 94.0 94.0 94.0 96.0 94.0 95.0 95.0 95.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.79 (3.2%) stddev-sans-first:1.86 19:53:23 INFO - PID 32090 | Values: 55.0 56.0 55.0 55.0 55.0 54.0 58.0 57.0 60.0 56.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:56.00 stddev:4.93 (8.8%) stddev-sans-first:5.10 19:53:23 INFO - PID 32090 | Values: 55.0 56.0 57.0 56.0 56.0 56.0 56.0 62.0 71.0 56.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:87.00 stddev:12.02 (13.8%) stddev-sans-first:12.51 19:53:23 INFO - PID 32090 | Values: 87.0 104.0 89.0 87.0 95.0 87.0 87.0 90.0 124.0 86.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:140.00 stddev:7.85 (5.6%) stddev-sans-first:8.30 19:53:23 INFO - PID 32090 | Values: 142.0 135.0 149.0 131.0 136.0 136.0 134.0 138.0 146.0 156.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.00 Median:197.00 stddev:5.75 (2.9%) stddev-sans-first:4.83 19:53:23 INFO - PID 32090 | Values: 187.0 196.0 193.0 200.0 198.0 203.0 208.0 194.0 196.0 195.0 19:53:23 INFO - PID 32090 | 19:53:23 INFO - PID 32090 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.00 stddev:2.05 (2.8%) stddev-sans-first:2.15 19:53:23 INFO - PID 32090 | Values: 74.0 71.0 75.0 73.0 77.0 73.0 71.0 70.0 73.0 73.0 19:53:23 INFO - PID 32090 | -------- Summary: end -------- 19:53:23 INFO - PID 32090 | 19:53:25 INFO - TEST-INFO | 32090: exit 0 19:53:25 INFO - TEST-OK | kraken | took 93007ms 19:53:25 INFO - SUITE-END | took 1240s 19:53:25 INFO - Completed test suite (00:20:40) 19:53:25 INFO - javascript benchmark 19:53:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6620.391313711714, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2690.9999999999995, 2698.8920443182274, 2722.4963381774373, 2736.6168736376912, 2744.4648293582745, 5070.391553013635, 5150.072986862363, 5173.073007959717, 5210.947890521104, 5220.112580861253, 5128.871778205546, 5138.768755406007, 5176.352955880515, 5208.270842082112, 5252.3171987641645, 4514.322851572258, 4565.0, 4584.037352156051, 4599.563041511068, 4623.214053610895, 4601.0, 4628.190066738307, 4631.328457373679, 4633.2818413146015, 4678.017616300581, 4519.050999290153, 4558.179527685015, 4580.725156490621, 4585.174668559658, 4639.76801159944, 4588.7476188809605, 4607.262837945946, 4625.722456652578, 4641.698289611165, 4670.995735916794, 4569.908601827945, 4571.0, 4574.702644328141, 4580.5190455002075, 4609.953900460986, 5057.8735531612, 5102.489751024905, 5177.611679124043, 5178.844634660966, 5181.740912954375, 5575.107982722786, 5609.747561359749, 5653.0, 5662.292213473316, 5668.546516278688, 5589.0, 5609.607327487078, 5612.663240205601, 5621.831345059655, 5650.576206784508, 5257.132573125392, 5259.395169555473, 5262.447443018428, 5262.552683021986, 5308.177232528887, 5619.241402410704, 5691.004074286983, 5694.202811606296, 5699.259096317535, 5784.537237021028, 5502.752376143083, 5504.752286147133, 5538.224648549206, 5557.083081291542, 5568.638038527482, 5577.972110139423, 5579.7489112990015, 5593.636413633101, 5606.887862242732, 5614.522765564891, 5420.864478387993, 5438.646487978348, 5497.505224529811, 5553.305836770403, 5619.129034999582, 5496.285482887199, 5523.861903452445, 5562.332520097533, 5569.526590239794, 5576.972115139399, 4645.39609850724, 4661.440627124767, 4673.976630116827, 4675.7895894684825, 4696.037312351028, 3999.0402303446963, 3999.140184860269, 4029.6776257899296, 4049.8785036448953, 4056.918861622751, 4551.886202844956, 4599.632029437637, 4609.285560738091, 4642.326862604971, 4673.929891051637, 5562.721863906789, 5566.2207290979295, 5574.358948720868, 5586.972065139729, 5622.325320961429, 4608.124456353349, 4621.745803980813, 4630.699004564693, 4642.280446530793, 4654.813807447732, 4830.806767729322, 4897.045076210176, 4899.191633380524, 4909.784698767541, 4910.386201724713, 5185.844424667266, 5200.791968321225, 5222.033923724123, 5236.581073514186, 5260.44765299638, 5404.432534583812, 5480.890382192413, 5496.340439147328, 5574.358948720949, 5592.245046918777, 5132.46109158533, 5159.045576568196, 5162.6386152968935, 5195.246689230116, 5209.114450543492, 5415.48552887475, 5466.289382380265, 5484.067708489646, 5484.862878428071, 5527.861803454945, 5527.391986881359, 5568.331800184003, 5595.104783234826, 5595.972020139873, 5604.355499117653, 5351.331083614548, 5359.303290572357, 5425.864353391039, 5426.891462170814, 5439.619226654097, 5357.571394288526, 5367.409584945731, 5371.973140134431, 5378.784848606168, 5423.864403389789, 5246.055709972242, 5294.814681486129, 5302.681839089667, 5306.204069389622, 5325.573954083741, 5324.254604355471, 5391.406945236099, 5421.5391691706645, 5442.156465747657, 5540.667559946416, 5329.360476742816, 5330.706811125426, 5337.119375303031, 5338.97330513345, 5354.598405119554], "value": 5042.118426660508, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.3646154384106, 722.6820199112391, 745.4222977192677, 1057.6086847866286, 1075.7848430313938, 31178.844105779466, 32133.83933080334, 32197.0, 32224.355512889757, 32240.516392254136, 33063.0, 33421.0, 33435.83282083592, 33476.83261583689, 33479.66520334796, 6636.73453061877, 6815.965920170393, 6857.348551887575, 6977.755778547752, 6983.336583024605, 6800.319968003209, 6880.724771009153, 6901.654917254143, 6908.75819346323, 6918.584884906922, 6868.141482314711, 6910.205326387454, 6917.169939607229, 6931.72273109075, 6935.791926242196, 6811.978203269499, 6841.521093523405, 6849.726010959555, 6868.7252509899545, 6875.656217189121, 6693.431058360045, 6723.260441351447, 6781.932180678179, 6788.08360871281, 6800.421964133055, 30317.393652127055, 30381.240468988453, 30412.239694007607, 30470.085897423112, 30580.235494112825, 2876.4103358811603, 2888.5522743974716, 2891.6385451818524, 2937.0601407549593, 2960.718731720483, 24068.27795166148, 24100.15649452261, 24114.0, 24128.276151715476, 24198.516029679486, 2977.8213307201636, 2979.865906034234, 2996.730294273526, 3044.9086527404215, 3061.081675497342, 121658.0, 122396.0, 129550.35224823815, 142477.2876135623, 142711.0, 36253.45619815705, 36431.4535281971, 36604.816975915484, 36719.63280367215, 36851.447228291596, 37976.43035354472, 38028.295755636325, 38093.80953095217, 38182.23635527274, 38280.617193827704, 11764.58823941158, 11933.224340417844, 11936.224145430519, 11976.760464790656, 11985.28088314704, 9429.2928030398, 9512.619495220251, 9526.380785248937, 9583.233341332676, 9587.760305992266, 11846.881531184577, 11876.465559049864, 11921.403929803475, 11989.580364687194, 12113.33376664292, 5220.738963051908, 5289.629725919226, 5292.894142117136, 5368.436314187033, 5375.543078838343, 825.3520986025941, 856.0626114404841, 877.4252864373846, 888.5512816027865, 895.3329769321766, 19690.31083912056, 20642.348612111295, 20656.0, 20732.378028659165, 21068.15727370888, 917.6237742525666, 925.5200446321744, 928.7306681062416, 941.8838676168625, 943.2595412601212, 10906.672799816019, 10945.124390048777, 10974.231803773659, 11028.613998510174, 11252.66242012741, 156595.0, 160766.0, 161801.0, 162157.0, 171292.0, 41461.0, 41850.58149418528, 42190.57809421867, 42666.78666606647, 43092.78453607774, 1122.5958654884234, 1132.2866594045863, 1136.0343707848428, 1143.1826244235244, 1160.1704781081567, 22878.885605571864, 24256.272311830675, 24669.753302466746, 24742.25773226806, 24756.876215618806, 27508.0, 27801.304967375978, 28281.292967675974, 28287.71712282933, 28314.43371132607, 145234.0, 145499.0, 146087.0, 146166.0, 146573.26713366364, 28224.576631350137, 28475.28811779722, 28632.856835715687, 28793.56809647899, 28860.855695721388, 33582.160445989044, 33596.0, 33641.327173456884, 33833.83083084569, 33931.15172120717, 24777.87611061933, 25523.0, 25722.485550289264, 26644.60033099544, 26798.464030719668, 25051.87474062618, 26334.73665263323, 26471.73528264693, 26747.0, 27080.32299192536, 28502.144935651962, 28623.713762862106, 31463.528047078853, 32895.0, 33065.66934330626, 34780.304393912484, 34853.82573087118, 35162.82418587993, 35254.471182932786, 35323.46765323447, 22466.663000055338, 25507.23478295654, 27167.45665086727, 27179.456410872066, 27220.183394498195], "value": 14207.689093847759, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.69346949583576, 408.8822726708845, 412.66780241905275, 422.66609378590914, 432.36442429628454, 12840.101192916476, 13302.46790128396, 17252.223649935753, 17822.554436139086, 17837.108144592767, 17900.55248618785, 18677.346292879753, 18690.90654546729, 18714.71927921079, 18771.53071173221, 5365.678059316434, 5526.171074338841, 5537.141743029817, 5550.084236101038, 5552.500274975251, 5401.864953376158, 5477.370102438231, 5494.230807686907, 5498.340199176105, 5509.228707980886, 5387.272718183034, 5431.755570999295, 5446.2375267462585, 5467.972660136694, 5469.206964990074, 5100.209467532539, 5324.440933701983, 5337.653052551611, 5348.572114230852, 5378.435264297232, 4847.781849816767, 4850.296706977469, 4875.439324477659, 4880.633952453581, 4882.584980276681, 22069.0, 22431.775682243133, 22451.32646020622, 22456.550868982693, 22461.0, 1409.8026276321323, 1435.1891181482429, 1439.3091316168193, 1439.4098419647894, 1439.8488158743392, 14659.26703664823, 14730.70538589233, 14930.701385972328, 14955.102693838297, 15397.461088861948, 2013.144413624204, 2028.8985550722552, 2039.1231770338748, 2045.110376986001, 2056.0644906567477, 101025.4948725259, 104592.99999999924, 105411.0, 105939.0, 106054.46972765164, 10473.423961682181, 11012.50443730034, 11078.667639970814, 11119.499622517005, 11368.431578421212, 15139.0, 15176.544703658908, 15213.0, 15224.162671053198, 15260.0, 7269.236730143364, 7277.38142257914, 7361.2638736125955, 7385.778426647209, 7420.666070026754, 6763.188417389846, 6844.28135045813, 6869.0, 6869.003994420881, 6892.586444813327, 6729.663516824139, 6749.300279887986, 6810.693518791666, 6813.4889883257965, 6834.555753875982, 1892.1107079672531, 1894.6589613869635, 1907.3801014670287, 1919.6832522633608, 2009.708592254115, 815.649270813544, 826.1696994520588, 849.4860609331389, 884.062893333069, 885.4288983605538, 17144.828551714323, 17629.294828206985, 20000.19999200045, 21521.67717484239, 21843.344699659036, 828.1180542721982, 850.37497439382, 864.8486514859875, 882.1002577371046, 882.955852207387, 9067.183953444222, 9342.439453632804, 9422.90577094234, 9603.855942160873, 9758.853617195748, 375616.0, 376236.0, 380161.0, 380823.0, 382490.0, 90530.54734726416, 93669.0, 93721.06278937124, 94320.0, 94642.526787367, 919.3977944446265, 1038.3458421194598, 1040.953157107932, 1085.685151306128, 1087.4345340422935, 14699.485518006819, 17442.0, 17710.734338985185, 18075.276988920297, 18395.632087358445, 42998.14003719846, 43601.78199108984, 44814.0, 45046.324305136106, 45085.77457112693, 54865.0, 55004.0, 55397.72301138468, 55461.44538554563, 55558.44441555694, 8666.78333041679, 8693.870001849587, 8742.650293988168, 8793.516356600192, 8812.295016398544, 10577.947110264708, 11164.497597607964, 13540.526081587492, 13611.0, 13871.653208669864, 12019.91820736138, 12095.274283543016, 12126.029917606747, 12181.451834667638, 12645.178063425848, 11443.427828608703, 11886.643400697993, 12030.63908082759, 12347.62957111288, 12722.936385318384, 13021.739565208452, 13025.153365031243, 13287.66780830487, 13290.13614115118, 13313.0, 9406.05939406054, 9484.525773711424, 9491.671166036622, 9495.815962328841, 9655.806883862142, 12973.351332433529, 13073.084884058024, 13279.734405312032, 13291.268980206181, 13373.799393008918], "value": 9094.557209247396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1237.6843904804275, 1282.56392826439, 1290.9870901290985, 1291.2704322058037, 1306.97386052279, 9458.432494050361, 9746.70759877203, 9854.605815767369, 9895.356801807895, 9990.25073119517, 9540.713778586654, 9768.267379946497, 9784.510774461283, 9792.951035244832, 9821.459819709913, 2139.668351405535, 2171.880546569938, 2181.040342249405, 2189.2447105748493, 2197.7802219778055, 1930.4594713480249, 1951.980480195194, 1954.902254887257, 1955.8630895837298, 1965.3219639224444, 2047.3039166683325, 2064.8348132149467, 2070.81362677359, 2071.968920466194, 2072.274703853654, 2026.5744193719336, 2031.0860112949158, 2038.5820906714162, 2045.98977005114, 2046.2326627514683, 1746.6070134219826, 1810.7374430707605, 1895.5924476237537, 1934.9164467898022, 1959.6080783843147, 9868.851967220497, 9947.502624868728, 9952.154066904322, 9952.4028558286, 9956.0, 4925.433575138869, 5135.024345374404, 5137.306463627438, 5139.717315547643, 5140.742962851842, 2946.2634341414646, 3046.7714921380984, 3109.362580670957, 3114.205877501223, 3118.23603217211, 946.3233787841657, 958.7746879483316, 975.9609615615437, 978.0659470205936, 982.6904525074578, 14065.226412547307, 14219.36012879423, 14230.28848557568, 14231.359588818425, 14285.78571321431, 4225.746455212636, 4226.492820861455, 4285.871423857289, 4359.956400436018, 4401.097774956126, 10953.34279943206, 10974.506147223394, 10978.780424391467, 11030.889691103146, 11174.944125279322, 5196.558292545101, 5323.973380133075, 5336.332958380202, 5355.758990845421, 5360.303160589098, 4761.166795810719, 4899.510048995072, 4930.580900623416, 4931.605471562267, 4936.531029552187, 3813.542374915028, 3873.709471789627, 3904.492415985904, 3960.207958408272, 3979.2041591681777, 1125.5610311978335, 1126.2904370246856, 1136.534021051365, 1140.8345789860423, 1153.5039932828963, 673.8382788130912, 710.591409939287, 712.0600806934797, 729.2233771033832, 730.1493759769809, 5452.754626041838, 5549.750261238254, 5583.748731307101, 5587.106063029895, 5653.23681303027, 512.3365242011604, 525.8238490105781, 527.8442859356499, 532.2362409941669, 534.7005676820993, 3484.9651503484642, 3836.36699944506, 3867.8259478323544, 3881.825317860703, 3920.9215815684097, 11816.46825892837, 12166.39168041612, 12177.391130443442, 12178.695532611755, 12233.327167005722, 12021.278723276631, 12050.216735912138, 12138.211016283913, 12158.088143389281, 12167.513299467922, 6709.865802683919, 6716.731330746716, 6781.321867813278, 7024.754133605299, 7135.6432178391915, 5520.0, 5743.827685169452, 5815.912761308499, 5859.9121013183985, 6071.817845464643, 11401.771964560496, 11591.0, 11594.6521604352, 11715.648530544097, 11737.0, 12068.39658017078, 12256.938715306367, 12298.754024919273, 12361.752764944831, 12441.377931103227, 7723.266289702469, 7839.843203135792, 7844.80387990282, 7858.0570331560575, 7861.2531809478005, 8964.103589640983, 9072.682456114004, 9081.500517471603, 9092.363534552518, 9133.725988220363, 7538.623068846426, 7571.924280757122, 7632.923670763222, 7717.6141192939, 7850.293473587404, 7606.04924384452, 7691.0, 7696.037995250594, 7784.377249820114, 7818.374530037697, 6872.41584465306, 7001.124859392576, 7020.964895175695, 7022.578645281095, 7082.610456424946, 4810.350602668595, 4915.43472500667, 4961.479044700399, 4972.588294677006, 5039.966806804523, 4907.705537667752, 4957.405111386656, 4964.925526117039, 4987.900241995212, 5032.295478632921], "value": 4455.048615197907, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.7478827849808, 356.0369201310455, 356.4510653593466, 366.1614901874707, 370.1523511159446, 5351.545118664909, 5470.316210473686, 5476.424975377583, 5494.917576236359, 5497.7904860930585, 5222.3472065991755, 5302.125149350362, 5302.284191634129, 5327.893442131165, 5336.493033161843, 4067.7966101694947, 4080.3879418087226, 4091.304478238692, 4098.098418347959, 4111.259973204822, 4120.526139493952, 4121.814518346681, 4126.484189476316, 4128.62842344189, 4129.318662420697, 4082.836686532535, 4086.3053280942313, 4096.5698601646845, 4099.856505022325, 4107.829268658433, 4087.7751723655188, 4092.1815636872598, 4095.2219078375015, 4104.835806567734, 4114.753114813121, 3602.009447401985, 3604.6662734788033, 3613.2231570212266, 3618.149734812317, 3630.473581330719, 5266.760942020668, 5268.525832675039, 5292.179712144585, 5310.522053015208, 5327.600429967768, 4826.444958829745, 4827.903441931142, 4851.248056551205, 4856.077345304416, 4861.78121984508, 5686.800961966353, 5691.9146212806845, 5692.288463942007, 5705.74324155414, 5716.371199168088, 4054.2702313583545, 4070.1859628074503, 4074.857379991716, 4075.246079475277, 4079.3676980068135, 5748.712564371806, 5965.135055416984, 6031.849203769897, 6113.205283313186, 6132.264128304588, 4029.2948733972025, 4037.475128233311, 4072.592740725963, 4075.1034772350035, 4083.0608959938786, 4109.301418758818, 4118.361653943583, 4128.6284234419045, 4130.215259100822, 4136.110736191733, 4624.213883639722, 4726.007538416971, 4731.692439991459, 4732.763361831895, 4732.787024583902, 5678.21136342051, 5726.594830171338, 5731.140328950691, 5738.340090889517, 5741.770329186869, 1423.1318895473753, 1445.5591044731457, 1447.7900704398014, 1448.2903377345026, 1450.7968884356198, 956.2159029595804, 977.8973207813077, 987.7728122531857, 988.0662773678948, 991.9256055795844, 4876.658633895664, 4887.315775791392, 4891.73095479752, 4898.951010489921, 4901.975490122527, 5876.353601103875, 5878.2064421302575, 5887.882242355129, 5917.763289468459, 5939.346671866091, 4855.1018061658, 4860.878478038077, 4864.562189402971, 4870.95129048705, 4871.902561948812, 3101.8138911665374, 3142.795718278305, 3147.213196700825, 3147.874085036619, 3148.889788857379, 5524.889502209933, 5526.253955716007, 5531.529819965268, 5534.391216966131, 5541.5289700375115, 6072.605280656743, 6073.384227986674, 6109.5112391008615, 6120.234970628671, 6150.477209437248, 5471.37079235893, 5476.370217424967, 5481.588880834033, 5487.6158668892795, 5499.945000550103, 5906.940930590639, 5937.3468918418075, 5941.435563621449, 5952.345242023287, 5956.255468066492, 5788.363280039108, 5804.796832110856, 5864.824055278348, 5870.236869206976, 5875.6474611523445, 5227.294315267391, 5325.760340784596, 5380.488853558905, 5488.204210389551, 5516.558675306046, 4107.630313271819, 4117.75293482392, 4119.46446961905, 4128.504579450485, 4163.6669066474005, 5889.49939255151, 5903.144044113494, 5914.378990205966, 5927.762889484545, 5951.345352011189, 5559.193916881949, 5671.6597004179885, 5710.743016564182, 5734.483896449173, 5754.6547207167705, 5692.036247494608, 5719.342275638355, 5729.512991395778, 5735.13972904051, 5783.624064435799, 5638.520725738194, 5639.859003524781, 5641.069223578063, 5647.491725744702, 5676.091825307931, 5754.827355179351, 5756.913646295393, 5782.971085144715, 5786.479216870502, 5788.247527821356, 5597.80407685729, 5597.888042239214, 5617.859553511195, 5633.661980281032, 5635.239242702182], "value": 4280.113393717387, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.5054210426389, 679.687343821842, 680.8910574308112, 697.5082566790413, 699.0283505926761, 12920.612381628554, 13369.39837707303, 13445.731085378298, 15399.92300038501, 16638.0, 15316.234188290597, 15410.229488525585, 15444.5366639001, 15456.149911754848, 15500.06999580026, 807.8020884883197, 816.7958010497375, 817.5380909785952, 817.5380909785981, 818.8403261364036, 800.2997377294867, 823.0617096509983, 823.407146854267, 828.8052307707684, 852.5651917522047, 861.8448679237734, 862.9352798540135, 866.1035827918106, 866.4931015356025, 868.2489646455833, 859.4198915731856, 861.8190180062195, 863.0894406401244, 863.4171933944593, 865.2515574028483, 633.2812258087105, 633.5280216238931, 634.5241069198102, 635.2059925093633, 635.942765151134, 14091.577252682437, 14323.427062917472, 14328.355224014944, 14388.424463021467, 14388.712225755426, 13940.302984850818, 14871.0, 15012.699746005019, 15044.924775376054, 15073.0, 11532.769344613145, 12128.939355303255, 12153.508530751174, 12263.816042759367, 12340.629781106582, 2966.1991262359256, 2975.062855200605, 2977.077106097117, 2980.910572682823, 2991.820490770561, 73769.0, 75116.0, 76794.61602692006, 76832.0, 79027.20972790313, 11443.656690299304, 11692.415379231004, 11774.05807535395, 11785.646430607096, 11789.469473873696, 19304.32434864773, 20386.28647997313, 20462.079206435745, 20518.89740551288, 20566.177352906016, 5788.710564471759, 5929.6145750526075, 5937.52499800015, 5940.584159108907, 5941.168236446901, 2753.2979090331837, 2801.761850242752, 2805.9158225253277, 2836.1633318170775, 2891.5951766752673, 3331.900042998714, 3410.686885549032, 3416.906589891261, 3423.3153369326233, 3426.5716785401823, 679.0154276299386, 686.1594546680277, 686.5297271369028, 689.2349492063805, 690.0305071374727, 492.2493197873272, 505.1463027483541, 505.2724077328635, 507.6471852062781, 524.1875093604897, 10333.121684656739, 10386.0, 10566.577336906437, 10607.416592087355, 10897.346159230472, 506.2153661824158, 510.54306395775575, 511.759473047667, 516.1741214057553, 518.2511271213136, 4139.4683966931825, 4345.456817897762, 4378.211921854033, 4481.238189507726, 4498.6626003049905, 85897.0, 86754.0, 86818.0, 87403.0, 87556.0, 75607.62196188983, 75810.0, 75842.62078689571, 76898.0, 77069.0, 61221.38778612246, 62794.0, 63510.0, 63730.0, 66436.66781666157, 8490.57547122629, 8554.700585479479, 8602.655893764178, 8617.526036067826, 8636.481811091355, 28446.0, 29569.556456652736, 29648.110556683336, 30145.849270753504, 30721.846390767903, 35975.92072237837, 36472.27055458823, 36656.81671591625, 37132.62867371292, 37576.62423375731, 11217.495212715285, 13029.15310504814, 13832.170069795844, 13897.305134743425, 13970.650733731738, 14805.259737013323, 16087.839121608635, 16100.67798643997, 16272.430464934145, 16480.917595412426, 13603.659908502366, 13675.794863076862, 13746.725065498835, 13863.79204311916, 14008.719825603635, 13307.135036222615, 13538.86461135376, 13670.11144275619, 13692.794608081085, 14615.269236537917, 14213.431462741375, 14239.35922883452, 14369.56891293263, 14392.0, 14607.0, 9841.1635011022, 9890.901090988998, 10181.694549163536, 10399.948000260252, 10589.4705264738, 10753.279475283916, 11426.143039271921, 11537.0, 11745.29528228309, 11747.47136378848], "value": 6777.075297896309, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 109.0, 110.0, 110.0, 111.0, 111.0, 109.0, 109.0, 113.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 123.0, 168.0, 124.0, 128.0, 125.0, 121.0, 154.0, 122.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 167.0, 162.0, 166.0, 169.0, 166.0, 167.0, 164.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 74.0, 110.0, 74.0, 74.0, 75.0, 73.0, 95.0, 76.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 105.0, 83.0, 82.0, 84.0, 97.0, 82.0, 82.0, 116.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 117.0, 115.0, 114.0, 117.0, 118.0, 114.0, 114.0, 115.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 150.0, 153.0, 150.0, 150.0, 152.0, 152.0, 154.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 94.0, 94.0, 96.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 55.0, 54.0, 58.0, 57.0, 60.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 56.0, 56.0, 56.0, 56.0, 62.0, 71.0, 56.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 104.0, 89.0, 87.0, 95.0, 87.0, 87.0, 90.0, 124.0, 86.0], "value": 93.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 135.0, 149.0, 131.0, 136.0, 136.0, 134.0, 138.0, 146.0, 156.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 196.0, 193.0, 200.0, 198.0, 203.0, 208.0, 194.0, 196.0, 195.0], "value": 197.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 75.0, 73.0, 77.0, 73.0, 71.0, 70.0, 73.0, 73.0], "value": 73.0, "unit": "score"}]}]} 19:53:25 INFO - Return code: 0 19:53:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:53:25 INFO - # TBPL SUCCESS # 19:53:25 INFO - Running post-action listener: _resource_record_post_action 19:53:25 INFO - [mozharness: 2017-06-02 02:53:25.282955Z] Finished run-tests step (success) 19:53:25 INFO - Running post-run listener: _resource_record_post_run 19:53:25 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 4096; Write bytes: 410775552; Read time: 4; Write time: 317096 19:53:25 INFO - TinderboxPrint: CPU usage
12.7% 19:53:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 19:53:25 INFO - TinderboxPrint: I/O write bytes / time
410,775,552 / 317,096 19:53:25 INFO - TinderboxPrint: CPU idle
8,759.7 (87.3%) 19:53:25 INFO - TinderboxPrint: CPU user
1,220.3 (12.2%) 19:53:25 INFO - TinderboxPrint: Swap in / out
0 / 0 19:53:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99409920; Read time: 0; Write time: 109640 19:53:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:53:25 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 0; Write bytes: 311365632; Read time: 0; Write time: 207456 19:53:25 INFO - Running post-run listener: _upload_blobber_files 19:53:25 INFO - Blob upload gear active. 19:53:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:53:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:53:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:53:26 INFO - (blobuploader) - INFO - Open directory for files ... 19:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:29 INFO - (blobuploader) - INFO - Done attempting. 19:53:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:53:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:53:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:30 INFO - (blobuploader) - INFO - Done attempting. 19:53:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:53:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:53:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:31 INFO - (blobuploader) - INFO - Done attempting. 19:53:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:53:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:53:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:32 INFO - (blobuploader) - INFO - Done attempting. 19:53:32 INFO - (blobuploader) - INFO - Iteration through files over. 19:53:32 INFO - Return code: 0 19:53:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:53:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:53:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5494dbf423a403a934afb8d1a8518fb6742267a07667c65a46a8f9ecbd7167ca44983c9ae632678912c62c11a5c920a2d7b1cd9232419acc3426974b23da6a3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6aaf3806da1cfd26a457ed65703c38ccbda458026243f15b27a143aaf453c86ba5d644dc744124276704a45cafccabdf38e4642946fb398a0af1723da33ed96e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdd4c660b12e8f546685f72b8cc2201d48d35ad425566ce4317849e1a604c517e207734635325c12eadcfb204290697b438b08841867ed14daa353834f8409b4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9a9a6cc5ed51af3b68cd3be1bf3ea0104ff3aef8c69b3a0e07507bcbb83a08ab63943917a3aff559978213fadd140edce0d4f7ce2d484f48f08c008d8759067"} 19:53:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:53:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:53:32 INFO - Contents: 19:53:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5494dbf423a403a934afb8d1a8518fb6742267a07667c65a46a8f9ecbd7167ca44983c9ae632678912c62c11a5c920a2d7b1cd9232419acc3426974b23da6a3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6aaf3806da1cfd26a457ed65703c38ccbda458026243f15b27a143aaf453c86ba5d644dc744124276704a45cafccabdf38e4642946fb398a0af1723da33ed96e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdd4c660b12e8f546685f72b8cc2201d48d35ad425566ce4317849e1a604c517e207734635325c12eadcfb204290697b438b08841867ed14daa353834f8409b4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9a9a6cc5ed51af3b68cd3be1bf3ea0104ff3aef8c69b3a0e07507bcbb83a08ab63943917a3aff559978213fadd140edce0d4f7ce2d484f48f08c008d8759067"} 19:53:32 INFO - Running post-run listener: copy_logs_to_upload_dir 19:53:32 INFO - Copying logs to upload dir... 19:53:32 INFO - mkdir: /builds/slave/test/build/upload/logs 19:53:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1314.499973 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-06-01 19:53:32.195208) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 19:53:32.199067) ========= 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=3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5494dbf423a403a934afb8d1a8518fb6742267a07667c65a46a8f9ecbd7167ca44983c9ae632678912c62c11a5c920a2d7b1cd9232419acc3426974b23da6a3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6aaf3806da1cfd26a457ed65703c38ccbda458026243f15b27a143aaf453c86ba5d644dc744124276704a45cafccabdf38e4642946fb398a0af1723da33ed96e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdd4c660b12e8f546685f72b8cc2201d48d35ad425566ce4317849e1a604c517e207734635325c12eadcfb204290697b438b08841867ed14daa353834f8409b4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9a9a6cc5ed51af3b68cd3be1bf3ea0104ff3aef8c69b3a0e07507bcbb83a08ab63943917a3aff559978213fadd140edce0d4f7ce2d484f48f08c008d8759067"} build_url:https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5494dbf423a403a934afb8d1a8518fb6742267a07667c65a46a8f9ecbd7167ca44983c9ae632678912c62c11a5c920a2d7b1cd9232419acc3426974b23da6a3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6aaf3806da1cfd26a457ed65703c38ccbda458026243f15b27a143aaf453c86ba5d644dc744124276704a45cafccabdf38e4642946fb398a0af1723da33ed96e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdd4c660b12e8f546685f72b8cc2201d48d35ad425566ce4317849e1a604c517e207734635325c12eadcfb204290697b438b08841867ed14daa353834f8409b4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9a9a6cc5ed51af3b68cd3be1bf3ea0104ff3aef8c69b3a0e07507bcbb83a08ab63943917a3aff559978213fadd140edce0d4f7ce2d484f48f08c008d8759067"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 19:53:32.229950) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:53:32.230501) ========= 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=3836458cccd887f2d2de3cf1000001de-1496368841.199132-1002017268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:53:32.313990) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 19:53:32.314564) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 19:53:32.315120) ========= ========= Total master_lag: 0.19 =========