builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1493827085.44 results: success (0) revision: d7e40bb852ea047a0e5f530bcdc04d29a1765001 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 08:58:05.439888) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 08:58:05.440312) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 08:58:05.440582) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 08:58:05.456118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 08:58:05.456382) ========= 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=7de08804244eb36560b44971000001c3-1493827084.108547-1531611621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-03 08:58:05-- 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% 40.9M=0s 2017-05-03 08:58:05 (40.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.191837 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 08:58:05.665903) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 08:58:05.666246) ========= 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=7de08804244eb36560b44971000001c3-1493827084.108547-1531611621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014073 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 08:58:05.715685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 08:58:05.715996) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d7e40bb852ea047a0e5f530bcdc04d29a1765001 --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 d7e40bb852ea047a0e5f530bcdc04d29a1765001 --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=7de08804244eb36560b44971000001c3-1493827084.108547-1531611621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-03 08:58:05,990 truncating revision to first 12 chars 2017-05-03 08:58:05,990 Setting DEBUG logging. 2017-05-03 08:58:05,990 attempt 1/10 2017-05-03 08:58:05,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d7e40bb852ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 08:58:07,159 unpacking tar archive at: mozilla-central-d7e40bb852ea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.544612 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 08:58:07.277465) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 08:58:07.277774) ========= script_repo_revision: d7e40bb852ea047a0e5f530bcdc04d29a1765001 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 08:58:07.278172) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 08:58:07.278432) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 08:58:07.289393) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-03 08:58:07.289652) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1493827084.108547-1531611621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:58:07 INFO - MultiFileLogger online at 20170503 08:58:07 in /builds/slave/test 08:58:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:58:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:58:07 INFO - {'append_to_log': False, 08:58:07 INFO - 'base_work_dir': '/builds/slave/test', 08:58:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:58:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:58:07 INFO - 'branch': 'Firefox-Non-PGO', 08:58:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:58:07 INFO - 'config_files': ('talos/linux_config.py',), 08:58:07 INFO - 'default_actions': ('clobber', 08:58:07 INFO - 'read-buildbot-config', 08:58:07 INFO - 'download-and-extract', 08:58:07 INFO - 'populate-webroot', 08:58:07 INFO - 'create-virtualenv', 08:58:07 INFO - 'install', 08:58:07 INFO - 'run-tests'), 08:58:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:58:07 INFO - 'download_minidump_stackwalk': True, 08:58:07 INFO - 'download_symbols': 'ondemand', 08:58:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:58:07 INFO - 'tooltool.py': '/tools/tooltool.py', 08:58:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:58:07 INFO - '/tools/misc-python/virtualenv.py')}, 08:58:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:58:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:58:07 INFO - 'gecko_profile': False, 08:58:07 INFO - 'gecko_profile_interval': 0, 08:58:07 INFO - 'installer_path': 'installer.exe', 08:58:07 INFO - 'log_level': 'info', 08:58:07 INFO - 'log_name': 'talos', 08:58:07 INFO - 'log_to_console': True, 08:58:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:58:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:58:07 INFO - 'opt_config_files': (), 08:58:07 INFO - 'pip_index': False, 08:58:07 INFO - 'suite': 'dromaeojs-e10s', 08:58:07 INFO - 'system_bits': '32', 08:58:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:58:07 INFO - 'title': 'talos-linux64-ix-003', 08:58:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:58:07 INFO - 'use_talos_json': True, 08:58:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:58:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:58:07 INFO - 'work_dir': 'build'} 08:58:07 INFO - [mozharness: 2017-05-03 15:58:07.756606Z] Running clobber step. 08:58:07 INFO - Running pre-action listener: _resource_record_pre_action 08:58:07 INFO - Running main action method: clobber 08:58:07 INFO - rmtree: /builds/slave/test/build 08:58:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:58:08 INFO - Running post-action listener: _resource_record_post_action 08:58:08 INFO - [mozharness: 2017-05-03 15:58:08.657480Z] Finished clobber step (success) 08:58:08 INFO - [mozharness: 2017-05-03 15:58:08.657578Z] Running read-buildbot-config step. 08:58:08 INFO - Running pre-action listener: _resource_record_pre_action 08:58:08 INFO - Running main action method: read_buildbot_config 08:58:08 INFO - Using buildbot properties: 08:58:08 INFO - { 08:58:08 INFO - "project": "", 08:58:08 INFO - "product": "firefox", 08:58:08 INFO - "who": "ffxbld@noreply.mozilla.org", 08:58:08 INFO - "installer_path": "public/build/target.tar.bz2", 08:58:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:58:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:58:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:58:08 INFO - "stage_platform": "linux64", 08:58:08 INFO - "basedir": "/builds/slave/test", 08:58:08 INFO - "buildnumber": 579, 08:58:08 INFO - "platform": "ubuntu64_hw", 08:58:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:58:08 INFO - "slavebuilddir": "test", 08:58:08 INFO - "taskId": "PqRm4iKrS-GrmU4ydU6DFQ", 08:58:08 INFO - "branch": "mozilla-central", 08:58:08 INFO - "script_repo_revision": "production", 08:58:08 INFO - "revision": "d7e40bb852ea047a0e5f530bcdc04d29a1765001", 08:58:08 INFO - "slavename": "talos-linux64-ix-003", 08:58:08 INFO - "repo_path": "mozilla-central" 08:58:08 INFO - } 08:58:08 INFO - Finding installer, test and symbols from parent task. 08:58:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PqRm4iKrS-GrmU4ydU6DFQ'}, attempt #1 08:58:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PqRm4iKrS-GrmU4ydU6DFQ'}, attempt #1 08:58:09 INFO - Task dependencies: Z_0mGBu9SDuVrWn0-OTd0A 08:58:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A'}, attempt #1 08:58:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.tar.bz2 08:58:10 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/test_packages.json 08:58:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.crashreporter-symbols.zip 08:58:10 INFO - Running post-action listener: _resource_record_post_action 08:58:10 INFO - [mozharness: 2017-05-03 15:58:10.028820Z] Finished read-buildbot-config step (success) 08:58:10 INFO - [mozharness: 2017-05-03 15:58:10.029036Z] Running download-and-extract step. 08:58:10 INFO - Running pre-action listener: _resource_record_pre_action 08:58:10 INFO - Running main action method: download_and_extract 08:58:10 INFO - mkdir: /builds/slave/test/build/tests 08:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:10 INFO - trying https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.test_packages.json 08:58:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:58:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:58:10 INFO - Downloaded 986 bytes. 08:58:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:58:10 INFO - Using the following test package requirements: 08:58:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:58:10 INFO - u'common': [u'target.common.tests.zip'], 08:58:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:58:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:58:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:58:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:58:10 INFO - u'mozbase': [u'target.common.tests.zip'], 08:58:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:58:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:58:10 INFO - u'web-platform': [u'target.common.tests.zip', 08:58:10 INFO - u'target.web-platform.tests.zip'], 08:58:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:58:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:58:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.common.tests.zip 08:58:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:58:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.common.tests.zip into memory 08:58:11 INFO - Content-Length response header: 58442937 08:58:11 INFO - Bytes received: 58442937 08:58:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:58:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.common.tests.zip 08:58:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:58:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.common.tests.zip into memory 08:58:22 INFO - Content-Length response header: 58442937 08:58:22 INFO - Bytes received: 58442937 08:58:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.talos.tests.zip 08:58:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:58:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.talos.tests.zip into memory 08:58:36 INFO - Content-Length response header: 14408811 08:58:36 INFO - Bytes received: 14408811 08:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:36 INFO - trying https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.tar.bz2 08:58:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:58:37 INFO - Downloaded 58509566 bytes. 08:58:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.tar.bz2 08:58:37 INFO - mkdir: /builds/slave/test/properties 08:58:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:58:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:58:37 INFO - Contents: 08:58:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.tar.bz2 08:58:37 INFO - Running post-action listener: _resource_record_post_action 08:58:37 INFO - Running post-action listener: set_extra_try_arguments 08:58:37 INFO - [mozharness: 2017-05-03 15:58:37.505344Z] Finished download-and-extract step (success) 08:58:37 INFO - [mozharness: 2017-05-03 15:58:37.505441Z] Running populate-webroot step. 08:58:37 INFO - Running pre-action listener: _resource_record_pre_action 08:58:37 INFO - Running main action method: populate_webroot 08:58:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:58:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:58:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:58:37 INFO - '--tppagecycles', 08:58:37 INFO - '7'], 08:58:37 INFO - 'tests': ['tsvgm']}}, 08:58:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:58:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:58:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:58:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:58:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:58:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:58:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:58:37 INFO - 'talos_options': ['--disable-e10s'], 08:58:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:58:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:58:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:58:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:58:37 INFO - 'talos_options': ['--disable-e10s'], 08:58:37 INFO - 'tests': ['damp', 'tps']}, 08:58:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:58:37 INFO - 'tests': ['damp', 'tps']}, 08:58:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:58:37 INFO - 'tests': ['dromaeo_dom']}, 08:58:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:58:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:58:37 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:58:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:58:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:58:37 INFO - 'tests': ['a11yr', 08:58:37 INFO - 'ts_paint', 08:58:37 INFO - 'tpaint', 08:58:37 INFO - 'sessionrestore', 08:58:37 INFO - 'sessionrestore_no_auto_restore', 08:58:37 INFO - 'tabpaint']}, 08:58:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:58:37 INFO - 'ts_paint', 08:58:37 INFO - 'tpaint', 08:58:37 INFO - 'sessionrestore', 08:58:37 INFO - 'sessionrestore_no_auto_restore', 08:58:37 INFO - 'tabpaint']}, 08:58:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:58:37 INFO - 'ts_paint', 08:58:37 INFO - 'tpaint', 08:58:37 INFO - 'sessionrestore', 08:58:37 INFO - 'sessionrestore_no_auto_restore', 08:58:37 INFO - 'tabpaint']}, 08:58:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:58:37 INFO - 'ts_paint', 08:58:37 INFO - 'tpaint', 08:58:37 INFO - 'sessionrestore', 08:58:37 INFO - 'sessionrestore_no_auto_restore', 08:58:37 INFO - 'tabpaint']}, 08:58:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:58:37 INFO - 'tests': ['a11yr', 08:58:37 INFO - 'ts_paint', 08:58:37 INFO - 'tpaint', 08:58:37 INFO - 'sessionrestore', 08:58:37 INFO - 'sessionrestore_no_auto_restore', 08:58:37 INFO - 'tabpaint']}, 08:58:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:58:37 INFO - 'tests': ['a11yr', 08:58:37 INFO - 'ts_paint', 08:58:37 INFO - 'tpaint', 08:58:37 INFO - 'sessionrestore', 08:58:37 INFO - 'sessionrestore_no_auto_restore', 08:58:37 INFO - 'tabpaint']}, 08:58:37 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:58:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:58:37 INFO - 'bloom_basic_ref']}, 08:58:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:58:37 INFO - 'tests': ['tsvgx', 08:58:37 INFO - 'tsvgr_opacity', 08:58:37 INFO - 'tart', 08:58:37 INFO - 'tscrollx', 08:58:37 INFO - 'cart', 08:58:37 INFO - 'tsvg_static']}, 08:58:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:58:37 INFO - 'tsvgr_opacity', 08:58:37 INFO - 'tart', 08:58:37 INFO - 'tscrollx', 08:58:37 INFO - 'cart', 08:58:37 INFO - 'tsvg_static']}, 08:58:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:58:37 INFO - 'talos_options': ['--disable-e10s'], 08:58:37 INFO - 'tests': ['tp5o']}, 08:58:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:58:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:58:37 INFO - 'talos_options': ['--disable-e10s', 08:58:37 INFO - '--xperf_path', 08:58:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:58:37 INFO - 'tests': ['tp5n']}, 08:58:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:58:37 INFO - 'talos_options': ['--xperf_path', 08:58:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:58:37 INFO - 'tests': ['tp5n']}}, 08:58:37 INFO - 'talos.zip': {'path': '', 08:58:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:58:37 INFO - Running post-action listener: _resource_record_post_action 08:58:37 INFO - [mozharness: 2017-05-03 15:58:37.518994Z] Finished populate-webroot step (success) 08:58:37 INFO - [mozharness: 2017-05-03 15:58:37.519084Z] Running create-virtualenv step. 08:58:37 INFO - Running pre-action listener: _resource_record_pre_action 08:58:37 INFO - Running main action method: create_virtualenv 08:58:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:58:37 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 08:58:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:58:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:58:37 INFO - Using real prefix '/usr' 08:58:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:58:39 INFO - Installing distribute.............................................................................................................................................................................................done. 08:58:41 INFO - Installing pip.................done. 08:58:41 INFO - Return code: 0 08:58:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:58:41 INFO - Reading from file tmpfile_stdout 08:58:41 INFO - Output received: 08:58:41 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) 08:58:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:41 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x282b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6290>, '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 0x2ac6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7040>, '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': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', '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 08:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:58:41 INFO - Using env: {'DISPLAY': ':0', 08:58:41 INFO - 'HOME': '/home/cltbld', 08:58:41 INFO - 'LANG': 'en_US.UTF-8', 08:58:41 INFO - 'LANGUAGE': 'en_US:en', 08:58:41 INFO - 'LOGNAME': 'cltbld', 08:58:41 INFO - 'MAIL': '/var/mail/cltbld', 08:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:41 INFO - 'MOZ_NO_REMOTE': '1', 08:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:41 INFO - 'NO_EM_RESTART': '1', 08:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:41 INFO - 'PWD': '/builds/slave/test', 08:58:41 INFO - 'SHELL': '/bin/bash', 08:58:41 INFO - 'SHLVL': '1', 08:58:41 INFO - 'TERM': 'linux', 08:58:41 INFO - 'TMOUT': '86400', 08:58:41 INFO - 'USER': 'cltbld', 08:58:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', 08:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:41 INFO - '_': '/tools/buildbot/bin/python'} 08:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:41 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 08:58:41 INFO - Cleaning up... 08:58:41 INFO - Return code: 0 08:58:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:41 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x282b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6290>, '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 0x2ac6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7040>, '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': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', '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 08:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:58:41 INFO - Using env: {'DISPLAY': ':0', 08:58:41 INFO - 'HOME': '/home/cltbld', 08:58:41 INFO - 'LANG': 'en_US.UTF-8', 08:58:41 INFO - 'LANGUAGE': 'en_US:en', 08:58:41 INFO - 'LOGNAME': 'cltbld', 08:58:41 INFO - 'MAIL': '/var/mail/cltbld', 08:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:41 INFO - 'MOZ_NO_REMOTE': '1', 08:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:41 INFO - 'NO_EM_RESTART': '1', 08:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:41 INFO - 'PWD': '/builds/slave/test', 08:58:41 INFO - 'SHELL': '/bin/bash', 08:58:41 INFO - 'SHLVL': '1', 08:58:41 INFO - 'TERM': 'linux', 08:58:41 INFO - 'TMOUT': '86400', 08:58:41 INFO - 'USER': 'cltbld', 08:58:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', 08:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:41 INFO - '_': '/tools/buildbot/bin/python'} 08:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:42 INFO - Downloading/unpacking psutil>=3.1.1 08:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:58:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:58:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:58:43 INFO - Installing collected packages: psutil 08:58:43 INFO - Running setup.py install for psutil 08:58:43 INFO - building 'psutil._psutil_linux' extension 08:58:43 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 08:58:44 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 08:58:44 INFO - building 'psutil._psutil_posix' extension 08:58:44 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 08:58:44 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 08:58:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:58:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:58:44 INFO - Successfully installed psutil 08:58:44 INFO - Cleaning up... 08:58:44 INFO - Return code: 0 08:58:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:44 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x282b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6290>, '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 0x2ac6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7040>, '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': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', '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 08:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:58:44 INFO - Using env: {'DISPLAY': ':0', 08:58:44 INFO - 'HOME': '/home/cltbld', 08:58:44 INFO - 'LANG': 'en_US.UTF-8', 08:58:44 INFO - 'LANGUAGE': 'en_US:en', 08:58:44 INFO - 'LOGNAME': 'cltbld', 08:58:44 INFO - 'MAIL': '/var/mail/cltbld', 08:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:44 INFO - 'MOZ_NO_REMOTE': '1', 08:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:44 INFO - 'NO_EM_RESTART': '1', 08:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:44 INFO - 'PWD': '/builds/slave/test', 08:58:44 INFO - 'SHELL': '/bin/bash', 08:58:44 INFO - 'SHLVL': '1', 08:58:44 INFO - 'TERM': 'linux', 08:58:44 INFO - 'TMOUT': '86400', 08:58:44 INFO - 'USER': 'cltbld', 08:58:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', 08:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:44 INFO - '_': '/tools/buildbot/bin/python'} 08:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:58:45 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 08:58:45 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 08:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:45 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 08:58:45 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 08:58:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:58:46 INFO - Installing collected packages: mozsystemmonitor 08:58:46 INFO - Running setup.py install for mozsystemmonitor 08:58:46 INFO - Successfully installed mozsystemmonitor 08:58:46 INFO - Cleaning up... 08:58:46 INFO - Return code: 0 08:58:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:46 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x282b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6290>, '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 0x2ac6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7040>, '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': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', '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 08:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:58:46 INFO - Using env: {'DISPLAY': ':0', 08:58:46 INFO - 'HOME': '/home/cltbld', 08:58:46 INFO - 'LANG': 'en_US.UTF-8', 08:58:46 INFO - 'LANGUAGE': 'en_US:en', 08:58:46 INFO - 'LOGNAME': 'cltbld', 08:58:46 INFO - 'MAIL': '/var/mail/cltbld', 08:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:46 INFO - 'MOZ_NO_REMOTE': '1', 08:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:46 INFO - 'NO_EM_RESTART': '1', 08:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:46 INFO - 'PWD': '/builds/slave/test', 08:58:46 INFO - 'SHELL': '/bin/bash', 08:58:46 INFO - 'SHLVL': '1', 08:58:46 INFO - 'TERM': 'linux', 08:58:46 INFO - 'TMOUT': '86400', 08:58:46 INFO - 'USER': 'cltbld', 08:58:46 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', 08:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:46 INFO - '_': '/tools/buildbot/bin/python'} 08:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:46 INFO - Downloading/unpacking jsonschema==2.5.1 08:58:46 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 08:58:46 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 08:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:46 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 08:58:46 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 08:58:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:58:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:58:47 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 08:58:47 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 08:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:47 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 08:58:47 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 08:58:47 INFO - Downloading functools32-3.2.3-2.tar.gz 08:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:58:47 INFO - warning: no files found matching '*.txt' 08:58:47 INFO - no previously-included directories found matching 'build' 08:58:47 INFO - no previously-included directories found matching 'dist' 08:58:47 INFO - no previously-included directories found matching '.git*' 08:58:47 INFO - Installing collected packages: jsonschema, functools32 08:58:47 INFO - Running setup.py install for functools32 08:58:47 INFO - warning: no files found matching '*.txt' 08:58:47 INFO - no previously-included directories found matching 'build' 08:58:47 INFO - no previously-included directories found matching 'dist' 08:58:47 INFO - no previously-included directories found matching '.git*' 08:58:47 INFO - Successfully installed jsonschema functools32 08:58:47 INFO - Cleaning up... 08:58:47 INFO - Return code: 0 08:58:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:47 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x282b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6290>, '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 0x2ac6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7040>, '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': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', '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 08:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:58:47 INFO - Using env: {'DISPLAY': ':0', 08:58:47 INFO - 'HOME': '/home/cltbld', 08:58:47 INFO - 'LANG': 'en_US.UTF-8', 08:58:47 INFO - 'LANGUAGE': 'en_US:en', 08:58:47 INFO - 'LOGNAME': 'cltbld', 08:58:47 INFO - 'MAIL': '/var/mail/cltbld', 08:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:47 INFO - 'MOZ_NO_REMOTE': '1', 08:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:47 INFO - 'NO_EM_RESTART': '1', 08:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:47 INFO - 'PWD': '/builds/slave/test', 08:58:47 INFO - 'SHELL': '/bin/bash', 08:58:47 INFO - 'SHLVL': '1', 08:58:47 INFO - 'TERM': 'linux', 08:58:47 INFO - 'TMOUT': '86400', 08:58:47 INFO - 'USER': 'cltbld', 08:58:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', 08:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:47 INFO - '_': '/tools/buildbot/bin/python'} 08:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:58:48 INFO - Cleaning up... 08:58:48 INFO - Return code: 0 08:58:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:48 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x282b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6290>, '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 0x2ac6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7040>, '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': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', '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 08:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:58:48 INFO - Using env: {'DISPLAY': ':0', 08:58:48 INFO - 'HOME': '/home/cltbld', 08:58:48 INFO - 'LANG': 'en_US.UTF-8', 08:58:48 INFO - 'LANGUAGE': 'en_US:en', 08:58:48 INFO - 'LOGNAME': 'cltbld', 08:58:48 INFO - 'MAIL': '/var/mail/cltbld', 08:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:48 INFO - 'MOZ_NO_REMOTE': '1', 08:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:48 INFO - 'NO_EM_RESTART': '1', 08:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:48 INFO - 'PWD': '/builds/slave/test', 08:58:48 INFO - 'SHELL': '/bin/bash', 08:58:48 INFO - 'SHLVL': '1', 08:58:48 INFO - 'TERM': 'linux', 08:58:48 INFO - 'TMOUT': '86400', 08:58:48 INFO - 'USER': 'cltbld', 08:58:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', 08:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:48 INFO - '_': '/tools/buildbot/bin/python'} 08:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:48 INFO - Downloading/unpacking blobuploader==1.2.4 08:58:48 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 08:58:48 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 08:58:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:48 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 08:58:48 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 08:58:49 INFO - Downloading blobuploader-1.2.4.tar.gz 08:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:58:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:58:49 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 08:58:49 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 08:58:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:49 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 08:58:49 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 08:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:58:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:50 INFO - Downloading docopt-0.6.1.tar.gz 08:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:58:50 INFO - Installing collected packages: blobuploader, requests, docopt 08:58:50 INFO - Running setup.py install for blobuploader 08:58:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:58:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:58:50 INFO - Running setup.py install for requests 08:58:50 INFO - Running setup.py install for docopt 08:58:50 INFO - Successfully installed blobuploader requests docopt 08:58:50 INFO - Cleaning up... 08:58:50 INFO - Return code: 0 08:58:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x282b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6290>, '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 0x2ac6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7040>, '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': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', '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 08:58:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:58:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:58:50 INFO - Using env: {'DISPLAY': ':0', 08:58:50 INFO - 'HOME': '/home/cltbld', 08:58:50 INFO - 'LANG': 'en_US.UTF-8', 08:58:50 INFO - 'LANGUAGE': 'en_US:en', 08:58:50 INFO - 'LOGNAME': 'cltbld', 08:58:50 INFO - 'MAIL': '/var/mail/cltbld', 08:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:50 INFO - 'MOZ_NO_REMOTE': '1', 08:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:50 INFO - 'NO_EM_RESTART': '1', 08:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:50 INFO - 'PWD': '/builds/slave/test', 08:58:50 INFO - 'SHELL': '/bin/bash', 08:58:50 INFO - 'SHLVL': '1', 08:58:50 INFO - 'TERM': 'linux', 08:58:50 INFO - 'TMOUT': '86400', 08:58:50 INFO - 'USER': 'cltbld', 08:58:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', 08:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:50 INFO - '_': '/tools/buildbot/bin/python'} 08:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:58:51 INFO - Running setup.py (path:/tmp/pip-NPQJPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:58:51 INFO - Running setup.py (path:/tmp/pip-EBJ2cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:58:51 INFO - Running setup.py (path:/tmp/pip-2dhIpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:58:51 INFO - Running setup.py (path:/tmp/pip-NMwPl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:58:51 INFO - Running setup.py (path:/tmp/pip-aDWR0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:58:51 INFO - Running setup.py (path:/tmp/pip-QO5ZZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:58:51 INFO - Running setup.py (path:/tmp/pip-NLjFtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:58:51 INFO - Running setup.py (path:/tmp/pip-nfcHeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:58:51 INFO - Running setup.py (path:/tmp/pip-W9L6ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:58:51 INFO - Running setup.py (path:/tmp/pip-6zJuc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:58:51 INFO - Running setup.py (path:/tmp/pip-N48vGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:58:51 INFO - Running setup.py (path:/tmp/pip-Aw0OMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:58:51 INFO - Running setup.py (path:/tmp/pip-7IIeDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:58:52 INFO - Running setup.py (path:/tmp/pip-3be3Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:58:52 INFO - Running setup.py (path:/tmp/pip-wS3UBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:58:52 INFO - Running setup.py (path:/tmp/pip-SuejcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:58:52 INFO - Running setup.py (path:/tmp/pip-cKC2HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:58:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:58:52 INFO - Running setup.py install for manifestparser 08:58:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:58:52 INFO - Running setup.py install for mozcrash 08:58:52 INFO - Running setup.py install for mozdebug 08:58:52 INFO - Running setup.py install for mozdevice 08:58:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:58:52 INFO - Running setup.py install for mozfile 08:58:52 INFO - Running setup.py install for mozhttpd 08:58:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:58:52 INFO - Running setup.py install for mozinfo 08:58:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:58:53 INFO - Running setup.py install for mozInstall 08:58:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:58:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:58:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:58:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:58:53 INFO - Running setup.py install for mozleak 08:58:53 INFO - Running setup.py install for mozlog 08:58:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:58:53 INFO - Running setup.py install for moznetwork 08:58:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:58:53 INFO - Running setup.py install for mozprocess 08:58:53 INFO - Running setup.py install for mozprofile 08:58:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:58:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:58:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:58:53 INFO - Running setup.py install for mozrunner 08:58:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:58:53 INFO - Running setup.py install for mozscreenshot 08:58:53 INFO - Running setup.py install for moztest 08:58:53 INFO - Running setup.py install for mozversion 08:58:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:58:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:58:54 INFO - Cleaning up... 08:58:54 INFO - Return code: 0 08:58:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x282b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6290>, '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 0x2ac6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7040>, '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': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', '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 08:58:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:58:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:58:54 INFO - Using env: {'DISPLAY': ':0', 08:58:54 INFO - 'HOME': '/home/cltbld', 08:58:54 INFO - 'LANG': 'en_US.UTF-8', 08:58:54 INFO - 'LANGUAGE': 'en_US:en', 08:58:54 INFO - 'LOGNAME': 'cltbld', 08:58:54 INFO - 'MAIL': '/var/mail/cltbld', 08:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:54 INFO - 'MOZ_NO_REMOTE': '1', 08:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:54 INFO - 'NO_EM_RESTART': '1', 08:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:54 INFO - 'PWD': '/builds/slave/test', 08:58:54 INFO - 'SHELL': '/bin/bash', 08:58:54 INFO - 'SHLVL': '1', 08:58:54 INFO - 'TERM': 'linux', 08:58:54 INFO - 'TMOUT': '86400', 08:58:54 INFO - 'USER': 'cltbld', 08:58:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', 08:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:54 INFO - '_': '/tools/buildbot/bin/python'} 08:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:58:54 INFO - Running setup.py (path:/tmp/pip-lL0JbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:58:54 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)) 08:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:58:54 INFO - Running setup.py (path:/tmp/pip-qnzryZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:58:54 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)) 08:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:58:54 INFO - Running setup.py (path:/tmp/pip-lpl5C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:58:54 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)) 08:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:58:54 INFO - Running setup.py (path:/tmp/pip-3oITgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 08:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:58:54 INFO - Running setup.py (path:/tmp/pip-lobouf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:58:54 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)) 08:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:58:54 INFO - Running setup.py (path:/tmp/pip-qJs47h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:58:54 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)) 08:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:58:54 INFO - Running setup.py (path:/tmp/pip-32LcMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:58:54 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)) 08:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:58:54 INFO - Running setup.py (path:/tmp/pip-TpeEGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:58:54 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)) 08:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:58:54 INFO - Running setup.py (path:/tmp/pip-mq31x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:58:54 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)) 08:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:58:54 INFO - Running setup.py (path:/tmp/pip-HQvYXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:58:55 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)) 08:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:58:55 INFO - Running setup.py (path:/tmp/pip-qhqU5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:58:55 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)) 08:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:58:55 INFO - Running setup.py (path:/tmp/pip-jNKO0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:58:55 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)) 08:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:58:55 INFO - Running setup.py (path:/tmp/pip-DQdT5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:58:55 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)) 08:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:58:55 INFO - Running setup.py (path:/tmp/pip-VxdriG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:58:55 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)) 08:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:58:55 INFO - Running setup.py (path:/tmp/pip-T1U6z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:58:55 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)) 08:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:58:55 INFO - Running setup.py (path:/tmp/pip-84Trxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:58:55 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)) 08:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:58:55 INFO - Running setup.py (path:/tmp/pip-ZZSdyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:58:55 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)) 08:58:55 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)) 08:58:55 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)) 08:58:55 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)) 08:58:55 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:58:55 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:58:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:56 INFO - Downloading blessings-1.6.tar.gz 08:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:58:56 INFO - Installing collected packages: blessings 08:58:56 INFO - Running setup.py install for blessings 08:58:57 INFO - Successfully installed blessings 08:58:57 INFO - Cleaning up... 08:58:57 INFO - Return code: 0 08:58:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:58:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:58:57 INFO - Reading from file tmpfile_stdout 08:58:57 INFO - Current package versions: 08:58:57 INFO - argparse == 1.2.1 08:58:57 INFO - blessings == 1.6 08:58:57 INFO - blobuploader == 1.2.4 08:58:57 INFO - docopt == 0.6.1 08:58:57 INFO - functools32 == 3.2.3-2 08:58:57 INFO - jsonschema == 2.5.1 08:58:57 INFO - manifestparser == 1.1 08:58:57 INFO - mozInstall == 1.12 08:58:57 INFO - mozcrash == 1.0 08:58:57 INFO - mozdebug == 0.1 08:58:57 INFO - mozdevice == 0.50 08:58:57 INFO - mozfile == 1.2 08:58:57 INFO - mozhttpd == 0.7 08:58:57 INFO - mozinfo == 0.9 08:58:57 INFO - mozleak == 0.1 08:58:57 INFO - mozlog == 3.4 08:58:57 INFO - moznetwork == 0.27 08:58:57 INFO - mozprocess == 0.25 08:58:57 INFO - mozprofile == 0.28 08:58:57 INFO - mozrunner == 6.13 08:58:57 INFO - mozscreenshot == 0.1 08:58:57 INFO - mozsystemmonitor == 0.3 08:58:57 INFO - moztest == 0.8 08:58:57 INFO - mozversion == 1.4 08:58:57 INFO - psutil == 3.1.1 08:58:57 INFO - requests == 1.2.3 08:58:57 INFO - wsgiref == 0.1.2 08:58:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x282b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6290>, '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 0x2ac6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7040>, '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': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', '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 08:58:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:58:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:58:57 INFO - Using env: {'DISPLAY': ':0', 08:58:57 INFO - 'HOME': '/home/cltbld', 08:58:57 INFO - 'LANG': 'en_US.UTF-8', 08:58:57 INFO - 'LANGUAGE': 'en_US:en', 08:58:57 INFO - 'LOGNAME': 'cltbld', 08:58:57 INFO - 'MAIL': '/var/mail/cltbld', 08:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:57 INFO - 'MOZ_NO_REMOTE': '1', 08:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:57 INFO - 'NO_EM_RESTART': '1', 08:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:57 INFO - 'PWD': '/builds/slave/test', 08:58:57 INFO - 'SHELL': '/bin/bash', 08:58:57 INFO - 'SHLVL': '1', 08:58:57 INFO - 'TERM': 'linux', 08:58:57 INFO - 'TMOUT': '86400', 08:58:57 INFO - 'USER': 'cltbld', 08:58:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', 08:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:57 INFO - '_': '/tools/buildbot/bin/python'} 08:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:57 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)) 08:58:57 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)) 08:58:57 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)) 08:58:57 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)) 08:58:57 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)) 08:58:57 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)) 08:58:57 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)) 08:58:57 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)) 08:58:57 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)) 08:58:57 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)) 08:58:57 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)) 08:58:57 INFO - Cleaning up... 08:58:57 INFO - Return code: 0 08:58:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x282b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6290>, '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 0x2ac6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7040>, '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': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', '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 08:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:58:57 INFO - Using env: {'DISPLAY': ':0', 08:58:57 INFO - 'HOME': '/home/cltbld', 08:58:57 INFO - 'LANG': 'en_US.UTF-8', 08:58:57 INFO - 'LANGUAGE': 'en_US:en', 08:58:57 INFO - 'LOGNAME': 'cltbld', 08:58:57 INFO - 'MAIL': '/var/mail/cltbld', 08:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:57 INFO - 'MOZ_NO_REMOTE': '1', 08:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:57 INFO - 'NO_EM_RESTART': '1', 08:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:57 INFO - 'PWD': '/builds/slave/test', 08:58:57 INFO - 'SHELL': '/bin/bash', 08:58:57 INFO - 'SHLVL': '1', 08:58:57 INFO - 'TERM': 'linux', 08:58:57 INFO - 'TMOUT': '86400', 08:58:57 INFO - 'USER': 'cltbld', 08:58:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', 08:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:57 INFO - '_': '/tools/buildbot/bin/python'} 08:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:58:57 INFO - Cleaning up... 08:58:57 INFO - Return code: 0 08:58:57 INFO - Running post-action listener: _resource_record_post_action 08:58:57 INFO - Running post-action listener: _start_resource_monitoring 08:58:57 INFO - Starting resource monitoring. 08:58:57 INFO - [mozharness: 2017-05-03 15:58:57.801380Z] Finished create-virtualenv step (success) 08:58:57 INFO - [mozharness: 2017-05-03 15:58:57.801834Z] Running install step. 08:58:57 INFO - Running pre-action listener: _resource_record_pre_action 08:58:57 INFO - Running main action method: install 08:58:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:58:58 INFO - Reading from file tmpfile_stdout 08:58:58 INFO - Detecting whether we're running mozinstall >=1.0... 08:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:58:58 INFO - Reading from file tmpfile_stdout 08:58:58 INFO - Output received: 08:58:58 INFO - Usage: mozinstall [options] installer 08:58:58 INFO - Options: 08:58:58 INFO - -h, --help show this help message and exit 08:58:58 INFO - -d DEST, --destination=DEST 08:58:58 INFO - Directory to install application into. [default: 08:58:58 INFO - "/builds/slave/test"] 08:58:58 INFO - --app=APP Application being installed. [default: firefox] 08:58:58 INFO - mkdir: /builds/slave/test/build/application 08:58:58 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'] 08:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:59:13 INFO - Reading from file tmpfile_stdout 08:59:13 INFO - Output received: 08:59:13 INFO - /builds/slave/test/build/application/firefox/firefox 08:59:13 INFO - Running post-action listener: _resource_record_post_action 08:59:13 INFO - [mozharness: 2017-05-03 15:59:13.071358Z] Finished install step (success) 08:59:13 INFO - [mozharness: 2017-05-03 15:59:13.071633Z] Running run-tests step. 08:59:13 INFO - Running pre-action listener: _resource_record_pre_action 08:59:13 INFO - Running main action method: run_tests 08:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:59:13 INFO - Python 2.7.3 08:59:13 INFO - Return code: 0 08:59:13 INFO - grabbing minidump binary from tooltool 08:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:59:13 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 0x2ac6290>, '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 0x2ac6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:59:13 INFO - Return code: 0 08:59:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:59:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:59:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:59:13 INFO - ENV: RUST_BACKTRACE is now 1 08:59:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:59:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 08:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 08:59:13 INFO - Using env: {'DISPLAY': ':0', 08:59:13 INFO - 'HOME': '/home/cltbld', 08:59:13 INFO - 'LANG': 'en_US.UTF-8', 08:59:13 INFO - 'LANGUAGE': 'en_US:en', 08:59:13 INFO - 'LOGNAME': 'cltbld', 08:59:13 INFO - 'MAIL': '/var/mail/cltbld', 08:59:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:59:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:13 INFO - 'MOZ_NO_REMOTE': '1', 08:59:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:13 INFO - 'NO_EM_RESTART': '1', 08:59:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:13 INFO - 'PWD': '/builds/slave/test', 08:59:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:59:13 INFO - 'RUST_BACKTRACE': '1', 08:59:13 INFO - 'SHELL': '/bin/bash', 08:59:13 INFO - 'SHLVL': '1', 08:59:13 INFO - 'TERM': 'linux', 08:59:13 INFO - 'TMOUT': '86400', 08:59:13 INFO - 'USER': 'cltbld', 08:59:13 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1493827084.108547-1531611621', 08:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:13 INFO - '_': '/tools/buildbot/bin/python'} 08:59:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 08:59:13 INFO - mozversion application_buildid: 20170503151847 08:59:13 INFO - mozversion application_changeset: d7e40bb852ea047a0e5f530bcdc04d29a1765001 08:59:13 INFO - mozversion application_display_name: Nightly 08:59:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:59:13 INFO - mozversion application_name: Firefox 08:59:13 INFO - mozversion application_remotingname: firefox 08:59:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:59:13 INFO - mozversion application_vendor: Mozilla 08:59:13 INFO - mozversion application_version: 55.0a1 08:59:13 INFO - mozversion platform_buildid: 20170503151847 08:59:13 INFO - mozversion platform_changeset: d7e40bb852ea047a0e5f530bcdc04d29a1765001 08:59:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:59:13 INFO - mozversion platform_version: 55.0a1 08:59:13 INFO - using testdate: 1493827153 08:59:13 INFO - actual date: 1493827153 08:59:13 INFO - starting webserver on 'localhost:52683' 08:59:13 INFO - SUITE-START | Running 2 tests 08:59:13 INFO - TEST-START | dromaeo_css 08:59:13 INFO - operating with platform_type : linux_ 08:59:13 INFO - Initialising browser for dromaeo_css test... 08:59:13 INFO - TEST-INFO | started process 3312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpidN5PK/profile http://localhost:52683/getInfo.html) 08:59:18 INFO - PID 3312 | __metrics Screen width/height:1600/1200 08:59:18 INFO - PID 3312 | colorDepth:24 08:59:18 INFO - PID 3312 | Browser inner width/height: 1024/695 08:59:18 INFO - PID 3312 | __metrics 08:59:20 INFO - TEST-INFO | 3312: exit 0 08:59:20 INFO - Browser initialized. 08:59:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:59:20 INFO - TEST-INFO | started process 3446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpidN5PK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:32 INFO - PID 3446 | RSS: Main: 160915456 08:59:32 INFO - PID 3446 | 09:02:37 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:52683/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52683/tests/dromaeo/cssquery-ext.html) 09:02:40 INFO - PID 3446 | RSS: Main: 163753984 09:02:40 INFO - PID 3446 | 09:05:42 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:52683/tests/dromaeo/cssquery-ext.html (next: http://localhost:52683/tests/dromaeo/cssquery-jquery.html) 09:05:43 INFO - PID 3446 | RSS: Main: 159342592 09:05:43 INFO - PID 3446 | 09:08:45 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:52683/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52683/tests/dromaeo/cssquery-mootools.html) 09:08:45 INFO - PID 3446 | RSS: Main: 166342656 09:08:45 INFO - PID 3446 | 09:11:47 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:52683/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52683/tests/dromaeo/cssquery-prototype.html) 09:11:48 INFO - PID 3446 | RSS: Main: 158666752 09:11:48 INFO - PID 3446 | 09:14:51 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:52683/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52683/tests/dromaeo/cssquery-yui.html) 09:14:51 INFO - PID 3446 | RSS: Main: 163024896 09:14:51 INFO - PID 3446 | 09:17:53 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:52683/tests/dromaeo/cssquery-yui.html (next: http://localhost:52683/tests/dromaeo/cssquery-dojo.html) 09:17:53 INFO - PID 3446 | RSS: Main: 167641088 09:17:53 INFO - PID 3446 | 09:17:53 INFO - PID 3446 | __start_tp_report 09:17:53 INFO - PID 3446 | _x_x_mozilla_page_load 09:17:53 INFO - PID 3446 | _x_x_mozilla_page_load_details 09:17:53 INFO - PID 3446 | |i|pagename|runs| 09:17:53 INFO - PID 3446 | |0;dojo.html;2703.094463354776;2704.1887433769866;2714.389262415956;2742.5200589896763;2743.286745446184;5264.39459462161;5291.4973077557615;5299.947000529994;5323.866903327419;5394.811181608639;5295.31160949077;5302;5397.919031214525;5433.565314774818;5435.2934118564535;4479.776011199443;4714.4106986626675;4762.428508578975;4795.23276275796;4816.54242846929;4854.150523658363;4882.97558512207;4887.0225954809;4901.411830580335;4922.286268491084;4699.201135806921;4718.41019872516;4751.097291514601;4828.155072862271;4841.394825646794;4794.5205479452125;4807.326974223612;4814.7833347499445;4855.126077306083;4873.707577545359;4738.194506933795;4767.809287628491;4768.213244814601;4780.354652121954;4811.711297322172;5250.81622143227;5331.680099194061;5357.705326207057;5414.64550621086;5458.044842152647;5746.913796293017;5750.683712395817;5755.712214389306;5756.251687280668;5764.135379693038;5778;5782.537397008229;5789.2763404574425;5793.391693872125;5794.710264486759;5329.440408757102;5377.758000889891;5379.569634429236;5384.111621582473;5385.246065550787;5823.88352232953;5865.120231965239;5880.117982302689;5892.6759028253;5904.0553511437965;5663.292088488939;5672.347680016851;5702.344230413555;5788.594798364074;5810.622309549865;5834.504067154255;5845.766169353264;5869;5871.089981052944;5909.8227053188475;5777;5811.3316968548315;5815.476607105381;5818.359980402152;5823.330317013598;5634.098544232903;5779.682117483495;5786.276715410574;5793.159991801165;5793.333766616893;4805.687630304019;4831.371921650233;4846.7818948147415;4848.3454733610515;4850.345203397566;4172.874813755592;4176.1230141670585;4205.306124489486;4212.473440819897;4216.789160541961;4907.60739140875;4923.310736496894;4946.431160416598;4969.403671559364;4979.4771548987555;5867.882642347129;5868;5870.471657550841;5890.234269545017;5892.911606325909;4802.063597598435;4873.366462359871;4912.238603016538;4922.384701912261;4926.630502712311;5212.50481204285;5238;5240;5245.895082098336;5270.472952704698;5340.385855626652;5368.060589396762;5368.489993450616;5375.220593013991;5379.811706590251;5722.055860783091;5806.796762113306;5878.793890101272;5894.263217097863;5952.0179170436395;5354.116570765936;5361.088614935392;5432.809851655173;5448.0465918463315;5453.209284653783;5683.403242659461;5685.914711279252;5723.198752174782;5726.370099288992;5727.6849773262875;5738.426157384228;5808.070708686759;5825.563082768725;5827.825165245049;5884.382139875252;5535.418781027934;5596.636218645775;5599.832005039855;5601.831945041656;5603.3836278008575;5511.889762204813;5516.558675306046;5538.280023597068;5540.753330500605;5550.973069982067;5497.36780270274;5509.889802203853;5522.475364840334;5547.972260138674;5551.056320425457;5641.633293835887;5691.800786972436;5725.341585717696;5789.2763404574425;5791.8552036199435;5616.606837521498;5620.690862002629;5626.43735626434;5633.549316054788;5638.88722225545 09:17:53 INFO - PID 3446 | |1;ext.html;643.8776632439836;670.175683908792;1032.3908893752684;1049.2602715085866;1119.4738472917725;31375.372492550163;32269.35461290776;32270.67729322706;32316.515252271205;32323.838380808123;29602.851985740093;29980.40039199215;30007;30043;30058.549121763135;6262.12330273762;6363.681815909197;6496.837579060538;6865.313468653119;6882.414994725455;6928.480363972697;6946.930530694704;6947.652617369136;6993.125859267591;7037.718491260343;6970.895436568456;6977.441804655616;7025.26234745352;7035.226125126232;7042.7887163385185;6984.860302793915;7007.264237255091;7025.332593403618;7028.226895041541;7034.542754720952;6849.2808255132995;6891;6894.413974812147;6894.620795856226;6923.099997000358;32296.677033229604;32381.51427728586;32419.83790081058;32553.6744632553;32591.185220369443;3104.891328803481;3114.4394009078355;3136.6549679535233;3138.497840345534;3144.5126005469187;24657.38356541083;24689.25932222036;24708.629370559454;24723.38191545208;24850;2592.1445922845414;2614.555525560659;2618.1752747884357;2631.63157157998;2636.93407664808;142666;143172;143190;143406;143733.28133359266;37559.436608450895;39758;40108.398374024415;40199.397009044886;41423.1715365691;41399.58600413957;41408.378874316906;41696;43349.566504335184;44076.77961610236;12553.811692824433;12754.36228188587;12757.744845103047;12816.743665126645;12850;9966.20270378368;10079.143272821746;10104.74738131538;10114.342567733074;10145.94927025375;12699.99950015742;12745.36273186337;12790.232586044867;12835.294058826667;13046.260285340184;5282.732144285421;5322.148456246982;5365.54392876602;5425.6202065855805;5505.889882202334;872.1017352127319;893.3523195683208;896.7309807057857;896.7354630384052;926.592299388267;20173.6973945388;21409.464763381042;21504.129256733937;21526.6770998432;21554.13783448676;967.385710074108;972.8881178664402;993.3295025857517;995.9751006224758;1005.8340373838234;11087.50106245221;11244.775104497865;11446.740858505558;11500.424978751196;11651.88348116508;171821;173219;173625;173682.13158934124;174080;39799.2040159201;39846;39979.200415991516;40041;40375.59624403777;1185.2991736020194;1228.8402507673945;1229.6126720083146;1234.481517762542;1234.8332975048254;20014.49963750918;20508.79491205069;20923.58152836965;21134.42190498364;21178.682319765525;29429.705702942698;32379.35241295208;32918.341633166725;32990.50514242336;33049.669503304656;160398;162151;163107;163325;163728;30111.849440752656;30152;30274.54588181223;30377.39245215039;30507.2373190672;35343.646563534036;35416.291674165856;35735;35747.46378804268;35985.280294393444;27449.588256175775;27843.303917402227;27934.927158012197;27981.160565183076;28827;26762.661866906186;27259.182224533295;27627.165246081455;27650;28783.856080719463;30709.38581228318;30719.232019198804;30919.84540077285;30938;31100.533491997187;26293.34266643349;26674.866625666746;26983.46033079288;27306.044288450605;27945.301367465163;21699.132034718434;22285.331440056823;22789.88605056964;23165.189218377276;23180.652290215323 09:17:53 INFO - PID 3446 | |2;jquery.html;408.96728261739065;411.6644934378483;416.11575402270165;439.9164158809826;440.9470863496381;14201.92899035506;17000.489985300428;17552.473425797216;17760;17963.371282005133;18131.456056318297;18312.175952082154;18430.262789488403;18551;18623;5335.7865685372535;5338.652987555816;5428.185772134192;5506.0089183946875;5573.6098473106895;5401.891962160755;5430.456954304557;5436.972815135919;5439.5376393006645;5481.260029895972;5259.973700131494;5389.973050134763;5434.184872269171;5469.371022332423;5501.4223506531835;5478.890422191574;5517.586181036419;5535.197396377543;5537.861553461175;5578.972105139448;4976.303317535548;4988.276699878497;4992.700437973734;5004.699718016895;5013.548780609763;20982.2656207032;21326.253581124587;21498.462538436506;21552.245671401583;21585.56828863414;1525.3822202008205;1595.0748565831789;1610.484644913628;1610.7503336982786;1634.2155765232756;14589.562313130624;14645.121292722471;14833.554993350217;14945.70108597822;15023.248837558187;2087.7285952826187;2099.6745504446835;2142.153849229546;2145.1955516681246;2175.4670105824175;86018;90327.54836225843;90401.64397534043;90401.64397534108;91272;10790.78418431627;10859.619913303155;10883.401412922365;11124.555017799197;11150.219484635998;15277.541673749805;15297.617559560877;15350.769738453931;15387.768978481694;32415.189620259684;8902.59938302765;9073.909260907307;9085.13691199335;9349.90650093504;9352.111549402796;7167.104111986002;7229.891551626624;7419.332260096618;7476.738314158978;7611.20082391352;8778.37600043994;9238.815223695623;9303.441793492411;9537.666181683608;9605.18355939739;3474.4614584739406;3532.4877892705927;3682.7606205597085;3749.7937613430977;3845.9038524036564;840.9537475438788;860.7046395175221;873.6854732296368;885.5395194498825;896.3501461440403;16570.254338554794;16735.83264167367;16848.74726879098;16874.83125168757;17292.481225563253;873.7204094689638;884.7699598104539;886.4326830828275;890.5013192612158;903.074348792493;9113.134252246025;9133.634654613874;9174.587143578421;9399.671011514563;9542.666006689733;369193;369887.1505642508;370854;379498;380620;73512.63243683748;75570.24429755632;75815.62092189614;80132.19867801364;80342;1025.1183981775666;1041.4688508860384;1063.2557209953063;1069.4332004037872;1072.5120070367964;14118.50585229512;14278.500252491112;14455.277236138361;14474.059186152866;15025.474108406153;36626.26747464982;36832.63167368292;37182.256354873294;37373.62626373702;37878.43182352322;43932;45160.32259516176;45205.869853253935;45601.31598026099;45677;11301.886981130083;11698.4735686896;11853.525858965544;11913.940430297793;12121.757564848478;12863.421146048637;12906.80639790385;12936.805947910601;13072.084954053125;13132.015098867432;10639.308444951053;10644;10707.839382409114;11175.776484470427;11216.383098929637;9895.802083958424;10117.342372745748;10194.694159175237;10205.693829185137;10250.077493025663;10837.512311945824;10863.728406789893;10938.835917461403;11268.211225214156;11379;11475.48360323804;11572.537098515964;11605.76788464243;11627.59303424376;12082.637520874388;9659.758506037124;9784.657536986457;9956.900430995598;10363.689089327332;10723.24937254416 09:17:53 INFO - PID 3446 | |3;mootools.html;1225.3505642009734;1285.922844629323;1287.41422652693;1288.780907245768;1292.399034448981;9540.666076687317;9857.556409961551;10013.599456021759;10026.899731002688;10081.344712593676;9891.455969921652;10044.497775111251;10063.04401081898;10099.646512372068;10105.191584673226;2262.8642281463126;2293.20884294918;2294.8623082615013;2305.13557415969;2313.0400883633274;2194.2868567715477;2253.954920901581;2272.4773302140516;2274.931752047441;2275.4993901341677;2243.573720993006;2251.819854411643;2284.2233640562204;2298.3449716830705;2298.5058212484314;2198.527316626925;2218.3899427657525;2257.322803159054;2262.7284725833006;2266.218154736613;1843.3087592152942;1902.914368853405;2068.6896965455153;2097.2869224463757;2110.2192188890053;9969.800603987953;9974.750631234278;10068.798624027551;10087.243456740774;10097.091261786401;5613.719314034322;5869.090291004858;5869.735861886225;5873.823785286449;5898.882022359572;3241.4003409369343;3487.093355727504;3496.1609213788506;3546.8935931922083;3572.910677233064;1014.9492525373702;1032.82441984862;1049.7375656085978;1072.1637123044038;1076.8330908709163;14377.496787612383;14416.92791536046;14493.782593261216;14551.927240363837;14557.272136393138;4722.811087556528;4732.100900828831;4991.775370108354;5039.092963266574;5127.769250383742;10395.84406233907;10429.9478502607;10444.947775261075;10473.005064518858;10495.527701253463;5525.502704756591;5549.500544950974;5577.972110139423;5580.386157522669;5602.495775380154;4969.180085285887;4991.825286114969;5157.123289040797;5227.947720522746;5319.0957537218765;3791.109089363997;3905.5899130591447;3940.113474468279;3957.8021098945514;4006.23881462527;1077.8975997280245;1096.276457538021;1101.6284725516623;1110.4170310587006;1111.8721347045032;716.4733920568378;736.14607055815;747.1855677311756;749.9362554182846;758.1811643425087;5639.379668236491;5789.8552536186935;6402.231732192074;6671.966640166866;6690.899636505456;851.9020312664;867.9566021698889;871.4684042733927;873.5850471026212;878.4509681449094;3890.2025084857537;3929.5677475477673;3949.565547789741;3951.130751234724;4025.8590949316635;12312.569060082855;12511.93744031274;12703.68240793969;12748.93625531885;12775.744485110432;12516.186447880858;12595.433205505775;12621.810672839914;12830.55093071738;12955.870441295654;7437.739679111205;7453.217412171861;7491.8501629967095;7513.511621744569;7564.054493188351;5999.400059993965;6035.879282414415;6059.6364218147055;6088.726007329769;6110.769569107333;11424.314541127558;11522.193446458667;11551.595694150665;11630.360330181922;11734.237274577124;11667.883321166679;11937.28376297425;12055.638330850088;12082.879171208175;12089.455974481345;7289.5261807982315;7550.924490755022;7554.244575542401;7561.3194812467145;7561.962190189014;9329.346945713734;9348.766280843034;9427.528623568931;9468.195203407788;9485.288603354638;7688.730894418669;7720.7683769487;7790.220977902164;7817.882731759142;8044.115147333906;7923.7226697065325;7931.286184243215;7983.92016079855;8003;8047.879281810895;6742.325767423218;6871.03805467225;6877.828054298682;6879.552829066095;6880.965595171992;5476.315460567429;5490.615656904138;5536.086545719912;5588.217649528988;5714.314282286152;5384;5483.835484935458;5516.834494965157;5576.024195765806;5669.3480249770155 09:17:53 INFO - PID 3446 | |4;prototype.html;376.2850583890609;402.5551765299346;404.44187021909767;407.09277037081256;408.6077365728899;5465.207544905987;5565.747706765981;5629.690367029812;5631.267935168427;5648.519875810561;5378.408375078739;5434.701091439969;5472.179173124034;5477.67133971962;5483.698396588186;4114.753114813113;4115.176964607075;4124.566920473352;4131.52487463941;4135.421041054255;4060.2082593894056;4085.2646523625735;4120.793960301988;4125.174965006996;4132.925439385766;4081.693872959525;4083.305838007546;4083.7141400102005;4088.897777555555;4095.2219078375015;4073.3279008963486;4080.204360149757;4090.836366545335;4093.1199792044554;4099.626625080602;3577.3918433866306;3580.5703315602295;3589.335972845032;3590.1922067534597;3595.2629710909464;5267.26258323835;5322.547583455411;5346.064438723208;5385.192221166817;5398.541124004464;4806.639502037361;4817.156997525419;4821.108095002436;4823.638227132979;4833.63747718919;5505.366882808488;5797.304323481167;5803.158542011384;5834.3290521589715;5835.387284335126;3950.4271880577157;3981.7013723970817;3988.3618621020496;3990.984552800846;3996.800159991989;5966.194563733884;6129.938700613026;6163.291221509494;6190.2571691397325;6199.628022318675;4050.6556942659613;4085.1216988347646;4089.7730680795644;4095.1809638072505;4097.258665067335;4128.669706423539;4147.398627199039;4153.605407486284;4161.313383291723;4166.520850102216;4738.360321356573;4791.305260737243;4808.230683090689;4821.807127714922;4825.855224343275;5804.1293805929445;5807.070868660994;5813.476787089097;5825.475707186373;5851;1417.1992824054375;1433.7347590695754;1435.777454494555;1436.4182506085053;1437.173625165534;940.4404379394249;947.15229869268;951.1772316945792;958.3148049144895;970.1365784451843;5018.874528136753;5031.094403007421;5032.899342013139;5037.370328708911;5052.267421223902;5981.6710080945095;6034.185384972972;6074.967255566476;6075.362086980892;6083.726232319556;4946.579540739078;4957.851264462072;4969.27945447908;5013.348264725635;5051.419086804991;3158.7315078218608;3219.4205043092;3219.500977348515;3232.5312829640043;3235.288236587947;5356.866078348073;5519.69641669704;5547.611667183259;5547.890421915633;5571.693556854412;6106.603070800384;6205.28639206488;6209.875802484015;6237.282712488031;6237.4698150656795;5569;5574.108142697149;5581.804636837691;5589.770250544792;5590.021746194318;5801.564882633904;5991.771686804282;6078.358843112246;6093.817185484442;6137.7851775187655;5970.492508136857;5980.5215582754145;5983.431574000463;5997.860406522746;6017.18767966319;5371.731413429391;5516.255305533701;5520.585956053232;5559.27729395176;5584.888302234014;4548.976480291908;4564.8131485813265;4567.4242386376645;4568.109218702321;4591.908161836812;5974.163617093697;6069.33237343883;6091.969540152448;6102.511799056154;6142.293636231711;5885.941140588539;5892.705364731832;5893.5874488785375;5898.528117750656;5901.527877769854;5837.299524056971;5843.795467158629;5855.2973643163095;5874.353821079763;5883.264591926009;5662.886742265214;5766.538676905753;5788.21859049023;5795.536357091339;5814;5940.584159108821;5950.494207992369;5954.404559544011;5962.642241465526;5963.821085367446;5596.608237423504;5728.312602487562;5783.884322313446;5791.131330300489;5792.362840087502 09:17:53 INFO - PID 3446 | |5;yui.html;745.5079647432689;755.6448469219466;764.3961270596226;772.9111152217494;786.6578038553228;12394.566190183345;13021.674458138552;13297.800532992002;14194.645133871645;14267;14438.783418248735;15100.395984160648;15122.924385378057;15149.091054536735;15187.772183417257;823.5799742131526;840.5503055865113;844.4004756622775;844.6283635200492;850.4727069217095;902.5712786426428;904.2720609909021;906.8730377747121;910.9180173784358;912.115248209236;932.7668082979255;939.5255396025032;940.6096469964956;947.673052796784;951.7192428233687;941.087145468894;943.8018016216603;945.3902233059638;948.4972964328916;948.8386974214366;690.147667630476;693.5630552751785;696.8780463418882;697.1285892634207;698.155232169076;12853.614391568175;12969.935150324281;13209.669758256025;13659.521916732867;13874.93062534691;15452.845471545254;15580.61048473786;15608.531744047697;15749.448769293134;15943.601409964844;11786.941065294704;12198.57304994321;12338.259704417675;12520.06099542538;12536.059795515283;2992.655844577858;2992.9102126936227;3006.9849650751607;3007.3083190866005;3008.458477474054;64174;65059.34940650628;65138;65664.01503977492;66366;12329.136960412865;12688.429020694091;12743.49026038948;12779.105462617528;12855.29295888735;21948.122075117135;22334.664980025314;22344.77655223427;22676.65985010226;22876.771232287796;5825.621334613236;5886.293644762656;5907.793227237112;5912.615679980788;6701.564398314094;3093.8917137900066;3145.9528107078413;3161.4151381994407;3167.7782555220915;3180.109569320594;3447.9827600861836;3491.4937334086417;3529.347070791912;3530.435130379127;3646.908827279286;753.3709352690455;762.0436352377731;771.1286246541372;777.5490215674895;779.6764342797676;583.6118980877669;604.9909251361233;614.4838335797862;627.9372062793684;638.6295948349946;9513.238940884712;9714.951425242829;9771.755706107404;9938.10557049869;9987.850182247272;610.914471973924;625.6058683029753;627.8681476889813;629.3894921925724;632.2697284636253;4385.166818304512;4436.401085853433;4477.082198149372;4518.615917646971;4537.274036154199;63760.68119659372;64154;64365.35634643687;66671;67174.66412668003;55035.72482137644;55272.447275527535;55413;55629.72185139048;56556.71721641366;51319;51679.48320516747;51832.48167518352;52039.73980130075;52109.218361724605;9194.17252447283;9303.813923721624;9333.953330233306;9426.811463770824;9638;26330.21009369722;26415;26529.204123876316;26708;27357.86321068382;31481.21296967594;31834.681653183172;32146;32322.35355292834;32407.351852963282;11970.281783092694;12118.394080296126;12261.754764904474;12395.566155184526;12452.68868278264;15012.549623511311;15278.923605381902;15624.21878906073;15892.046477211405;15968.361265549247;13592.524261650795;13803.861961380258;14363.856361436252;14476.059056161315;14573.708525829636;15092.773608395662;15206.011609245365;15295.388184472497;15301.617459563155;15557.14435706047;13160.276184809545;13227.3386330685;13716.725665486834;13788.862111378758;13935.93032034874;9764.267679924176;9993.300468967103;10145.492725363554;10246.129079028366;10546.789064218827;10693.839592406275;11150.645338117565;11181.552737890393;11201.719957000814;11415.486303116546 09:17:53 INFO - PID 3446 | __end_tp_report 09:17:53 INFO - PID 3446 | __start_cc_report 09:17:53 INFO - PID 3446 | _x_x_mozilla_cycle_collect,339 09:17:53 INFO - PID 3446 | __end_cc_report 09:17:53 INFO - PID 3446 | __startTimestamp1493828273883__endTimestamp 09:17:53 INFO - PID 3446 | 09:17:53 INFO - PID 3446 | ------- Summary: start ------- 09:17:53 INFO - PID 3446 | Number of tests: 6 09:17:53 INFO - PID 3446 | 09:17:53 INFO - PID 3446 | [#0] dojo.html Cycles:165 Average:5297.88 Median:5448.05 stddev:631.03 (11.6%) stddev-sans-first:599.23 09:17:53 INFO - PID 3446 | Values: 2703.1 2704.2 2714.4 2742.5 2743.3 5264.4 5291.5 5299.9 5323.9 5394.8 5295.3 5302.0 5397.9 5433.6 5435.3 4479.8 4714.4 4762.4 4795.2 4816.5 4854.2 4883.0 4887.0 4901.4 4922.3 4699.2 4718.4 4751.1 4828.2 4841.4 4794.5 4807.3 4814.8 4855.1 4873.7 4738.2 4767.8 4768.2 4780.4 4811.7 5250.8 5331.7 5357.7 5414.6 5458.0 5746.9 5750.7 5755.7 5756.3 5764.1 5778.0 5782.5 5789.3 5793.4 5794.7 5329.4 5377.8 5379.6 5384.1 5385.2 5823.9 5865.1 5880.1 5892.7 5904.1 5663.3 5672.3 5702.3 5788.6 5810.6 5834.5 5845.8 5869.0 5871.1 5909.8 5777.0 5811.3 5815.5 5818.4 5823.3 5634.1 5779.7 5786.3 5793.2 5793.3 4805.7 4831.4 4846.8 4848.3 4850.3 4172.9 4176.1 4205.3 4212.5 4216.8 4907.6 4923.3 4946.4 4969.4 4979.5 5867.9 5868.0 5870.5 5890.2 5892.9 4802.1 4873.4 4912.2 4922.4 4926.6 5212.5 5238.0 5240.0 5245.9 5270.5 5340.4 5368.1 5368.5 5375.2 5379.8 5722.1 5806.8 5878.8 5894.3 5952.0 5354.1 5361.1 5432.8 5448.0 5453.2 5683.4 5685.9 5723.2 5726.4 5727.7 5738.4 5808.1 5825.6 5827.8 5884.4 5535.4 5596.6 5599.8 5601.8 5603.4 5511.9 5516.6 5538.3 5540.8 5551.0 5497.4 5509.9 5522.5 5548.0 5551.1 5641.6 5691.8 5725.3 5789.3 5791.9 5616.6 5620.7 5626.4 5633.5 5638.9 09:17:53 INFO - PID 3446 | 09:17:53 INFO - PID 3446 | [#1] ext.html Cycles:180 Average:30371.12 Median:30213.27 stddev:41289.29 (136.7%) stddev-sans-first:41344.77 09:17:53 INFO - PID 3446 | Values: 643.9 670.2 1032.4 1049.3 1119.5 31375.4 32269.4 32270.7 32316.5 32323.8 29602.9 29980.4 30007.0 30043.0 30058.5 6262.1 6363.7 6496.8 6865.3 6882.4 6928.5 6946.9 6947.7 6993.1 7037.7 6970.9 6977.4 7025.3 7035.2 7042.8 6984.9 7007.3 7025.3 7028.2 7034.5 6849.3 6891.0 6894.4 6894.6 6923.1 32296.7 32381.5 32419.8 32553.7 32591.2 3104.9 3114.4 3136.7 3138.5 3144.5 24657.4 24689.3 24708.6 24723.4 24850.0 2592.1 2614.6 2618.2 2631.6 2636.9 142666.0 143172.0 143190.0 143406.0 143733.3 37559.4 39758.0 40108.4 40199.4 41423.2 41399.6 41408.4 41696.0 43349.6 44076.8 12553.8 12754.4 12757.7 12816.7 12850.0 9966.2 10079.1 10104.7 10114.3 10145.9 12700.0 12745.4 12790.2 12835.3 13046.3 5282.7 5322.1 5365.5 5425.6 5505.9 872.1 893.4 896.7 896.7 926.6 20173.7 21409.5 21504.1 21526.7 21554.1 967.4 972.9 993.3 996.0 1005.8 11087.5 11244.8 11446.7 11500.4 11651.9 171821.0 173219.0 173625.0 173682.1 174080.0 39799.2 39846.0 39979.2 40041.0 40375.6 1185.3 1228.8 1229.6 1234.5 1234.8 20014.5 20508.8 20923.6 21134.4 21178.7 29429.7 32379.4 32918.3 32990.5 33049.7 160398.0 162151.0 163107.0 163325.0 163728.0 30111.8 30152.0 30274.5 30377.4 30507.2 35343.6 35416.3 35735.0 35747.5 35985.3 27449.6 27843.3 27934.9 27981.2 28827.0 26762.7 27259.2 27627.2 27650.0 28783.9 30709.4 30719.2 30919.8 30938.0 31100.5 26293.3 26674.9 26983.5 27306.0 27945.3 21699.1 22285.3 22789.9 23165.2 23180.7 09:17:53 INFO - PID 3446 | 09:17:53 INFO - PID 3446 | [#2] jquery.html Cycles:180 Average:25187.03 Median:203012.82 stddev:62123.95 (30.6%) stddev-sans-first:62270.37 09:17:53 INFO - PID 3446 | Values: 409.0 411.7 416.1 439.9 440.9 14201.9 17000.5 17552.5 17760.0 17963.4 18131.5 18312.2 18430.3 18551.0 18623.0 5335.8 5338.7 5428.2 5506.0 5573.6 5401.9 5430.5 5437.0 5439.5 5481.3 5260.0 5390.0 5434.2 5469.4 5501.4 5478.9 5517.6 5535.2 5537.9 5579.0 4976.3 4988.3 4992.7 5004.7 5013.5 20982.3 21326.3 21498.5 21552.2 21585.6 1525.4 1595.1 1610.5 1610.8 1634.2 14589.6 14645.1 14833.6 14945.7 15023.2 2087.7 2099.7 2142.2 2145.2 2175.5 86018.0 90327.5 90401.6 90401.6 91272.0 10790.8 10859.6 10883.4 11124.6 11150.2 15277.5 15297.6 15350.8 15387.8 32415.2 8902.6 9073.9 9085.1 9349.9 9352.1 7167.1 7229.9 7419.3 7476.7 7611.2 8778.4 9238.8 9303.4 9537.7 9605.2 3474.5 3532.5 3682.8 3749.8 3845.9 841.0 860.7 873.7 885.5 896.4 16570.3 16735.8 16848.7 16874.8 17292.5 873.7 884.8 886.4 890.5 903.1 9113.1 9133.6 9174.6 9399.7 9542.7 369193.0 369887.2 370854.0 379498.0 380620.0 73512.6 75570.2 75815.6 80132.2 80342.0 1025.1 1041.5 1063.3 1069.4 1072.5 14118.5 14278.5 14455.3 14474.1 15025.5 36626.3 36832.6 37182.3 37373.6 37878.4 43932.0 45160.3 45205.9 45601.3 45677.0 11301.9 11698.5 11853.5 11913.9 12121.8 12863.4 12906.8 12936.8 13072.1 13132.0 10639.3 10644.0 10707.8 11175.8 11216.4 9895.8 10117.3 10194.7 10205.7 10250.1 10837.5 10863.7 10938.8 11268.2 11379.0 11475.5 11572.5 11605.8 11627.6 12082.6 9659.8 9784.7 9956.9 10363.7 10723.2 09:17:53 INFO - PID 3446 | 09:17:53 INFO - PID 3446 | [#3] mootools.html Cycles:180 Average:6196.90 Median:3950.35 stddev:3855.34 (97.6%) stddev-sans-first:3848.05 09:17:53 INFO - PID 3446 | Values: 1225.4 1285.9 1287.4 1288.8 1292.4 9540.7 9857.6 10013.6 10026.9 10081.3 9891.5 10044.5 10063.0 10099.6 10105.2 2262.9 2293.2 2294.9 2305.1 2313.0 2194.3 2254.0 2272.5 2274.9 2275.5 2243.6 2251.8 2284.2 2298.3 2298.5 2198.5 2218.4 2257.3 2262.7 2266.2 1843.3 1902.9 2068.7 2097.3 2110.2 9969.8 9974.8 10068.8 10087.2 10097.1 5613.7 5869.1 5869.7 5873.8 5898.9 3241.4 3487.1 3496.2 3546.9 3572.9 1014.9 1032.8 1049.7 1072.2 1076.8 14377.5 14416.9 14493.8 14551.9 14557.3 4722.8 4732.1 4991.8 5039.1 5127.8 10395.8 10429.9 10444.9 10473.0 10495.5 5525.5 5549.5 5578.0 5580.4 5602.5 4969.2 4991.8 5157.1 5227.9 5319.1 3791.1 3905.6 3940.1 3957.8 4006.2 1077.9 1096.3 1101.6 1110.4 1111.9 716.5 736.1 747.2 749.9 758.2 5639.4 5789.9 6402.2 6672.0 6690.9 851.9 868.0 871.5 873.6 878.5 3890.2 3929.6 3949.6 3951.1 4025.9 12312.6 12511.9 12703.7 12748.9 12775.7 12516.2 12595.4 12621.8 12830.6 12955.9 7437.7 7453.2 7491.9 7513.5 7564.1 5999.4 6035.9 6059.6 6088.7 6110.8 11424.3 11522.2 11551.6 11630.4 11734.2 11667.9 11937.3 12055.6 12082.9 12089.5 7289.5 7550.9 7554.2 7561.3 7562.0 9329.3 9348.8 9427.5 9468.2 9485.3 7688.7 7720.8 7790.2 7817.9 8044.1 7923.7 7931.3 7983.9 8003.0 8047.9 6742.3 6871.0 6877.8 6879.6 6881.0 5476.3 5490.6 5536.1 5588.2 5714.3 5384.0 5483.8 5516.8 5576.0 5669.3 09:17:53 INFO - PID 3446 | 09:17:53 INFO - PID 3446 | [#4] prototype.html Cycles:180 Average:4795.75 Median:5474.93 stddev:1432.57 (26.2%) stddev-sans-first:1397.66 09:17:53 INFO - PID 3446 | Values: 376.3 402.6 404.4 407.1 408.6 5465.2 5565.7 5629.7 5631.3 5648.5 5378.4 5434.7 5472.2 5477.7 5483.7 4114.8 4115.2 4124.6 4131.5 4135.4 4060.2 4085.3 4120.8 4125.2 4132.9 4081.7 4083.3 4083.7 4088.9 4095.2 4073.3 4080.2 4090.8 4093.1 4099.6 3577.4 3580.6 3589.3 3590.2 3595.3 5267.3 5322.5 5346.1 5385.2 5398.5 4806.6 4817.2 4821.1 4823.6 4833.6 5505.4 5797.3 5803.2 5834.3 5835.4 3950.4 3981.7 3988.4 3991.0 3996.8 5966.2 6129.9 6163.3 6190.3 6199.6 4050.7 4085.1 4089.8 4095.2 4097.3 4128.7 4147.4 4153.6 4161.3 4166.5 4738.4 4791.3 4808.2 4821.8 4825.9 5804.1 5807.1 5813.5 5825.5 5851.0 1417.2 1433.7 1435.8 1436.4 1437.2 940.4 947.2 951.2 958.3 970.1 5018.9 5031.1 5032.9 5037.4 5052.3 5981.7 6034.2 6075.0 6075.4 6083.7 4946.6 4957.9 4969.3 5013.3 5051.4 3158.7 3219.4 3219.5 3232.5 3235.3 5356.9 5519.7 5547.6 5547.9 5571.7 6106.6 6205.3 6209.9 6237.3 6237.5 5569.0 5574.1 5581.8 5589.8 5590.0 5801.6 5991.8 6078.4 6093.8 6137.8 5970.5 5980.5 5983.4 5997.9 6017.2 5371.7 5516.3 5520.6 5559.3 5584.9 4549.0 4564.8 4567.4 4568.1 4591.9 5974.2 6069.3 6092.0 6102.5 6142.3 5885.9 5892.7 5893.6 5898.5 5901.5 5837.3 5843.8 5855.3 5874.4 5883.3 5662.9 5766.5 5788.2 5795.5 5814.0 5940.6 5950.5 5954.4 5962.6 5963.8 5596.6 5728.3 5783.9 5791.1 5792.4 09:17:53 INFO - PID 3446 | 09:17:53 INFO - PID 3446 | [#5] yui.html Cycles:180 Average:14998.45 Median:3529.89 stddev:17599.96 (498.6%) stddev-sans-first:17616.79 09:17:53 INFO - PID 3446 | Values: 745.5 755.6 764.4 772.9 786.7 12394.6 13021.7 13297.8 14194.6 14267.0 14438.8 15100.4 15122.9 15149.1 15187.8 823.6 840.6 844.4 844.6 850.5 902.6 904.3 906.9 910.9 912.1 932.8 939.5 940.6 947.7 951.7 941.1 943.8 945.4 948.5 948.8 690.1 693.6 696.9 697.1 698.2 12853.6 12969.9 13209.7 13659.5 13874.9 15452.8 15580.6 15608.5 15749.4 15943.6 11786.9 12198.6 12338.3 12520.1 12536.1 2992.7 2992.9 3007.0 3007.3 3008.5 64174.0 65059.3 65138.0 65664.0 66366.0 12329.1 12688.4 12743.5 12779.1 12855.3 21948.1 22334.7 22344.8 22676.7 22876.8 5825.6 5886.3 5907.8 5912.6 6701.6 3093.9 3146.0 3161.4 3167.8 3180.1 3448.0 3491.5 3529.3 3530.4 3646.9 753.4 762.0 771.1 777.5 779.7 583.6 605.0 614.5 627.9 638.6 9513.2 9715.0 9771.8 9938.1 9987.9 610.9 625.6 627.9 629.4 632.3 4385.2 4436.4 4477.1 4518.6 4537.3 63760.7 64154.0 64365.4 66671.0 67174.7 55035.7 55272.4 55413.0 55629.7 56556.7 51319.0 51679.5 51832.5 52039.7 52109.2 9194.2 9303.8 9334.0 9426.8 9638.0 26330.2 26415.0 26529.2 26708.0 27357.9 31481.2 31834.7 32146.0 32322.4 32407.4 11970.3 12118.4 12261.8 12395.6 12452.7 15012.5 15278.9 15624.2 15892.0 15968.4 13592.5 13803.9 14363.9 14476.1 14573.7 15092.8 15206.0 15295.4 15301.6 15557.1 13160.3 13227.3 13716.7 13788.9 13935.9 9764.3 9993.3 10145.5 10246.1 10546.8 10693.8 11150.6 11181.6 11201.7 11415.5 09:17:53 INFO - PID 3446 | -------- Summary: end -------- 09:17:53 INFO - PID 3446 | 09:17:54 INFO - TEST-INFO | 3446: exit 0 09:17:54 INFO - TEST-OK | dromaeo_css | took 1121254ms 09:17:54 INFO - TEST-START | kraken 09:17:54 INFO - operating with platform_type : linux_ 09:17:54 INFO - Initialising browser for kraken test... 09:17:54 INFO - TEST-INFO | started process 3829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUWV3xp/profile http://localhost:52683/getInfo.html) 09:17:58 INFO - PID 3829 | __metrics Screen width/height:1600/1200 09:17:58 INFO - PID 3829 | colorDepth:24 09:17:58 INFO - PID 3829 | Browser inner width/height: 1024/695 09:17:58 INFO - PID 3829 | __metrics 09:18:01 INFO - TEST-INFO | 3829: exit 0 09:18:01 INFO - Browser initialized. 09:18:01 INFO - Running cycle 1/1 for kraken test... 09:18:01 INFO - TEST-INFO | started process 3963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUWV3xp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:13 INFO - PID 3963 | RSS: Main: 160440320 09:18:13 INFO - PID 3963 | 09:18:15 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52683/tests/kraken/driver.html?testName=audio-beat-detection) 09:18:16 INFO - PID 3963 | RSS: Main: 165572608 09:18:16 INFO - PID 3963 | 09:18:19 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52683/tests/kraken/driver.html?testName=audio-dft) 09:18:19 INFO - PID 3963 | RSS: Main: 164868096 09:18:19 INFO - PID 3963 | 09:18:22 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52683/tests/kraken/driver.html?testName=audio-fft) 09:18:23 INFO - PID 3963 | RSS: Main: 161239040 09:18:23 INFO - PID 3963 | 09:18:25 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52683/tests/kraken/driver.html?testName=audio-oscillator) 09:18:26 INFO - PID 3963 | RSS: Main: 161222656 09:18:26 INFO - PID 3963 | 09:18:28 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52683/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:18:28 INFO - PID 3963 | RSS: Main: 162045952 09:18:28 INFO - PID 3963 | 09:18:32 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52683/tests/kraken/driver.html?testName=imaging-darkroom) 09:18:32 INFO - PID 3963 | RSS: Main: 167190528 09:18:32 INFO - PID 3963 | 09:18:36 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52683/tests/kraken/driver.html?testName=imaging-desaturate) 09:18:36 INFO - PID 3963 | RSS: Main: 164745216 09:18:36 INFO - PID 3963 | 09:18:39 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52683/tests/kraken/driver.html?testName=json-parse-financial) 09:18:40 INFO - PID 3963 | RSS: Main: 166137856 09:18:40 INFO - PID 3963 | 09:18:42 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52683/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:18:42 INFO - PID 3963 | RSS: Main: 166322176 09:18:42 INFO - PID 3963 | 09:18:44 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52683/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:18:45 INFO - PID 3963 | RSS: Main: 166076416 09:18:45 INFO - PID 3963 | 09:18:47 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52683/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:18:47 INFO - PID 3963 | RSS: Main: 165986304 09:18:47 INFO - PID 3963 | 09:18:50 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:18:51 INFO - PID 3963 | RSS: Main: 166412288 09:18:51 INFO - PID 3963 | 09:18:54 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:18:55 INFO - PID 3963 | RSS: Main: 166825984 09:18:55 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | Cycle 1(1): loaded http://localhost:52683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52683/tests/kraken/driver.html?testName=ai-astar) 09:18:57 INFO - PID 3963 | RSS: Main: 168443904 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | __start_tp_report 09:18:57 INFO - PID 3963 | _x_x_mozilla_page_load 09:18:57 INFO - PID 3963 | _x_x_mozilla_page_load_details 09:18:57 INFO - PID 3963 | |i|pagename|runs| 09:18:57 INFO - PID 3963 | |0;ai-astar;110;113;120;111;112;112;113;113;113;113 09:18:57 INFO - PID 3963 | |1;audio-beat-detection;149;128;123;163;123;124;128;130;143;128 09:18:57 INFO - PID 3963 | |2;audio-dft;162;164;161;165;169;175;167;163;164;163 09:18:57 INFO - PID 3963 | |3;audio-fft;75;75;75;109;75;77;80;77;101;77 09:18:57 INFO - PID 3963 | |4;audio-oscillator;86;84;113;83;83;83;98;83;83;101 09:18:57 INFO - PID 3963 | |5;imaging-gaussian-blur;114;113;116;114;114;114;113;119;118;114 09:18:57 INFO - PID 3963 | |6;imaging-darkroom;153;150;150;150;150;151;151;151;150;153 09:18:57 INFO - PID 3963 | |7;imaging-desaturate;94;95;94;95;95;94;95;95;95;94 09:18:57 INFO - PID 3963 | |8;json-parse-financial;54;53;53;52;54;54;57;54;54;56 09:18:57 INFO - PID 3963 | |9;json-stringify-tinderbox;57;56;56;56;57;56;57;57;57;56 09:18:57 INFO - PID 3963 | |10;stanford-crypto-aes;83;83;83;82;81;83;92;91;81;83 09:18:57 INFO - PID 3963 | |11;stanford-crypto-ccm;143;134;132;145;133;141;139;145;184;141 09:18:57 INFO - PID 3963 | |12;stanford-crypto-pbkdf2;187;202;198;204;193;206;208;189;199;195 09:18:57 INFO - PID 3963 | |13;stanford-crypto-sha256-iterative;73;73;75;73;72;74;72;71;73;71 09:18:57 INFO - PID 3963 | __end_tp_report 09:18:57 INFO - PID 3963 | __start_cc_report 09:18:57 INFO - PID 3963 | _x_x_mozilla_cycle_collect,828 09:18:57 INFO - PID 3963 | __end_cc_report 09:18:57 INFO - PID 3963 | __startTimestamp1493828337300__endTimestamp 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | ------- Summary: start ------- 09:18:57 INFO - PID 3963 | Number of tests: 14 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:2.67 (2.4%) stddev-sans-first:2.60 09:18:57 INFO - PID 3963 | Values: 110.0 113.0 120.0 111.0 112.0 112.0 113.0 113.0 113.0 113.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:129.00 stddev:13.39 (10.4%) stddev-sans-first:13.04 09:18:57 INFO - PID 3963 | Values: 149.0 128.0 123.0 163.0 123.0 124.0 128.0 130.0 143.0 128.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:4.14 (2.5%) stddev-sans-first:4.21 09:18:57 INFO - PID 3963 | Values: 162.0 164.0 161.0 165.0 169.0 175.0 167.0 163.0 164.0 163.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:12.31 (16.2%) stddev-sans-first:12.79 09:18:57 INFO - PID 3963 | Values: 75.0 75.0 75.0 109.0 75.0 77.0 80.0 77.0 101.0 77.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:83.00 stddev:10.59 (12.8%) stddev-sans-first:11.15 09:18:57 INFO - PID 3963 | Values: 86.0 84.0 113.0 83.0 83.0 83.0 98.0 83.0 83.0 101.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.00 stddev:2.08 (1.8%) stddev-sans-first:2.18 09:18:57 INFO - PID 3963 | Values: 114.0 113.0 116.0 114.0 114.0 114.0 113.0 119.0 118.0 114.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:1.20 (0.8%) stddev-sans-first:1.00 09:18:57 INFO - PID 3963 | Values: 153.0 150.0 150.0 150.0 150.0 151.0 151.0 151.0 150.0 153.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:18:57 INFO - PID 3963 | Values: 94.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.45 (2.7%) stddev-sans-first:1.54 09:18:57 INFO - PID 3963 | Values: 54.0 53.0 53.0 52.0 54.0 54.0 57.0 54.0 54.0 56.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:57.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 09:18:57 INFO - PID 3963 | Values: 57.0 56.0 56.0 56.0 57.0 56.0 57.0 57.0 57.0 56.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.00 stddev:3.94 (4.7%) stddev-sans-first:4.15 09:18:57 INFO - PID 3963 | Values: 83.0 83.0 83.0 82.0 81.0 83.0 92.0 91.0 81.0 83.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:142.00 stddev:14.94 (10.5%) stddev-sans-first:15.85 09:18:57 INFO - PID 3963 | Values: 143.0 134.0 132.0 145.0 133.0 141.0 139.0 145.0 184.0 141.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.10 Median:200.50 stddev:7.09 (3.5%) stddev-sans-first:6.28 09:18:57 INFO - PID 3963 | Values: 187.0 202.0 198.0 204.0 193.0 206.0 208.0 189.0 199.0 195.0 09:18:57 INFO - PID 3963 | 09:18:57 INFO - PID 3963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:1.25 (1.7%) stddev-sans-first:1.32 09:18:57 INFO - PID 3963 | Values: 73.0 73.0 75.0 73.0 72.0 74.0 72.0 71.0 73.0 71.0 09:18:57 INFO - PID 3963 | -------- Summary: end -------- 09:18:57 INFO - PID 3963 | 09:18:58 INFO - TEST-INFO | 3963: exit 0 09:18:58 INFO - TEST-OK | kraken | took 63934ms 09:18:58 INFO - SUITE-END | took 1185s 09:18:58 INFO - Completed test suite (00:19:45) 09:18:58 INFO - javascript benchmark 09:18:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6787.532773184738, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2703.094463354776, 2704.1887433769866, 2714.389262415956, 2742.5200589896763, 2743.286745446184, 5264.39459462161, 5291.4973077557615, 5299.947000529994, 5323.866903327419, 5394.811181608639, 5295.31160949077, 5302.0, 5397.919031214525, 5433.565314774818, 5435.2934118564535, 4479.776011199443, 4714.4106986626675, 4762.428508578975, 4795.23276275796, 4816.54242846929, 4854.150523658363, 4882.97558512207, 4887.0225954809, 4901.411830580335, 4922.286268491084, 4699.201135806921, 4718.41019872516, 4751.097291514601, 4828.155072862271, 4841.394825646794, 4794.5205479452125, 4807.326974223612, 4814.7833347499445, 4855.126077306083, 4873.707577545359, 4738.194506933795, 4767.809287628491, 4768.213244814601, 4780.354652121954, 4811.711297322172, 5250.81622143227, 5331.680099194061, 5357.705326207057, 5414.64550621086, 5458.044842152647, 5746.913796293017, 5750.683712395817, 5755.712214389306, 5756.251687280668, 5764.135379693038, 5778.0, 5782.537397008229, 5789.2763404574425, 5793.391693872125, 5794.710264486759, 5329.440408757102, 5377.758000889891, 5379.569634429236, 5384.111621582473, 5385.246065550787, 5823.88352232953, 5865.120231965239, 5880.117982302689, 5892.6759028253, 5904.0553511437965, 5663.292088488939, 5672.347680016851, 5702.344230413555, 5788.594798364074, 5810.622309549865, 5834.504067154255, 5845.766169353264, 5869.0, 5871.089981052944, 5909.8227053188475, 5777.0, 5811.3316968548315, 5815.476607105381, 5818.359980402152, 5823.330317013598, 5634.098544232903, 5779.682117483495, 5786.276715410574, 5793.159991801165, 5793.333766616893, 4805.687630304019, 4831.371921650233, 4846.7818948147415, 4848.3454733610515, 4850.345203397566, 4172.874813755592, 4176.1230141670585, 4205.306124489486, 4212.473440819897, 4216.789160541961, 4907.60739140875, 4923.310736496894, 4946.431160416598, 4969.403671559364, 4979.4771548987555, 5867.882642347129, 5868.0, 5870.471657550841, 5890.234269545017, 5892.911606325909, 4802.063597598435, 4873.366462359871, 4912.238603016538, 4922.384701912261, 4926.630502712311, 5212.50481204285, 5238.0, 5240.0, 5245.895082098336, 5270.472952704698, 5340.385855626652, 5368.060589396762, 5368.489993450616, 5375.220593013991, 5379.811706590251, 5722.055860783091, 5806.796762113306, 5878.793890101272, 5894.263217097863, 5952.0179170436395, 5354.116570765936, 5361.088614935392, 5432.809851655173, 5448.0465918463315, 5453.209284653783, 5683.403242659461, 5685.914711279252, 5723.198752174782, 5726.370099288992, 5727.6849773262875, 5738.426157384228, 5808.070708686759, 5825.563082768725, 5827.825165245049, 5884.382139875252, 5535.418781027934, 5596.636218645775, 5599.832005039855, 5601.831945041656, 5603.3836278008575, 5511.889762204813, 5516.558675306046, 5538.280023597068, 5540.753330500605, 5550.973069982067, 5497.36780270274, 5509.889802203853, 5522.475364840334, 5547.972260138674, 5551.056320425457, 5641.633293835887, 5691.800786972436, 5725.341585717696, 5789.2763404574425, 5791.8552036199435, 5616.606837521498, 5620.690862002629, 5626.43735626434, 5633.549316054788, 5638.88722225545], "value": 5250.678751900142, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.8776632439836, 670.175683908792, 1032.3908893752684, 1049.2602715085866, 1119.4738472917725, 31375.372492550163, 32269.35461290776, 32270.67729322706, 32316.515252271205, 32323.838380808123, 29602.851985740093, 29980.40039199215, 30007.0, 30043.0, 30058.549121763135, 6262.12330273762, 6363.681815909197, 6496.837579060538, 6865.313468653119, 6882.414994725455, 6928.480363972697, 6946.930530694704, 6947.652617369136, 6993.125859267591, 7037.718491260343, 6970.895436568456, 6977.441804655616, 7025.26234745352, 7035.226125126232, 7042.7887163385185, 6984.860302793915, 7007.264237255091, 7025.332593403618, 7028.226895041541, 7034.542754720952, 6849.2808255132995, 6891.0, 6894.413974812147, 6894.620795856226, 6923.099997000358, 32296.677033229604, 32381.51427728586, 32419.83790081058, 32553.6744632553, 32591.185220369443, 3104.891328803481, 3114.4394009078355, 3136.6549679535233, 3138.497840345534, 3144.5126005469187, 24657.38356541083, 24689.25932222036, 24708.629370559454, 24723.38191545208, 24850.0, 2592.1445922845414, 2614.555525560659, 2618.1752747884357, 2631.63157157998, 2636.93407664808, 142666.0, 143172.0, 143190.0, 143406.0, 143733.28133359266, 37559.436608450895, 39758.0, 40108.398374024415, 40199.397009044886, 41423.1715365691, 41399.58600413957, 41408.378874316906, 41696.0, 43349.566504335184, 44076.77961610236, 12553.811692824433, 12754.36228188587, 12757.744845103047, 12816.743665126645, 12850.0, 9966.20270378368, 10079.143272821746, 10104.74738131538, 10114.342567733074, 10145.94927025375, 12699.99950015742, 12745.36273186337, 12790.232586044867, 12835.294058826667, 13046.260285340184, 5282.732144285421, 5322.148456246982, 5365.54392876602, 5425.6202065855805, 5505.889882202334, 872.1017352127319, 893.3523195683208, 896.7309807057857, 896.7354630384052, 926.592299388267, 20173.6973945388, 21409.464763381042, 21504.129256733937, 21526.6770998432, 21554.13783448676, 967.385710074108, 972.8881178664402, 993.3295025857517, 995.9751006224758, 1005.8340373838234, 11087.50106245221, 11244.775104497865, 11446.740858505558, 11500.424978751196, 11651.88348116508, 171821.0, 173219.0, 173625.0, 173682.13158934124, 174080.0, 39799.2040159201, 39846.0, 39979.200415991516, 40041.0, 40375.59624403777, 1185.2991736020194, 1228.8402507673945, 1229.6126720083146, 1234.481517762542, 1234.8332975048254, 20014.49963750918, 20508.79491205069, 20923.58152836965, 21134.42190498364, 21178.682319765525, 29429.705702942698, 32379.35241295208, 32918.341633166725, 32990.50514242336, 33049.669503304656, 160398.0, 162151.0, 163107.0, 163325.0, 163728.0, 30111.849440752656, 30152.0, 30274.54588181223, 30377.39245215039, 30507.2373190672, 35343.646563534036, 35416.291674165856, 35735.0, 35747.46378804268, 35985.280294393444, 27449.588256175775, 27843.303917402227, 27934.927158012197, 27981.160565183076, 28827.0, 26762.661866906186, 27259.182224533295, 27627.165246081455, 27650.0, 28783.856080719463, 30709.38581228318, 30719.232019198804, 30919.84540077285, 30938.0, 31100.533491997187, 26293.34266643349, 26674.866625666746, 26983.46033079288, 27306.044288450605, 27945.301367465163, 21699.132034718434, 22285.331440056823, 22789.88605056964, 23165.189218377276, 23180.652290215323], "value": 14465.686793874254, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.96728261739065, 411.6644934378483, 416.11575402270165, 439.9164158809826, 440.9470863496381, 14201.92899035506, 17000.489985300428, 17552.473425797216, 17760.0, 17963.371282005133, 18131.456056318297, 18312.175952082154, 18430.262789488403, 18551.0, 18623.0, 5335.7865685372535, 5338.652987555816, 5428.185772134192, 5506.0089183946875, 5573.6098473106895, 5401.891962160755, 5430.456954304557, 5436.972815135919, 5439.5376393006645, 5481.260029895972, 5259.973700131494, 5389.973050134763, 5434.184872269171, 5469.371022332423, 5501.4223506531835, 5478.890422191574, 5517.586181036419, 5535.197396377543, 5537.861553461175, 5578.972105139448, 4976.303317535548, 4988.276699878497, 4992.700437973734, 5004.699718016895, 5013.548780609763, 20982.2656207032, 21326.253581124587, 21498.462538436506, 21552.245671401583, 21585.56828863414, 1525.3822202008205, 1595.0748565831789, 1610.484644913628, 1610.7503336982786, 1634.2155765232756, 14589.562313130624, 14645.121292722471, 14833.554993350217, 14945.70108597822, 15023.248837558187, 2087.7285952826187, 2099.6745504446835, 2142.153849229546, 2145.1955516681246, 2175.4670105824175, 86018.0, 90327.54836225843, 90401.64397534043, 90401.64397534108, 91272.0, 10790.78418431627, 10859.619913303155, 10883.401412922365, 11124.555017799197, 11150.219484635998, 15277.541673749805, 15297.617559560877, 15350.769738453931, 15387.768978481694, 32415.189620259684, 8902.59938302765, 9073.909260907307, 9085.13691199335, 9349.90650093504, 9352.111549402796, 7167.104111986002, 7229.891551626624, 7419.332260096618, 7476.738314158978, 7611.20082391352, 8778.37600043994, 9238.815223695623, 9303.441793492411, 9537.666181683608, 9605.18355939739, 3474.4614584739406, 3532.4877892705927, 3682.7606205597085, 3749.7937613430977, 3845.9038524036564, 840.9537475438788, 860.7046395175221, 873.6854732296368, 885.5395194498825, 896.3501461440403, 16570.254338554794, 16735.83264167367, 16848.74726879098, 16874.83125168757, 17292.481225563253, 873.7204094689638, 884.7699598104539, 886.4326830828275, 890.5013192612158, 903.074348792493, 9113.134252246025, 9133.634654613874, 9174.587143578421, 9399.671011514563, 9542.666006689733, 369193.0, 369887.1505642508, 370854.0, 379498.0, 380620.0, 73512.63243683748, 75570.24429755632, 75815.62092189614, 80132.19867801364, 80342.0, 1025.1183981775666, 1041.4688508860384, 1063.2557209953063, 1069.4332004037872, 1072.5120070367964, 14118.50585229512, 14278.500252491112, 14455.277236138361, 14474.059186152866, 15025.474108406153, 36626.26747464982, 36832.63167368292, 37182.256354873294, 37373.62626373702, 37878.43182352322, 43932.0, 45160.32259516176, 45205.869853253935, 45601.31598026099, 45677.0, 11301.886981130083, 11698.4735686896, 11853.525858965544, 11913.940430297793, 12121.757564848478, 12863.421146048637, 12906.80639790385, 12936.805947910601, 13072.084954053125, 13132.015098867432, 10639.308444951053, 10644.0, 10707.839382409114, 11175.776484470427, 11216.383098929637, 9895.802083958424, 10117.342372745748, 10194.694159175237, 10205.693829185137, 10250.077493025663, 10837.512311945824, 10863.728406789893, 10938.835917461403, 11268.211225214156, 11379.0, 11475.48360323804, 11572.537098515964, 11605.76788464243, 11627.59303424376, 12082.637520874388, 9659.758506037124, 9784.657536986457, 9956.900430995598, 10363.689089327332, 10723.24937254416], "value": 9212.729341047996, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.3505642009734, 1285.922844629323, 1287.41422652693, 1288.780907245768, 1292.399034448981, 9540.666076687317, 9857.556409961551, 10013.599456021759, 10026.899731002688, 10081.344712593676, 9891.455969921652, 10044.497775111251, 10063.04401081898, 10099.646512372068, 10105.191584673226, 2262.8642281463126, 2293.20884294918, 2294.8623082615013, 2305.13557415969, 2313.0400883633274, 2194.2868567715477, 2253.954920901581, 2272.4773302140516, 2274.931752047441, 2275.4993901341677, 2243.573720993006, 2251.819854411643, 2284.2233640562204, 2298.3449716830705, 2298.5058212484314, 2198.527316626925, 2218.3899427657525, 2257.322803159054, 2262.7284725833006, 2266.218154736613, 1843.3087592152942, 1902.914368853405, 2068.6896965455153, 2097.2869224463757, 2110.2192188890053, 9969.800603987953, 9974.750631234278, 10068.798624027551, 10087.243456740774, 10097.091261786401, 5613.719314034322, 5869.090291004858, 5869.735861886225, 5873.823785286449, 5898.882022359572, 3241.4003409369343, 3487.093355727504, 3496.1609213788506, 3546.8935931922083, 3572.910677233064, 1014.9492525373702, 1032.82441984862, 1049.7375656085978, 1072.1637123044038, 1076.8330908709163, 14377.496787612383, 14416.92791536046, 14493.782593261216, 14551.927240363837, 14557.272136393138, 4722.811087556528, 4732.100900828831, 4991.775370108354, 5039.092963266574, 5127.769250383742, 10395.84406233907, 10429.9478502607, 10444.947775261075, 10473.005064518858, 10495.527701253463, 5525.502704756591, 5549.500544950974, 5577.972110139423, 5580.386157522669, 5602.495775380154, 4969.180085285887, 4991.825286114969, 5157.123289040797, 5227.947720522746, 5319.0957537218765, 3791.109089363997, 3905.5899130591447, 3940.113474468279, 3957.8021098945514, 4006.23881462527, 1077.8975997280245, 1096.276457538021, 1101.6284725516623, 1110.4170310587006, 1111.8721347045032, 716.4733920568378, 736.14607055815, 747.1855677311756, 749.9362554182846, 758.1811643425087, 5639.379668236491, 5789.8552536186935, 6402.231732192074, 6671.966640166866, 6690.899636505456, 851.9020312664, 867.9566021698889, 871.4684042733927, 873.5850471026212, 878.4509681449094, 3890.2025084857537, 3929.5677475477673, 3949.565547789741, 3951.130751234724, 4025.8590949316635, 12312.569060082855, 12511.93744031274, 12703.68240793969, 12748.93625531885, 12775.744485110432, 12516.186447880858, 12595.433205505775, 12621.810672839914, 12830.55093071738, 12955.870441295654, 7437.739679111205, 7453.217412171861, 7491.8501629967095, 7513.511621744569, 7564.054493188351, 5999.400059993965, 6035.879282414415, 6059.6364218147055, 6088.726007329769, 6110.769569107333, 11424.314541127558, 11522.193446458667, 11551.595694150665, 11630.360330181922, 11734.237274577124, 11667.883321166679, 11937.28376297425, 12055.638330850088, 12082.879171208175, 12089.455974481345, 7289.5261807982315, 7550.924490755022, 7554.244575542401, 7561.3194812467145, 7561.962190189014, 9329.346945713734, 9348.766280843034, 9427.528623568931, 9468.195203407788, 9485.288603354638, 7688.730894418669, 7720.7683769487, 7790.220977902164, 7817.882731759142, 8044.115147333906, 7923.7226697065325, 7931.286184243215, 7983.92016079855, 8003.0, 8047.879281810895, 6742.325767423218, 6871.03805467225, 6877.828054298682, 6879.552829066095, 6880.965595171992, 5476.315460567429, 5490.615656904138, 5536.086545719912, 5588.217649528988, 5714.314282286152, 5384.0, 5483.835484935458, 5516.834494965157, 5576.024195765806, 5669.3480249770155], "value": 4728.246288536021, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.2850583890609, 402.5551765299346, 404.44187021909767, 407.09277037081256, 408.6077365728899, 5465.207544905987, 5565.747706765981, 5629.690367029812, 5631.267935168427, 5648.519875810561, 5378.408375078739, 5434.701091439969, 5472.179173124034, 5477.67133971962, 5483.698396588186, 4114.753114813113, 4115.176964607075, 4124.566920473352, 4131.52487463941, 4135.421041054255, 4060.2082593894056, 4085.2646523625735, 4120.793960301988, 4125.174965006996, 4132.925439385766, 4081.693872959525, 4083.305838007546, 4083.7141400102005, 4088.897777555555, 4095.2219078375015, 4073.3279008963486, 4080.204360149757, 4090.836366545335, 4093.1199792044554, 4099.626625080602, 3577.3918433866306, 3580.5703315602295, 3589.335972845032, 3590.1922067534597, 3595.2629710909464, 5267.26258323835, 5322.547583455411, 5346.064438723208, 5385.192221166817, 5398.541124004464, 4806.639502037361, 4817.156997525419, 4821.108095002436, 4823.638227132979, 4833.63747718919, 5505.366882808488, 5797.304323481167, 5803.158542011384, 5834.3290521589715, 5835.387284335126, 3950.4271880577157, 3981.7013723970817, 3988.3618621020496, 3990.984552800846, 3996.800159991989, 5966.194563733884, 6129.938700613026, 6163.291221509494, 6190.2571691397325, 6199.628022318675, 4050.6556942659613, 4085.1216988347646, 4089.7730680795644, 4095.1809638072505, 4097.258665067335, 4128.669706423539, 4147.398627199039, 4153.605407486284, 4161.313383291723, 4166.520850102216, 4738.360321356573, 4791.305260737243, 4808.230683090689, 4821.807127714922, 4825.855224343275, 5804.1293805929445, 5807.070868660994, 5813.476787089097, 5825.475707186373, 5851.0, 1417.1992824054375, 1433.7347590695754, 1435.777454494555, 1436.4182506085053, 1437.173625165534, 940.4404379394249, 947.15229869268, 951.1772316945792, 958.3148049144895, 970.1365784451843, 5018.874528136753, 5031.094403007421, 5032.899342013139, 5037.370328708911, 5052.267421223902, 5981.6710080945095, 6034.185384972972, 6074.967255566476, 6075.362086980892, 6083.726232319556, 4946.579540739078, 4957.851264462072, 4969.27945447908, 5013.348264725635, 5051.419086804991, 3158.7315078218608, 3219.4205043092, 3219.500977348515, 3232.5312829640043, 3235.288236587947, 5356.866078348073, 5519.69641669704, 5547.611667183259, 5547.890421915633, 5571.693556854412, 6106.603070800384, 6205.28639206488, 6209.875802484015, 6237.282712488031, 6237.4698150656795, 5569.0, 5574.108142697149, 5581.804636837691, 5589.770250544792, 5590.021746194318, 5801.564882633904, 5991.771686804282, 6078.358843112246, 6093.817185484442, 6137.7851775187655, 5970.492508136857, 5980.5215582754145, 5983.431574000463, 5997.860406522746, 6017.18767966319, 5371.731413429391, 5516.255305533701, 5520.585956053232, 5559.27729395176, 5584.888302234014, 4548.976480291908, 4564.8131485813265, 4567.4242386376645, 4568.109218702321, 4591.908161836812, 5974.163617093697, 6069.33237343883, 6091.969540152448, 6102.511799056154, 6142.293636231711, 5885.941140588539, 5892.705364731832, 5893.5874488785375, 5898.528117750656, 5901.527877769854, 5837.299524056971, 5843.795467158629, 5855.2973643163095, 5874.353821079763, 5883.264591926009, 5662.886742265214, 5766.538676905753, 5788.21859049023, 5795.536357091339, 5814.0, 5940.584159108821, 5950.494207992369, 5954.404559544011, 5962.642241465526, 5963.821085367446, 5596.608237423504, 5728.312602487562, 5783.884322313446, 5791.131330300489, 5792.362840087502], "value": 4355.294349770633, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.5079647432689, 755.6448469219466, 764.3961270596226, 772.9111152217494, 786.6578038553228, 12394.566190183345, 13021.674458138552, 13297.800532992002, 14194.645133871645, 14267.0, 14438.783418248735, 15100.395984160648, 15122.924385378057, 15149.091054536735, 15187.772183417257, 823.5799742131526, 840.5503055865113, 844.4004756622775, 844.6283635200492, 850.4727069217095, 902.5712786426428, 904.2720609909021, 906.8730377747121, 910.9180173784358, 912.115248209236, 932.7668082979255, 939.5255396025032, 940.6096469964956, 947.673052796784, 951.7192428233687, 941.087145468894, 943.8018016216603, 945.3902233059638, 948.4972964328916, 948.8386974214366, 690.147667630476, 693.5630552751785, 696.8780463418882, 697.1285892634207, 698.155232169076, 12853.614391568175, 12969.935150324281, 13209.669758256025, 13659.521916732867, 13874.93062534691, 15452.845471545254, 15580.61048473786, 15608.531744047697, 15749.448769293134, 15943.601409964844, 11786.941065294704, 12198.57304994321, 12338.259704417675, 12520.06099542538, 12536.059795515283, 2992.655844577858, 2992.9102126936227, 3006.9849650751607, 3007.3083190866005, 3008.458477474054, 64174.0, 65059.34940650628, 65138.0, 65664.01503977492, 66366.0, 12329.136960412865, 12688.429020694091, 12743.49026038948, 12779.105462617528, 12855.29295888735, 21948.122075117135, 22334.664980025314, 22344.77655223427, 22676.65985010226, 22876.771232287796, 5825.621334613236, 5886.293644762656, 5907.793227237112, 5912.615679980788, 6701.564398314094, 3093.8917137900066, 3145.9528107078413, 3161.4151381994407, 3167.7782555220915, 3180.109569320594, 3447.9827600861836, 3491.4937334086417, 3529.347070791912, 3530.435130379127, 3646.908827279286, 753.3709352690455, 762.0436352377731, 771.1286246541372, 777.5490215674895, 779.6764342797676, 583.6118980877669, 604.9909251361233, 614.4838335797862, 627.9372062793684, 638.6295948349946, 9513.238940884712, 9714.951425242829, 9771.755706107404, 9938.10557049869, 9987.850182247272, 610.914471973924, 625.6058683029753, 627.8681476889813, 629.3894921925724, 632.2697284636253, 4385.166818304512, 4436.401085853433, 4477.082198149372, 4518.615917646971, 4537.274036154199, 63760.68119659372, 64154.0, 64365.35634643687, 66671.0, 67174.66412668003, 55035.72482137644, 55272.447275527535, 55413.0, 55629.72185139048, 56556.71721641366, 51319.0, 51679.48320516747, 51832.48167518352, 52039.73980130075, 52109.218361724605, 9194.17252447283, 9303.813923721624, 9333.953330233306, 9426.811463770824, 9638.0, 26330.21009369722, 26415.0, 26529.204123876316, 26708.0, 27357.86321068382, 31481.21296967594, 31834.681653183172, 32146.0, 32322.35355292834, 32407.351852963282, 11970.281783092694, 12118.394080296126, 12261.754764904474, 12395.566155184526, 12452.68868278264, 15012.549623511311, 15278.923605381902, 15624.21878906073, 15892.046477211405, 15968.361265549247, 13592.524261650795, 13803.861961380258, 14363.856361436252, 14476.059056161315, 14573.708525829636, 15092.773608395662, 15206.011609245365, 15295.388184472497, 15301.617459563155, 15557.14435706047, 13160.276184809545, 13227.3386330685, 13716.725665486834, 13788.862111378758, 13935.93032034874, 9764.267679924176, 9993.300468967103, 10145.492725363554, 10246.129079028366, 10546.789064218827, 10693.839592406275, 11150.645338117565, 11181.552737890393, 11201.719957000814, 11415.486303116546], "value": 6785.466096412887, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 120.0, 111.0, 112.0, 112.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 128.0, 123.0, 163.0, 123.0, 124.0, 128.0, 130.0, 143.0, 128.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 165.0, 169.0, 175.0, 167.0, 163.0, 164.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 109.0, 75.0, 77.0, 80.0, 77.0, 101.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 113.0, 83.0, 83.0, 83.0, 98.0, 83.0, 83.0, 101.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 116.0, 114.0, 114.0, 114.0, 113.0, 119.0, 118.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 150.0, 150.0, 150.0, 151.0, 151.0, 151.0, 150.0, 153.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 52.0, 54.0, 54.0, 57.0, 54.0, 54.0, 56.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 57.0, 57.0, 57.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 81.0, 83.0, 92.0, 91.0, 81.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 134.0, 132.0, 145.0, 133.0, 141.0, 139.0, 145.0, 184.0, 141.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 202.0, 198.0, 204.0, 193.0, 206.0, 208.0, 189.0, 199.0, 195.0], "value": 198.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 73.0, 72.0, 74.0, 72.0, 71.0, 73.0, 71.0], "value": 72.7, "unit": "score"}]}]} 09:18:59 INFO - Return code: 0 09:18:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:18:59 INFO - # TBPL SUCCESS # 09:18:59 INFO - Running post-action listener: _resource_record_post_action 09:18:59 INFO - [mozharness: 2017-05-03 16:18:59.106921Z] Finished run-tests step (success) 09:18:59 INFO - Running post-run listener: _resource_record_post_run 09:18:59 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7880704; Write bytes: 360927232; Read time: 1296; Write time: 267872 09:18:59 INFO - TinderboxPrint: CPU usage
13.3% 09:18:59 INFO - TinderboxPrint: I/O read bytes / time
7,880,704 / 1,296 09:18:59 INFO - TinderboxPrint: I/O write bytes / time
360,927,232 / 267,872 09:18:59 INFO - TinderboxPrint: CPU idle
8,311.9 (86.7%) 09:18:59 INFO - TinderboxPrint: CPU user
1,214.3 (12.7%) 09:18:59 INFO - TinderboxPrint: Swap in / out
0 / 0 09:18:59 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107008000; Read time: 36; Write time: 75308 09:18:59 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 5660672; Write bytes: 253919232; Read time: 1080; Write time: 192564 09:18:59 INFO - Running post-run listener: _upload_blobber_files 09:18:59 INFO - Blob upload gear active. 09:18:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:18:59 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 09:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:19:00 INFO - (blobuploader) - INFO - Open directory for files ... 09:19:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:19:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:19:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:01 INFO - (blobuploader) - INFO - Done attempting. 09:19:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:19:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:19:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:02 INFO - (blobuploader) - INFO - Done attempting. 09:19:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:19:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:19:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:03 INFO - (blobuploader) - INFO - Done attempting. 09:19:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:19:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:19:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:06 INFO - (blobuploader) - INFO - Done attempting. 09:19:06 INFO - (blobuploader) - INFO - Iteration through files over. 09:19:06 INFO - Return code: 0 09:19:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:19:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:19:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7dc2ef89d145444f7212c6e8c4acdb30163da806f03827cf04a53e680f102f712e6c95bd41373af05fa7fd4c5e3e2560508867b416132e013e6909c4356d4426", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e388ba20d9482b45dac1b790c491d85f74f41278349e816a43621072c278252953bc785819b53cea805f512af9351b16a17e89198597a58991f18e61a394940", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd3b63eed215e694a9a69c221c5dd3141ba9956fddb796e979cd365550158c1162f9c0300e978a6879a2925d8b0868d8264ad1e4260a11006a39237d7030fde5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6093fb58448722e1cc5fb830d61b8ea33cb7b8693cda616c1cc284a5d09ced882b6df75b51f5c6fb4d045db4cc0b7252818b9df097c249a3615bc82ae837fba3"} 09:19:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:19:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:19:06 INFO - Contents: 09:19:06 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7dc2ef89d145444f7212c6e8c4acdb30163da806f03827cf04a53e680f102f712e6c95bd41373af05fa7fd4c5e3e2560508867b416132e013e6909c4356d4426", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e388ba20d9482b45dac1b790c491d85f74f41278349e816a43621072c278252953bc785819b53cea805f512af9351b16a17e89198597a58991f18e61a394940", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd3b63eed215e694a9a69c221c5dd3141ba9956fddb796e979cd365550158c1162f9c0300e978a6879a2925d8b0868d8264ad1e4260a11006a39237d7030fde5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6093fb58448722e1cc5fb830d61b8ea33cb7b8693cda616c1cc284a5d09ced882b6df75b51f5c6fb4d045db4cc0b7252818b9df097c249a3615bc82ae837fba3"} 09:19:06 INFO - Running post-run listener: copy_logs_to_upload_dir 09:19:06 INFO - Copying logs to upload dir... 09:19:06 INFO - mkdir: /builds/slave/test/build/upload/logs 09:19:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.725141 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-03 09:19:06.235548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 09:19:06.244544) ========= 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=7de08804244eb36560b44971000001c3-1493827084.108547-1531611621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7dc2ef89d145444f7212c6e8c4acdb30163da806f03827cf04a53e680f102f712e6c95bd41373af05fa7fd4c5e3e2560508867b416132e013e6909c4356d4426", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e388ba20d9482b45dac1b790c491d85f74f41278349e816a43621072c278252953bc785819b53cea805f512af9351b16a17e89198597a58991f18e61a394940", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd3b63eed215e694a9a69c221c5dd3141ba9956fddb796e979cd365550158c1162f9c0300e978a6879a2925d8b0868d8264ad1e4260a11006a39237d7030fde5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6093fb58448722e1cc5fb830d61b8ea33cb7b8693cda616c1cc284a5d09ced882b6df75b51f5c6fb4d045db4cc0b7252818b9df097c249a3615bc82ae837fba3"} build_url:https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/Z_0mGBu9SDuVrWn0-OTd0A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7dc2ef89d145444f7212c6e8c4acdb30163da806f03827cf04a53e680f102f712e6c95bd41373af05fa7fd4c5e3e2560508867b416132e013e6909c4356d4426", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e388ba20d9482b45dac1b790c491d85f74f41278349e816a43621072c278252953bc785819b53cea805f512af9351b16a17e89198597a58991f18e61a394940", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd3b63eed215e694a9a69c221c5dd3141ba9956fddb796e979cd365550158c1162f9c0300e978a6879a2925d8b0868d8264ad1e4260a11006a39237d7030fde5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6093fb58448722e1cc5fb830d61b8ea33cb7b8693cda616c1cc284a5d09ced882b6df75b51f5c6fb4d045db4cc0b7252818b9df097c249a3615bc82ae837fba3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 09:19:06.270981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 09:19:06.271316) ========= 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=7de08804244eb36560b44971000001c3-1493827084.108547-1531611621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 09:19:06.354895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 09:19:06.358241) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 09:19:06.358595) ========= ========= Total master_lag: 0.38 =========