builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1489775245.55 results: success (0) revision: 85ead1312fe6ca35789595f455788b599f599c9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 11:27:25.546940) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 11:27:25.547401) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 11:27:25.547670) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 11:27:25.562647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:27:25.562946) ========= 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=826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-17 11:27:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-03-17 11:27:25 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120405 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:27:25.696800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:27:25.697076) ========= 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=826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019080 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:27:25.746989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-17 11:27:25.747326) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 85ead1312fe6ca35789595f455788b599f599c9f --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 85ead1312fe6ca35789595f455788b599f599c9f --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=826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-17 11:27:25,971 truncating revision to first 12 chars 2017-03-17 11:27:25,971 Setting DEBUG logging. 2017-03-17 11:27:25,971 attempt 1/10 2017-03-17 11:27:25,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/85ead1312fe6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-17 11:27:26,828 unpacking tar archive at: mozilla-central-85ead1312fe6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.221977 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-17 11:27:26.982397) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 11:27:26.982698) ========= script_repo_revision: 85ead1312fe6ca35789595f455788b599f599c9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 11:27:26.983056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 11:27:26.983328) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 11:27:26.993205) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-17 11:27:26.993590) ========= /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=826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:27:27 INFO - MultiFileLogger online at 20170317 11:27:27 in /builds/slave/test 11:27:27 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 11:27:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:27:27 INFO - {'append_to_log': False, 11:27:27 INFO - 'base_work_dir': '/builds/slave/test', 11:27:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:27:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:27:27 INFO - 'branch': 'Firefox-Non-PGO', 11:27:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:27:27 INFO - 'config_files': ('talos/linux_config.py',), 11:27:27 INFO - 'default_actions': ('clobber', 11:27:27 INFO - 'read-buildbot-config', 11:27:27 INFO - 'download-and-extract', 11:27:27 INFO - 'populate-webroot', 11:27:27 INFO - 'create-virtualenv', 11:27:27 INFO - 'install', 11:27:27 INFO - 'run-tests'), 11:27:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:27:27 INFO - 'download_minidump_stackwalk': True, 11:27:27 INFO - 'download_symbols': 'ondemand', 11:27:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:27:27 INFO - 'tooltool.py': '/tools/tooltool.py', 11:27:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:27:27 INFO - '/tools/misc-python/virtualenv.py')}, 11:27:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:27:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:27:27 INFO - 'gecko_profile': False, 11:27:27 INFO - 'gecko_profile_interval': 0, 11:27:27 INFO - 'installer_path': 'installer.exe', 11:27:27 INFO - 'log_level': 'info', 11:27:27 INFO - 'log_name': 'talos', 11:27:27 INFO - 'log_to_console': True, 11:27:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:27:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:27:27 INFO - 'opt_config_files': (), 11:27:27 INFO - 'pip_index': False, 11:27:27 INFO - 'suite': 'dromaeojs-e10s', 11:27:27 INFO - 'system_bits': '32', 11:27:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:27:27 INFO - 'title': 'talos-linux64-ix-052', 11:27:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:27:27 INFO - 'use_talos_json': True, 11:27:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:27:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:27:27 INFO - 'work_dir': 'build'} 11:27:27 INFO - [mozharness: 2017-03-17 18:27:27.319208Z] Running clobber step. 11:27:27 INFO - Running pre-action listener: _resource_record_pre_action 11:27:27 INFO - Running main action method: clobber 11:27:27 INFO - rmtree: /builds/slave/test/build 11:27:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:27:28 INFO - Running post-action listener: _resource_record_post_action 11:27:28 INFO - [mozharness: 2017-03-17 18:27:28.251937Z] Finished clobber step (success) 11:27:28 INFO - [mozharness: 2017-03-17 18:27:28.252036Z] Running read-buildbot-config step. 11:27:28 INFO - Running pre-action listener: _resource_record_pre_action 11:27:28 INFO - Running main action method: read_buildbot_config 11:27:28 INFO - Using buildbot properties: 11:27:28 INFO - { 11:27:28 INFO - "project": "", 11:27:28 INFO - "product": "firefox", 11:27:28 INFO - "who": "kwierso@gmail.com", 11:27:28 INFO - "installer_path": "public/build/target.tar.bz2", 11:27:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:27:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 11:27:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:27:28 INFO - "stage_platform": "linux64", 11:27:28 INFO - "basedir": "/builds/slave/test", 11:27:28 INFO - "buildnumber": 470, 11:27:28 INFO - "platform": "ubuntu64_hw", 11:27:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:27:28 INFO - "slavebuilddir": "test", 11:27:28 INFO - "taskId": "Y57K91tSRliSur12T0Fs8A", 11:27:28 INFO - "branch": "mozilla-central", 11:27:28 INFO - "script_repo_revision": "production", 11:27:28 INFO - "revision": "85ead1312fe6ca35789595f455788b599f599c9f", 11:27:28 INFO - "slavename": "talos-linux64-ix-052", 11:27:28 INFO - "repo_path": "mozilla-central" 11:27:28 INFO - } 11:27:28 INFO - Finding installer, test and symbols from parent task. 11:27:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y57K91tSRliSur12T0Fs8A'}, attempt #1 11:27:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y57K91tSRliSur12T0Fs8A'}, attempt #1 11:27:29 INFO - Task dependencies: PveYK3-lSSa-H8qxbtmpWw 11:27:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw'}, attempt #1 11:27:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.tar.bz2 11:27:29 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/test_packages.json 11:27:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.crashreporter-symbols.zip 11:27:29 INFO - Running post-action listener: _resource_record_post_action 11:27:29 INFO - [mozharness: 2017-03-17 18:27:29.635057Z] Finished read-buildbot-config step (success) 11:27:29 INFO - [mozharness: 2017-03-17 18:27:29.635277Z] Running download-and-extract step. 11:27:29 INFO - Running pre-action listener: _resource_record_pre_action 11:27:29 INFO - Running main action method: download_and_extract 11:27:29 INFO - mkdir: /builds/slave/test/build/tests 11:27:29 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')]} 11:27:29 INFO - trying https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.test_packages.json 11:27:29 INFO - Downloading https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:27:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:27:30 INFO - Downloaded 986 bytes. 11:27:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:27:30 INFO - Using the following test package requirements: 11:27:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:27:30 INFO - u'common': [u'target.common.tests.zip'], 11:27:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:27:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:27:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:27:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:27:30 INFO - u'mozbase': [u'target.common.tests.zip'], 11:27:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:27:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:27:30 INFO - u'web-platform': [u'target.common.tests.zip', 11:27:30 INFO - u'target.web-platform.tests.zip'], 11:27:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:27:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:27:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.common.tests.zip 11:27:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:27:30 INFO - Fetch https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.common.tests.zip into memory 11:27:31 INFO - Expected file size: 58185917 11:27:31 INFO - Obtained file size: 58185917 11:27:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:27:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.common.tests.zip 11:27:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:27:41 INFO - Fetch https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.common.tests.zip into memory 11:27:42 INFO - Expected file size: 58185917 11:27:42 INFO - Obtained file size: 58185917 11:27:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.talos.tests.zip 11:27:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:27:53 INFO - Fetch https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.talos.tests.zip into memory 11:27:53 INFO - Expected file size: 14404171 11:27:53 INFO - Obtained file size: 14404171 11:27: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')]} 11:27:54 INFO - trying https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.tar.bz2 11:27:54 INFO - Downloading https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:27:55 INFO - Downloaded 61689988 bytes. 11:27:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.tar.bz2 11:27:55 INFO - mkdir: /builds/slave/test/properties 11:27:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:27:55 INFO - Writing to file /builds/slave/test/properties/build_url 11:27:55 INFO - Contents: 11:27:55 INFO - build_url:https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.tar.bz2 11:27:55 INFO - Running post-action listener: _resource_record_post_action 11:27:55 INFO - Running post-action listener: set_extra_try_arguments 11:27:55 INFO - [mozharness: 2017-03-17 18:27:55.337390Z] Finished download-and-extract step (success) 11:27:55 INFO - [mozharness: 2017-03-17 18:27:55.337486Z] Running populate-webroot step. 11:27:55 INFO - Running pre-action listener: _resource_record_pre_action 11:27:55 INFO - Running main action method: populate_webroot 11:27:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:27:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:27:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:27:55 INFO - '--tppagecycles', 11:27:55 INFO - '7'], 11:27:55 INFO - 'tests': ['tsvgm']}}, 11:27:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:27:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:27:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:27:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:27:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:27:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:27:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:27:55 INFO - 'talos_options': ['--disable-e10s'], 11:27:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:27:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:27:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:27:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:27:55 INFO - 'talos_options': ['--disable-e10s'], 11:27:55 INFO - 'tests': ['damp', 'tps']}, 11:27:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:27:55 INFO - 'tests': ['damp', 'tps']}, 11:27:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:27:55 INFO - 'tests': ['dromaeo_dom']}, 11:27:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:27:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:27:55 INFO - 'tests': ['basic_compositor_video']}, 11:27:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:27:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:27:55 INFO - 'tests': ['a11yr', 11:27:55 INFO - 'ts_paint', 11:27:55 INFO - 'tpaint', 11:27:55 INFO - 'sessionrestore', 11:27:55 INFO - 'sessionrestore_no_auto_restore', 11:27:55 INFO - 'tabpaint']}, 11:27:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:27:55 INFO - 'ts_paint', 11:27:55 INFO - 'tpaint', 11:27:55 INFO - 'sessionrestore', 11:27:55 INFO - 'sessionrestore_no_auto_restore', 11:27:55 INFO - 'tabpaint']}, 11:27:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:27:55 INFO - 'ts_paint', 11:27:55 INFO - 'tpaint', 11:27:55 INFO - 'sessionrestore', 11:27:55 INFO - 'sessionrestore_no_auto_restore', 11:27:55 INFO - 'tabpaint']}, 11:27:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:27:55 INFO - 'ts_paint', 11:27:55 INFO - 'tpaint', 11:27:55 INFO - 'sessionrestore', 11:27:55 INFO - 'sessionrestore_no_auto_restore', 11:27:55 INFO - 'tabpaint']}, 11:27:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:27:55 INFO - 'tests': ['a11yr', 11:27:55 INFO - 'ts_paint', 11:27:55 INFO - 'tpaint', 11:27:55 INFO - 'sessionrestore', 11:27:55 INFO - 'sessionrestore_no_auto_restore', 11:27:55 INFO - 'tabpaint']}, 11:27:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:27:55 INFO - 'tests': ['a11yr', 11:27:55 INFO - 'ts_paint', 11:27:55 INFO - 'tpaint', 11:27:55 INFO - 'sessionrestore', 11:27:55 INFO - 'sessionrestore_no_auto_restore', 11:27:55 INFO - 'tabpaint']}, 11:27:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:27:55 INFO - 'tests': ['tsvgx', 11:27:55 INFO - 'tsvgr_opacity', 11:27:55 INFO - 'tart', 11:27:55 INFO - 'tscrollx', 11:27:55 INFO - 'cart', 11:27:55 INFO - 'tsvg_static']}, 11:27:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:27:55 INFO - 'tsvgr_opacity', 11:27:55 INFO - 'tart', 11:27:55 INFO - 'tscrollx', 11:27:55 INFO - 'cart', 11:27:55 INFO - 'tsvg_static']}, 11:27:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:27:55 INFO - 'talos_options': ['--disable-e10s'], 11:27:55 INFO - 'tests': ['tp5o']}, 11:27:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:27:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:27:55 INFO - 'talos_options': ['--disable-e10s', 11:27:55 INFO - '--xperf_path', 11:27:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:27:55 INFO - 'tests': ['tp5n']}, 11:27:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:27:55 INFO - 'talos_options': ['--xperf_path', 11:27:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:27:55 INFO - 'tests': ['tp5n']}}, 11:27:55 INFO - 'talos.zip': {'path': '', 11:27:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:27:55 INFO - Running post-action listener: _resource_record_post_action 11:27:55 INFO - [mozharness: 2017-03-17 18:27:55.350491Z] Finished populate-webroot step (success) 11:27:55 INFO - [mozharness: 2017-03-17 18:27:55.350579Z] Running create-virtualenv step. 11:27:55 INFO - Running pre-action listener: _resource_record_pre_action 11:27:55 INFO - Running main action method: create_virtualenv 11:27:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:27:55 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 11:27:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:27:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:27:55 INFO - Using real prefix '/usr' 11:27:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:27:55 INFO - Installing distribute.............................................................................................................................................................................................done. 11:27:57 INFO - Installing pip.................done. 11:27:57 INFO - Return code: 0 11:27:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:27:58 INFO - Reading from file tmpfile_stdout 11:27:58 INFO - Output received: 11:27:58 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) 11:27:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:27:58 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')]} 11:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:58 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')]} 11:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0xb771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12290>, '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 0xe12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe13040>, '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': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', '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 11:27:58 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 11:27:58 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 11:27:58 INFO - Using env: {'DISPLAY': ':0', 11:27:58 INFO - 'HOME': '/home/cltbld', 11:27:58 INFO - 'LANG': 'en_US.UTF-8', 11:27:58 INFO - 'LANGUAGE': 'en_US:en', 11:27:58 INFO - 'LOGNAME': 'cltbld', 11:27:58 INFO - 'MAIL': '/var/mail/cltbld', 11:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:58 INFO - 'MOZ_NO_REMOTE': '1', 11:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:58 INFO - 'NO_EM_RESTART': '1', 11:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:58 INFO - 'PWD': '/builds/slave/test', 11:27:58 INFO - 'SHELL': '/bin/bash', 11:27:58 INFO - 'SHLVL': '1', 11:27:58 INFO - 'TERM': 'linux', 11:27:58 INFO - 'TMOUT': '86400', 11:27:58 INFO - 'USER': 'cltbld', 11:27:58 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', 11:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:58 INFO - '_': '/tools/buildbot/bin/python'} 11:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:58 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 11:27:58 INFO - Cleaning up... 11:27:58 INFO - Return code: 0 11:27:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:27:58 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')]} 11:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:58 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')]} 11:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0xb771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12290>, '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 0xe12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe13040>, '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': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', '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 11:27:58 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 11:27:58 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 11:27:58 INFO - Using env: {'DISPLAY': ':0', 11:27:58 INFO - 'HOME': '/home/cltbld', 11:27:58 INFO - 'LANG': 'en_US.UTF-8', 11:27:58 INFO - 'LANGUAGE': 'en_US:en', 11:27:58 INFO - 'LOGNAME': 'cltbld', 11:27:58 INFO - 'MAIL': '/var/mail/cltbld', 11:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:58 INFO - 'MOZ_NO_REMOTE': '1', 11:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:58 INFO - 'NO_EM_RESTART': '1', 11:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:58 INFO - 'PWD': '/builds/slave/test', 11:27:58 INFO - 'SHELL': '/bin/bash', 11:27:58 INFO - 'SHLVL': '1', 11:27:58 INFO - 'TERM': 'linux', 11:27:58 INFO - 'TMOUT': '86400', 11:27:58 INFO - 'USER': 'cltbld', 11:27:58 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', 11:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:58 INFO - '_': '/tools/buildbot/bin/python'} 11:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:58 INFO - Downloading/unpacking psutil>=3.1.1 11:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:58 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 11:27:58 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 11:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:28:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:28:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:28:00 INFO - Installing collected packages: psutil 11:28:00 INFO - Running setup.py install for psutil 11:28:00 INFO - building 'psutil._psutil_linux' extension 11:28:00 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 11:28:00 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 11:28:00 INFO - building 'psutil._psutil_posix' extension 11:28:00 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 11:28:01 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 11:28:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:28:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:28:01 INFO - Successfully installed psutil 11:28:01 INFO - Cleaning up... 11:28:01 INFO - Return code: 0 11:28:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:28:01 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')]} 11:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:01 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')]} 11:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:01 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 0xb771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12290>, '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 0xe12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe13040>, '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': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', '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 11:28:01 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 11:28:01 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 11:28:01 INFO - Using env: {'DISPLAY': ':0', 11:28:01 INFO - 'HOME': '/home/cltbld', 11:28:01 INFO - 'LANG': 'en_US.UTF-8', 11:28:01 INFO - 'LANGUAGE': 'en_US:en', 11:28:01 INFO - 'LOGNAME': 'cltbld', 11:28:01 INFO - 'MAIL': '/var/mail/cltbld', 11:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:01 INFO - 'MOZ_NO_REMOTE': '1', 11:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:01 INFO - 'NO_EM_RESTART': '1', 11:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:01 INFO - 'PWD': '/builds/slave/test', 11:28:01 INFO - 'SHELL': '/bin/bash', 11:28:01 INFO - 'SHLVL': '1', 11:28:01 INFO - 'TERM': 'linux', 11:28:01 INFO - 'TMOUT': '86400', 11:28:01 INFO - 'USER': 'cltbld', 11:28:01 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', 11:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:01 INFO - '_': '/tools/buildbot/bin/python'} 11:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:28:01 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 11:28:01 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 11:28:01 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 11:28:01 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 11:28:01 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 11:28:01 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 11:28:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:28:04 INFO - Installing collected packages: mozsystemmonitor 11:28:04 INFO - Running setup.py install for mozsystemmonitor 11:28:04 INFO - Successfully installed mozsystemmonitor 11:28:04 INFO - Cleaning up... 11:28:04 INFO - Return code: 0 11:28:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:28:04 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')]} 11:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:04 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')]} 11:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:04 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 0xb771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12290>, '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 0xe12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe13040>, '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': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', '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 11:28:04 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 11:28:04 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 11:28:04 INFO - Using env: {'DISPLAY': ':0', 11:28:04 INFO - 'HOME': '/home/cltbld', 11:28:04 INFO - 'LANG': 'en_US.UTF-8', 11:28:04 INFO - 'LANGUAGE': 'en_US:en', 11:28:04 INFO - 'LOGNAME': 'cltbld', 11:28:04 INFO - 'MAIL': '/var/mail/cltbld', 11:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:04 INFO - 'MOZ_NO_REMOTE': '1', 11:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:04 INFO - 'NO_EM_RESTART': '1', 11:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:04 INFO - 'PWD': '/builds/slave/test', 11:28:04 INFO - 'SHELL': '/bin/bash', 11:28:04 INFO - 'SHLVL': '1', 11:28:04 INFO - 'TERM': 'linux', 11:28:04 INFO - 'TMOUT': '86400', 11:28:04 INFO - 'USER': 'cltbld', 11:28:04 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', 11:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:04 INFO - '_': '/tools/buildbot/bin/python'} 11:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:04 INFO - Downloading/unpacking jsonschema==2.5.1 11:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:04 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 11:28:04 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 11:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:28:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:28:06 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 11:28:06 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 11:28:06 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 11:28:06 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 11:28:06 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 11:28:06 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 11:28:07 INFO - Downloading functools32-3.2.3-2.tar.gz 11:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:28:07 INFO - warning: no files found matching '*.txt' 11:28:07 INFO - no previously-included directories found matching 'build' 11:28:07 INFO - no previously-included directories found matching 'dist' 11:28:07 INFO - no previously-included directories found matching '.git*' 11:28:07 INFO - Installing collected packages: jsonschema, functools32 11:28:07 INFO - Running setup.py install for functools32 11:28:07 INFO - warning: no files found matching '*.txt' 11:28:07 INFO - no previously-included directories found matching 'build' 11:28:07 INFO - no previously-included directories found matching 'dist' 11:28:07 INFO - no previously-included directories found matching '.git*' 11:28:07 INFO - Successfully installed jsonschema functools32 11:28:07 INFO - Cleaning up... 11:28:07 INFO - Return code: 0 11:28:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:28:07 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')]} 11:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:07 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')]} 11:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:07 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 0xb771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12290>, '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 0xe12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe13040>, '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': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', '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 11:28:07 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 11:28:07 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 11:28:07 INFO - Using env: {'DISPLAY': ':0', 11:28:07 INFO - 'HOME': '/home/cltbld', 11:28:07 INFO - 'LANG': 'en_US.UTF-8', 11:28:07 INFO - 'LANGUAGE': 'en_US:en', 11:28:07 INFO - 'LOGNAME': 'cltbld', 11:28:07 INFO - 'MAIL': '/var/mail/cltbld', 11:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:07 INFO - 'MOZ_NO_REMOTE': '1', 11:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:07 INFO - 'NO_EM_RESTART': '1', 11:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:07 INFO - 'PWD': '/builds/slave/test', 11:28:07 INFO - 'SHELL': '/bin/bash', 11:28:07 INFO - 'SHLVL': '1', 11:28:07 INFO - 'TERM': 'linux', 11:28:07 INFO - 'TMOUT': '86400', 11:28:07 INFO - 'USER': 'cltbld', 11:28:07 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', 11:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:07 INFO - '_': '/tools/buildbot/bin/python'} 11:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:28:07 INFO - Cleaning up... 11:28:07 INFO - Return code: 0 11:28:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:28:07 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')]} 11:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:07 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')]} 11:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:07 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 0xb771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12290>, '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 0xe12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe13040>, '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': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', '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 11:28:07 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 11:28:07 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 11:28:07 INFO - Using env: {'DISPLAY': ':0', 11:28:07 INFO - 'HOME': '/home/cltbld', 11:28:07 INFO - 'LANG': 'en_US.UTF-8', 11:28:07 INFO - 'LANGUAGE': 'en_US:en', 11:28:07 INFO - 'LOGNAME': 'cltbld', 11:28:07 INFO - 'MAIL': '/var/mail/cltbld', 11:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:07 INFO - 'MOZ_NO_REMOTE': '1', 11:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:07 INFO - 'NO_EM_RESTART': '1', 11:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:07 INFO - 'PWD': '/builds/slave/test', 11:28:07 INFO - 'SHELL': '/bin/bash', 11:28:07 INFO - 'SHLVL': '1', 11:28:07 INFO - 'TERM': 'linux', 11:28:07 INFO - 'TMOUT': '86400', 11:28:07 INFO - 'USER': 'cltbld', 11:28:07 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', 11:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:07 INFO - '_': '/tools/buildbot/bin/python'} 11:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:07 INFO - Downloading/unpacking blobuploader==1.2.4 11:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:07 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 11:28:07 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 11:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:09 INFO - Downloading blobuploader-1.2.4.tar.gz 11:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:28:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:28:09 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 11:28:09 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 11:28:09 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 11:28:09 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 11:28:09 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 11:28:09 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 11:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:28:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:28:10 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 11:28:10 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 11:28:10 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 11:28:10 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 11:28:10 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 11:28:10 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 11:28:10 INFO - Downloading docopt-0.6.1.tar.gz 11:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:28:10 INFO - Installing collected packages: blobuploader, requests, docopt 11:28:10 INFO - Running setup.py install for blobuploader 11:28:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:28:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:28:10 INFO - Running setup.py install for requests 11:28:11 INFO - Running setup.py install for docopt 11:28:11 INFO - Successfully installed blobuploader requests docopt 11:28:11 INFO - Cleaning up... 11:28:11 INFO - Return code: 0 11:28:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:11 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')]} 11:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:11 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')]} 11:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:11 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 0xb771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12290>, '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 0xe12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe13040>, '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': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', '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 11:28:11 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 11:28:11 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 11:28:11 INFO - Using env: {'DISPLAY': ':0', 11:28:11 INFO - 'HOME': '/home/cltbld', 11:28:11 INFO - 'LANG': 'en_US.UTF-8', 11:28:11 INFO - 'LANGUAGE': 'en_US:en', 11:28:11 INFO - 'LOGNAME': 'cltbld', 11:28:11 INFO - 'MAIL': '/var/mail/cltbld', 11:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:11 INFO - 'MOZ_NO_REMOTE': '1', 11:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:11 INFO - 'NO_EM_RESTART': '1', 11:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:11 INFO - 'PWD': '/builds/slave/test', 11:28:11 INFO - 'SHELL': '/bin/bash', 11:28:11 INFO - 'SHLVL': '1', 11:28:11 INFO - 'TERM': 'linux', 11:28:11 INFO - 'TMOUT': '86400', 11:28:11 INFO - 'USER': 'cltbld', 11:28:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', 11:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:11 INFO - '_': '/tools/buildbot/bin/python'} 11:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:28:11 INFO - Running setup.py (path:/tmp/pip-Tv7stZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:28:11 INFO - Running setup.py (path:/tmp/pip-FwxG_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:28:11 INFO - Running setup.py (path:/tmp/pip-wIsWcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:28:11 INFO - Running setup.py (path:/tmp/pip-JL0ml0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:28:11 INFO - Running setup.py (path:/tmp/pip-ymvUQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:28:11 INFO - Running setup.py (path:/tmp/pip-BAUqZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:28:11 INFO - Running setup.py (path:/tmp/pip-wey9vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:28:12 INFO - Running setup.py (path:/tmp/pip-DHfEx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:28:12 INFO - Running setup.py (path:/tmp/pip-hrADYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:28:12 INFO - Running setup.py (path:/tmp/pip-YOjmmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:28:12 INFO - Running setup.py (path:/tmp/pip-aI2N01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:28:12 INFO - Running setup.py (path:/tmp/pip-IEOQg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:28:12 INFO - Running setup.py (path:/tmp/pip-nxmYt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:28:12 INFO - Running setup.py (path:/tmp/pip-4R7nLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:12 INFO - Running setup.py (path:/tmp/pip-nZz08T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:28:12 INFO - Running setup.py (path:/tmp/pip-m8DfZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:28:12 INFO - Running setup.py (path:/tmp/pip-YROhxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:28:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:28:12 INFO - Running setup.py install for manifestparser 11:28:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:28:12 INFO - Running setup.py install for mozcrash 11:28:12 INFO - Running setup.py install for mozdebug 11:28:13 INFO - Running setup.py install for mozdevice 11:28:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:28:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:28:13 INFO - Running setup.py install for mozfile 11:28:13 INFO - Running setup.py install for mozhttpd 11:28:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:28:13 INFO - Running setup.py install for mozinfo 11:28:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:28:13 INFO - Running setup.py install for mozInstall 11:28:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:28:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:28:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:28:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:28:13 INFO - Running setup.py install for mozleak 11:28:13 INFO - Running setup.py install for mozlog 11:28:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:28:13 INFO - Running setup.py install for moznetwork 11:28:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:28:13 INFO - Running setup.py install for mozprocess 11:28:13 INFO - Running setup.py install for mozprofile 11:28:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:28:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:28:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:28:14 INFO - Running setup.py install for mozrunner 11:28:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:28:14 INFO - Running setup.py install for mozscreenshot 11:28:14 INFO - Running setup.py install for moztest 11:28:14 INFO - Running setup.py install for mozversion 11:28:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:28:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:28:14 INFO - Cleaning up... 11:28:14 INFO - Return code: 0 11:28:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:14 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')]} 11:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:14 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')]} 11:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:14 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 0xb771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12290>, '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 0xe12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe13040>, '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': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', '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 11:28:14 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 11:28:14 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 11:28:14 INFO - Using env: {'DISPLAY': ':0', 11:28:14 INFO - 'HOME': '/home/cltbld', 11:28:14 INFO - 'LANG': 'en_US.UTF-8', 11:28:14 INFO - 'LANGUAGE': 'en_US:en', 11:28:14 INFO - 'LOGNAME': 'cltbld', 11:28:14 INFO - 'MAIL': '/var/mail/cltbld', 11:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:14 INFO - 'MOZ_NO_REMOTE': '1', 11:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:14 INFO - 'NO_EM_RESTART': '1', 11:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:14 INFO - 'PWD': '/builds/slave/test', 11:28:14 INFO - 'SHELL': '/bin/bash', 11:28:14 INFO - 'SHLVL': '1', 11:28:14 INFO - 'TERM': 'linux', 11:28:14 INFO - 'TMOUT': '86400', 11:28:14 INFO - 'USER': 'cltbld', 11:28:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', 11:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:14 INFO - '_': '/tools/buildbot/bin/python'} 11:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:28:14 INFO - Running setup.py (path:/tmp/pip-bdT_X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:28:14 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)) 11:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:28:14 INFO - Running setup.py (path:/tmp/pip-e6W01n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:28:14 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)) 11:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:28:14 INFO - Running setup.py (path:/tmp/pip-kfRA7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:28:14 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)) 11:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:28:15 INFO - Running setup.py (path:/tmp/pip-a_sncL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:28:15 INFO - Running setup.py (path:/tmp/pip-wvCr_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:28:15 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:28:15 INFO - Running setup.py (path:/tmp/pip-q8RVMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:28:15 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:28:15 INFO - Running setup.py (path:/tmp/pip-KOUgj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:28:15 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:28:15 INFO - Running setup.py (path:/tmp/pip-Z83euz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:28:15 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:28:15 INFO - Running setup.py (path:/tmp/pip-fK86s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:28:15 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:28:15 INFO - Running setup.py (path:/tmp/pip-aFaV1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:28:15 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:28:15 INFO - Running setup.py (path:/tmp/pip-UdT_51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:28:15 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:28:15 INFO - Running setup.py (path:/tmp/pip-zf_HQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:28:15 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:28:15 INFO - Running setup.py (path:/tmp/pip-hnfuyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:28:15 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:28:15 INFO - Running setup.py (path:/tmp/pip-1KkFAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:28:15 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:15 INFO - Running setup.py (path:/tmp/pip-VuHYBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:15 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:28:15 INFO - Running setup.py (path:/tmp/pip-lat5ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:28:15 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)) 11:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:28:15 INFO - Running setup.py (path:/tmp/pip-JhaJ4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:28:16 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)) 11:28:16 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)) 11:28:16 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)) 11:28:16 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)) 11:28:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:28:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:28:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:16 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 11:28:16 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 11:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:18 INFO - Downloading blessings-1.6.tar.gz 11:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:28:18 INFO - Installing collected packages: blessings 11:28:18 INFO - Running setup.py install for blessings 11:28:18 INFO - Successfully installed blessings 11:28:18 INFO - Cleaning up... 11:28:18 INFO - Return code: 0 11:28:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:28:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:28:19 INFO - Reading from file tmpfile_stdout 11:28:19 INFO - Current package versions: 11:28:19 INFO - argparse == 1.2.1 11:28:19 INFO - blessings == 1.6 11:28:19 INFO - blobuploader == 1.2.4 11:28:19 INFO - docopt == 0.6.1 11:28:19 INFO - functools32 == 3.2.3-2 11:28:19 INFO - jsonschema == 2.5.1 11:28:19 INFO - manifestparser == 1.1 11:28:19 INFO - mozInstall == 1.12 11:28:19 INFO - mozcrash == 1.0 11:28:19 INFO - mozdebug == 0.1 11:28:19 INFO - mozdevice == 0.49 11:28:19 INFO - mozfile == 1.2 11:28:19 INFO - mozhttpd == 0.7 11:28:19 INFO - mozinfo == 0.9 11:28:19 INFO - mozleak == 0.1 11:28:19 INFO - mozlog == 3.4 11:28:19 INFO - moznetwork == 0.27 11:28:19 INFO - mozprocess == 0.25 11:28:19 INFO - mozprofile == 0.28 11:28:19 INFO - mozrunner == 6.13 11:28:19 INFO - mozscreenshot == 0.1 11:28:19 INFO - mozsystemmonitor == 0.3 11:28:19 INFO - moztest == 0.8 11:28:19 INFO - mozversion == 1.4 11:28:19 INFO - psutil == 3.1.1 11:28:19 INFO - requests == 1.2.3 11:28:19 INFO - wsgiref == 0.1.2 11:28:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:19 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')]} 11:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:19 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')]} 11:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:19 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 0xb771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12290>, '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 0xe12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe13040>, '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': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', '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 11:28:19 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 11:28:19 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 11:28:19 INFO - Using env: {'DISPLAY': ':0', 11:28:19 INFO - 'HOME': '/home/cltbld', 11:28:19 INFO - 'LANG': 'en_US.UTF-8', 11:28:19 INFO - 'LANGUAGE': 'en_US:en', 11:28:19 INFO - 'LOGNAME': 'cltbld', 11:28:19 INFO - 'MAIL': '/var/mail/cltbld', 11:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:19 INFO - 'MOZ_NO_REMOTE': '1', 11:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:19 INFO - 'NO_EM_RESTART': '1', 11:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:19 INFO - 'PWD': '/builds/slave/test', 11:28:19 INFO - 'SHELL': '/bin/bash', 11:28:19 INFO - 'SHLVL': '1', 11:28:19 INFO - 'TERM': 'linux', 11:28:19 INFO - 'TMOUT': '86400', 11:28:19 INFO - 'USER': 'cltbld', 11:28:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', 11:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:19 INFO - '_': '/tools/buildbot/bin/python'} 11:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 INFO - Cleaning up... 11:28:19 INFO - Return code: 0 11:28:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:28:19 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')]} 11:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:19 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')]} 11:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:19 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 0xb771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12290>, '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 0xe12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe13040>, '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': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', '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 11:28:19 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 11:28:19 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 11:28:19 INFO - Using env: {'DISPLAY': ':0', 11:28:19 INFO - 'HOME': '/home/cltbld', 11:28:19 INFO - 'LANG': 'en_US.UTF-8', 11:28:19 INFO - 'LANGUAGE': 'en_US:en', 11:28:19 INFO - 'LOGNAME': 'cltbld', 11:28:19 INFO - 'MAIL': '/var/mail/cltbld', 11:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:19 INFO - 'MOZ_NO_REMOTE': '1', 11:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:19 INFO - 'NO_EM_RESTART': '1', 11:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:19 INFO - 'PWD': '/builds/slave/test', 11:28:19 INFO - 'SHELL': '/bin/bash', 11:28:19 INFO - 'SHLVL': '1', 11:28:19 INFO - 'TERM': 'linux', 11:28:19 INFO - 'TMOUT': '86400', 11:28:19 INFO - 'USER': 'cltbld', 11:28:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', 11:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:19 INFO - '_': '/tools/buildbot/bin/python'} 11:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:28:19 INFO - Cleaning up... 11:28:19 INFO - Return code: 0 11:28:19 INFO - Running post-action listener: _resource_record_post_action 11:28:19 INFO - Running post-action listener: _start_resource_monitoring 11:28:19 INFO - Starting resource monitoring. 11:28:19 INFO - [mozharness: 2017-03-17 18:28:19.735703Z] Finished create-virtualenv step (success) 11:28:19 INFO - [mozharness: 2017-03-17 18:28:19.736221Z] Running install step. 11:28:19 INFO - Running pre-action listener: _resource_record_pre_action 11:28:19 INFO - Running main action method: install 11:28:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:28:19 INFO - Reading from file tmpfile_stdout 11:28:19 INFO - Detecting whether we're running mozinstall >=1.0... 11:28:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:28:20 INFO - Reading from file tmpfile_stdout 11:28:20 INFO - Output received: 11:28:20 INFO - Usage: mozinstall [options] installer 11:28:20 INFO - Options: 11:28:20 INFO - -h, --help show this help message and exit 11:28:20 INFO - -d DEST, --destination=DEST 11:28:20 INFO - Directory to install application into. [default: 11:28:20 INFO - "/builds/slave/test"] 11:28:20 INFO - --app=APP Application being installed. [default: firefox] 11:28:20 INFO - mkdir: /builds/slave/test/build/application 11:28:20 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'] 11:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:28:35 INFO - Reading from file tmpfile_stdout 11:28:35 INFO - Output received: 11:28:35 INFO - /builds/slave/test/build/application/firefox/firefox 11:28:35 INFO - Running post-action listener: _resource_record_post_action 11:28:35 INFO - [mozharness: 2017-03-17 18:28:35.507246Z] Finished install step (success) 11:28:35 INFO - [mozharness: 2017-03-17 18:28:35.507517Z] Running run-tests step. 11:28:35 INFO - Running pre-action listener: _resource_record_pre_action 11:28:35 INFO - Running main action method: run_tests 11:28:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:28:35 INFO - Python 2.7.3 11:28:35 INFO - Return code: 0 11:28:35 INFO - grabbing minidump binary from tooltool 11:28:35 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')]} 11:28:35 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 0xe12290>, '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 0xe12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe13040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:28:35 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 11:28:35 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 11:28:35 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 11:28:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:28:35 INFO - Return code: 0 11:28:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:28:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:28:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:28:35 INFO - ENV: RUST_BACKTRACE is now 1 11:28:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:28:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:28:35 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/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 11:28:35 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/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 11:28:35 INFO - Using env: {'DISPLAY': ':0', 11:28:35 INFO - 'HOME': '/home/cltbld', 11:28:35 INFO - 'LANG': 'en_US.UTF-8', 11:28:35 INFO - 'LANGUAGE': 'en_US:en', 11:28:35 INFO - 'LOGNAME': 'cltbld', 11:28:35 INFO - 'MAIL': '/var/mail/cltbld', 11:28:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:28:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:35 INFO - 'MOZ_NO_REMOTE': '1', 11:28:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:35 INFO - 'NO_EM_RESTART': '1', 11:28:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:35 INFO - 'PWD': '/builds/slave/test', 11:28:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:28:35 INFO - 'RUST_BACKTRACE': '1', 11:28:35 INFO - 'SHELL': '/bin/bash', 11:28:35 INFO - 'SHLVL': '1', 11:28:35 INFO - 'TERM': 'linux', 11:28:35 INFO - 'TMOUT': '86400', 11:28:35 INFO - 'USER': 'cltbld', 11:28:35 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984', 11:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:35 INFO - '_': '/tools/buildbot/bin/python'} 11:28:35 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/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 11:28:35 INFO - mozversion application_buildid: 20170317175953 11:28:35 INFO - mozversion application_changeset: 85ead1312fe6ca35789595f455788b599f599c9f 11:28:35 INFO - mozversion application_display_name: Nightly 11:28:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:28:35 INFO - mozversion application_name: Firefox 11:28:35 INFO - mozversion application_remotingname: firefox 11:28:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:28:35 INFO - mozversion application_vendor: Mozilla 11:28:35 INFO - mozversion application_version: 55.0a1 11:28:35 INFO - mozversion platform_buildid: 20170317175953 11:28:35 INFO - mozversion platform_changeset: 85ead1312fe6ca35789595f455788b599f599c9f 11:28:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:28:35 INFO - mozversion platform_version: 55.0a1 11:28:35 INFO - using testdate: 1489775315 11:28:35 INFO - actual date: 1489775315 11:28:35 INFO - starting webserver on 'localhost:47556' 11:28:35 INFO - SUITE-START | Running 2 tests 11:28:35 INFO - TEST-START | dromaeo_css 11:28:35 INFO - operating with platform_type : linux_ 11:28:35 INFO - Initialising browser for dromaeo_css test... 11:28:35 INFO - TEST-INFO | started process 20737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVk2ehr/profile http://localhost:47556/getInfo.html) 11:28:40 INFO - PID 20737 | __metrics Screen width/height:1600/1200 11:28:40 INFO - PID 20737 | colorDepth:24 11:28:40 INFO - PID 20737 | Browser inner width/height: 1024/697 11:28:40 INFO - PID 20737 | __metrics 11:28:40 ERROR - PID 20737 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 11:28:42 INFO - TEST-INFO | 20737: exit 0 11:28:42 INFO - Browser initialized. 11:28:42 INFO - Running cycle 1/1 for dromaeo_css test... 11:28:42 INFO - TEST-INFO | started process 20869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVk2ehr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:54 INFO - PID 20869 | RSS: Main: 155459584 11:28:54 INFO - PID 20869 | 11:31:58 INFO - PID 20869 | Cycle 1(1): loaded http://localhost:47556/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47556/tests/dromaeo/cssquery-ext.html) 11:32:00 INFO - PID 20869 | RSS: Main: 165642240 11:32:00 INFO - PID 20869 | 11:33:42 INFO - PID 20869 | ************************* 11:33:42 INFO - PID 20869 | A coding exception was thrown and uncaught in a Task. 11:33:42 INFO - PID 20869 | 11:33:42 ERROR - PID 20869 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:33:42 INFO - PID 20869 | Full stack: 11:33:42 INFO - PID 20869 | ************************* 11:35:02 INFO - PID 20869 | Cycle 1(1): loaded http://localhost:47556/tests/dromaeo/cssquery-ext.html (next: http://localhost:47556/tests/dromaeo/cssquery-jquery.html) 11:35:03 INFO - PID 20869 | RSS: Main: 161140736 11:35:03 INFO - PID 20869 | 11:38:05 INFO - PID 20869 | Cycle 1(1): loaded http://localhost:47556/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47556/tests/dromaeo/cssquery-mootools.html) 11:38:06 INFO - PID 20869 | RSS: Main: 169132032 11:38:06 INFO - PID 20869 | 11:41:07 INFO - PID 20869 | Cycle 1(1): loaded http://localhost:47556/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47556/tests/dromaeo/cssquery-prototype.html) 11:41:08 INFO - PID 20869 | RSS: Main: 160743424 11:41:08 INFO - PID 20869 | 11:44:11 INFO - PID 20869 | Cycle 1(1): loaded http://localhost:47556/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47556/tests/dromaeo/cssquery-yui.html) 11:44:12 INFO - PID 20869 | RSS: Main: 168361984 11:44:12 INFO - PID 20869 | 11:47:15 INFO - PID 20869 | Cycle 1(1): loaded http://localhost:47556/tests/dromaeo/cssquery-yui.html (next: http://localhost:47556/tests/dromaeo/cssquery-dojo.html) 11:47:15 INFO - PID 20869 | RSS: Main: 161718272 11:47:15 INFO - PID 20869 | 11:47:15 INFO - PID 20869 | __start_tp_report 11:47:15 INFO - PID 20869 | _x_x_mozilla_page_load 11:47:15 INFO - PID 20869 | _x_x_mozilla_page_load_details 11:47:15 INFO - PID 20869 | |i|pagename|runs| 11:47:15 INFO - PID 20869 | |0;dojo.html;2728.1406356997545;2748.1343376836307;2755.50400927833;2764.5853122031695;2780.6107144999696;5020.146575082235;5160.0711871863;5178.896422071556;5213.635045546814;5215.556677682397;5037.77330020149;5153.922691159635;5177.094008548498;5219;5224.8693782655455;4699.90600187996;4715.12770137524;4745.09843129806;4758.833440829571;4783;4773.856784296477;4798.688085274463;4827.56551910328;4838.443578988426;4874.366332376786;4682.227432473638;4727.385439892826;4741.241401375763;4749.121412538657;4756.7859446325;4633.7914793834025;4637.211674015425;4637.443506779175;4677.812887484497;4682;4527.456705195397;4575.405197324327;4616.676832621718;4625.4911959684405;4650.581447669692;4942.827001054981;5012.674176178537;5050.545450909399;5051.696898186121;5140.665856719302;5556.16657501374;5575.804846830341;5580.414056524088;5614.27014488118;5649.745761440745;5599.32808063031;5599.776008959637;5609.803656872031;5614.719264036782;5627.662340259557;4968.0312339093525;5015;5021.824236151717;5175.249588809676;5279.577633789288;5498.3127109111365;5519.889602207933;5527.032769265363;5528.364238112668;5534.86162845924;5384.973075134678;5448.482394172547;5463.562914966793;5481.985832620978;5511.862203444946;5476.288082549243;5569.637973531708;5574.442555744393;5580.944190558123;5584.888302233932;5295.046891559479;5361.035013697494;5445.782168713286;5501.889962200814;5579.302587176603;5464.972675136599;5482.068048431696;5488.423715509894;5537.280153580009;5549.445055494418;4643.024964757439;4662.393888794435;4668.11305851887;4673.275642275453;4728.976355118202;3922.3135951208997;4026.7785271809744;4040.313146765057;4067.491563554556;4075.49056367954;4522.615577675869;4716.952830471651;4747.2879068140055;4747.596454301354;4771.23660214364;5544.833654990357;5554.250176226158;5582.218489411485;5582.609217354828;5586.804461843816;4736.5973892219545;4761.309610106515;4762.285657151386;4763.237881938942;4796.304535842283;4809.711417314972;4868.269759536027;4871.829485968045;4872.049950259736;4876.683015603974;5067.543921047123;5111.616628752784;5112.948870511396;5117.2068329409;5121.436641969455;5426.945730542644;5493.533049690821;5548.472895074961;5591.580631452576;5615.213870058276;5132.769025393941;5145.9965306764825;5206.088934436383;5216.269722238965;5256.658317209369;5405.189221616789;5473.504324455821;5478.178273259043;5495.368032676293;5527.2538207343105;5341.412444631165;5382.784688612568;5544.029794785815;5573.27547418833;5582.748776304995;5346;5346.251524786455;5384.946150538444;5385.380681221553;5427.6200665953;5305.31030965972;5331.70675612845;5347.812826551052;5357.785688572413;5428.348598168245;5059.367579052619;5121.615878809179;5221.712805795718;5244.187150991603;5296.867578310573;5364.14173732201;5383.946160538345;5406.567474602101;5437.293151890229;5448.918266225931;5221.008008478377;5227.477252274742;5234.738263086907;5237.319148510669;5283.524482796567 11:47:15 INFO - PID 20869 | |1;ext.html;699.699129374369;720.2149656874006;770.6493545436826;783.5455435847209;822.3215846926287;33691.32617347652;34714.65285347146;34766.65233347669;34773;34773.65226347736;30916.84541577289;31155;31267.843660781666;31276.843615781945;31396.215094622647;6254.937450625493;6399.712012959428;6402.487800975934;8920.375573709844;9152.31357648179;9109.498977556232;9147.405418647766;9251.768705782342;9264.583093760797;9268.721938341827;9171.266298696122;9271.072892710708;9292.674756383529;9292.907070929272;9295.62817487303;9374.343795934288;9429.905700943005;9478;9487.573059212353;9495.90504094957;9152.54237288133;9174.128457796498;9185.724428267162;9189.172974432333;9208.907910920872;34021.82989085063;34188.31623367544;34399.828000860085;34519.13702157441;34595.48106778401;3360.395128876801;3436.1924947637285;3451.758376913617;3454.3264063507627;3486.877959271413;22357.776422235733;22868.542629147323;22876.941075303137;23241.070357185694;23286.76713232863;3349.949750753741;3435.519027336175;3449.758516903818;3477.1828620274214;3493.68556829884;155208;155935;155990.22004890017;156244.2187789065;156952.99999999886;31387.215319617193;31652.827698599012;37209.62790372062;41217.587824121976;41314.38028429576;40948.79525602353;41827.79086104611;42000.369994450106;42105.36841947373;42214.366784498256;13070.34648267602;13099.934500327628;13110.606681799562;13113.147645403018;13135.277559734115;10656.94671526653;10673.893261067446;10685.305455145392;10686.251962362716;10718.678439646823;13169.868301317056;13189;13197.604071877859;13227.669308267177;13430.328483575977;5399.676019438846;5481.506664400144;5494.890102197934;5508.483004157006;5669.433056694297;803.3252068262688;819.5697258939105;828.2090603473669;832.812617161146;854.786303424144;21332.680009799555;22324;22506.437339066328;22520;22529.52175260753;866.757307953774;870.3950754225752;881.1540920716056;882.8278485695356;898.883145191121;11650.70873228176;12094.516219351304;12161.756764864653;12168.634940951786;12272.938635306766;237591;243940;244377;244644;244958;41324.79337603353;41815.37276940848;41823.58176418197;41840.790796046436;41888.790556047024;1211.594115971142;1249.7937840256257;1254.1785130739381;1261.6845788553046;1384.5015794314038;20541.281055163;20578.58842823105;21810;21836.781632183476;22377.552448951257;31198.844005779825;31208.843955780078;31220.531692024182;31354.52968205433;31361.686383135875;214574;215231;215360;215905;216962;21991.670124948458;22052.77947220507;25043.499130017663;25084.24747257585;28323.433531328847;29122.56316155302;29237;29409.264768380963;29593.40813183681;29610.55584166196;25368.746312536638;27296.727032729417;27498.725012749615;27647.861760691067;28101;27101.457970840078;27208.319792005357;27583.31041723973;28159.71840281653;28434.715652843206;27878.581821273103;28076.29809254785;28410.85794571014;28590.42819143647;28623.713762862106;23845.52308953846;25211.369715757253;25318.620220697074;25582.744172558036;26028.86985565136;20449.69325460149;20456.284030058876;20513.282035128697;20659;20708 11:47:15 INFO - PID 20869 | |2;jquery.html;413.80344336440174;418.2304559610316;423.64413892330447;432.7663061946549;435.26874850251573;14110.858891411082;16918.407855725036;17464.301427942883;17470.213840377164;17941;16605.169741512935;16663.75004374932;16825.242864071115;17260.136993150354;17521.474355769315;5762.711864406773;5988.1317209004665;5996.730147143389;6559.737610495575;6848.315168483162;6680.66596670167;6684.064231007663;6705.094812200339;6706.161729783777;6719.798406047827;6546.607203567777;6995.440364770831;6997.755078572251;6998.790036298919;7005.124359455068;6520.250171230275;6797.898031529531;6957.408620267283;6997.82505437363;7040.753573624924;6617.239017512999;6647.501437392215;6657.068010478537;6664;6666.866662666768;21051.157953681835;21507.46231344213;21534.89232553843;21610.35168944934;22616;2180.3349978256624;2286.8056215221727;2329.9650505242435;2353.1411034972284;2400.411899084718;13955.092918960236;14665;14813.703725925528;14837.554873353816;15137.848621513755;1841.4659748673002;1855.5175654329971;1889.6031833315021;1897.4592241211326;1908.9236430542762;87509.56245218797;87844;87963;89010.5549472255;91356.08643913543;16457.341706331852;16476.4233251838;16748.24632891523;16756;16968.321267149175;26823.329416764736;28905.855470722512;28958.27604309909;28965.986190483232;29165.270868228465;9027;9060.411073280347;9070.501122438198;9076.41003334781;9202.769930751785;7326.743563975342;7372.741954031583;7559.773206803805;7611.847763044819;7643.235676432423;9113;9255.49094799779;9509.619615215452;9542.904570954202;9597.952010240044;3734.5518537775642;3742.7754334740002;3841.654251117413;3932.174243408916;4010.5588385277597;978.2760757039739;994.1251698505414;1005.406809982114;1009.3641006166068;1012.8531362952479;19180.808191918182;19746.50633734168;22190.556188876133;22212.77787222107;22297.777022229893;874.5452364770284;877.1360210192955;877.6489404238356;878.1876763993408;881.4402854187509;6559.704813283318;6631.436327912182;6673.432758215606;6727.629980351127;6908.240093589701;488423;489684;490607;513688.1996210354;520537;83538.58230708807;84282;85531.5723421379;86035.13964860271;87788.56105719431;1111.183280288987;1149.9022583080532;1172.607176595833;1172.8592568891788;1188.423614546944;16447.506574802774;16589.83410165931;16782.66434671324;17833.375831845824;18743;41778.79110604428;42136.36795448132;42706.35940460833;43779.78110109429;44221.336679949185;53272.73363633157;53693.46306537041;54035;54669.72665136649;55832.16251756145;6474.773382931575;8130.593470326578;9748.80502389934;9980.401175929468;10425.791484170426;11644.35956022427;11659.76680466369;11697.532098715956;11800.881991179978;12080.39598020113;9006.144416280444;9361.4383137012;9368;9378.906210937803;9699.496578030417;9748.853767193355;9908.231285060781;9966;10213.387196768217;10296.639617613348;9525.428474291564;9801.80396392054;9850.507474626384;9946.055124763136;10009.099181073738;9870.605175792887;10018.64934727281;10195.7451063724;10417.166626669698;10568.947155264175;9559.091886270793;9582.137607615348;9843.507824608598;9937.055979681918;10026.598936042477 11:47:15 INFO - PID 20869 | |3;mootools.html;1401.0387180938794;1409.7039621679446;1431.270052273341;1453.1136007035707;1525.9394720669136;8276.420650554464;8508.872366914502;9029;9351.345405821587;9370.85943710844;8988.775280617987;9323.160915517603;9333.626654933794;9333.626654933794;9364.34449588529;1937.7093435984646;1948.1720268885738;1974.3879397386784;1976.8418526517844;1977.54516461214;1944.6013567218686;1996.820286174244;2004.3686238834794;2012.617602655498;2021.9898900505477;1970.753655793026;2004.4988752811796;2005.2079428625684;2041.4998325410295;2048.0476578391044;1892.8201820826998;1894.4979580411202;1901.9334323298617;1904.6857268550673;1905.199816077251;1845.7877344105332;1863.394396821025;1902.3722171683312;1947.5423275530238;1955.286320493024;9602.75993100171;9631.181349585293;9728.708138755848;9730.756731081708;9753.707388778348;4765.761711914391;4954.950450495521;4957.107720610289;4959.727215003173;4959.784852711109;2622.2133359992117;2801.4817258806984;2869.1249169003445;2871.1099559136733;2877.1224776443178;1012.6759436980169;1078.2560033576806;1093.1801149138146;1106.9576631115578;1120.960766373173;13187.934060329733;13231;13317.400716967759;13339.19964802115;13361;3923.548791888912;4122.216778812016;4204.201201771653;4211.410402543646;4379.605835474823;11523.596674116534;11556.364399958084;11587.478563464665;11590.13074019452;11628.360440175702;4943.901121977612;4997.325361076281;5006.749662516932;5032.043911656773;5060.746962651852;4275.422817919541;4376.3654270130655;4532.5694059065;4546.795394207269;4549.931751023737;3364.2598628301735;3432.7768695034742;3433.399155147889;3464.7921124732597;3511.4030614795547;913.862920561921;925.4077390470104;927.1701826865053;931.2270815223349;935.7333160049353;750.3959312753286;765.7243392378739;779.4154384211841;781.7771934998498;785.5012067337168;5364.22218778275;5425.891482170335;5471.534919531884;5573.164025396142;5578.442155784389;867.9045305016443;869.6564856881496;876.5398165962921;884.606744377595;891.6611687558686;3489.6803034677787;3588.515550400715;3660.359437098497;3725.403935370328;3801.163743976321;12250.632481025583;12335.568255111028;12676.23942563449;12681.556145534862;12707.745845083047;12293.93853030729;12322.568710095284;12327.630171094881;12331.568395106127;12334.568290109803;8787.516686582172;8882.200601945726;8977.775555611031;9059.22996545301;9203.171714545722;5470.316210473691;5529.33647962231;5599.1041433370465;5620.606557540933;5640.54875609942;10310;10372.325798823053;10394.584216631552;10493.842592360968;10631.521581529005;10781.191410644076;10869.891301087204;10956.726081847699;11020;11049.447527623426;6955.721771129098;7158.821029474305;7766.805829854299;8023.197680232163;8064.717734879251;8565.614547345509;8595.05454400028;8641.265492433213;8648.135186481302;8720.694775682821;7902.24928631779;7964.20357964199;7975.641096150804;8036.236557527026;8051.959740201261;7893.763187104396;7953.5227886327;7983.5209887406945;7992.920070799218;8068.677252909818;6673.632950187786;6783.660816959231;6823.488238382042;6828.863422731617;6903.206131294965;4825.445073816556;4912.459629440687;4952.47998960104;4978.4274808397495;5014.84955451337;4961.74449110696;5076.517730815566;5096.974515127401;5112.667676601009;5178.119719647593 11:47:15 INFO - PID 20869 | |4;prototype.html;359.5936591651433;370.8998570385996;377.04607343421145;380.77343980331693;384.6807150065444;5498.3127109111365;5501.229827824103;5542.279503664518;5545.112781954888;5587.7764889404425;5399.649022813514;5414.214938833867;5418.512333889949;5425.511703946644;5427.83716488505;4277.850275240367;4333.436653235075;4345.739255644656;4350.8912277193;4367.563243675639;4328.372386004027;4334.826606935719;4339.804708788096;4348.760388399976;4349.717268377562;4320.567943205686;4326.459192600925;4327.783610819462;4328.480582330109;4344.3917851500655;4237.258479766028;4290.056187638715;4342.739435633856;4358.651307895392;4372.540883207281;3826.3112639724836;3831.3525184170794;3869.3422118239687;3871.264459752666;3893.53277606689;5306.204069389584;5320.813771518017;5326.307580014612;5333.280007199017;5335.839924802262;4844.757762111915;4982.526659967298;4983.6013118950395;4997.2004479283505;5011.1481048221885;5655.915161272585;5662.462066103713;5703.857403564944;5705.942940570582;5722.599418040739;4247.5540068293;4257.8296868125235;4270.402143699885;4273.273543497582;4275.700700950934;5486.149646804752;5569.164625306196;5933.554983376221;6034.275886893557;6042.486388656969;5125.513076257824;5135.947130838169;5138.126518491866;5138.6814646841085;5155.226715992631;5250.159974404077;5265.4730128263145;5266.92099618506;5270.604704647167;5273.288106105703;4921.876953076202;5162.1224391853475;5227.607929405233;5369.624126311199;5441.782328706808;5688.146777983336;5690.374058853523;5706.172604972256;5719.027765279912;5720.971395142998;1665.1674162918541;1685.6881476926562;1691.222037862597;1691.9746203806953;1692.3653629888793;1204.644629834201;1248.8189212564128;1263.9557615483413;1273.4142294544613;1279.3155661720934;4964.304997300381;4975.203967365204;4975.402951645826;4980.77586508608;4982.750862456863;5857.26784151981;5896.498797602166;5905.852353691193;5919.230500035054;5969.432903874125;4816.686915350491;4879.2925025871045;4928.630352723489;4948.802047918043;4964;3111.937761244808;3133.2950086230417;3137.607799025122;3145.370925814846;3156.352947645727;5351.304330437096;5457.61796674229;5457.890842183134;5470.671759694431;5481.149182973098;5711.371749107595;5903.409659034062;5954.940450595439;5961;6007.219061522062;5402.945970540323;5481.835544933659;5483.232347471358;5499.780008799603;5517.227588137664;5908.970455147697;5941.702914854326;5954.732037058429;5958.255218097738;5990.311114221746;5633.324001119892;5759.596828221985;5794.82615521535;5817.214676018683;5838.854028649318;5476.507114359727;5508.807191748269;5521.668699878021;5529.972350138223;5539.279893613965;4527.139843429738;4705.670603057753;4720;4725.653188841164;4737.573618374363;5907.202527658711;5925.170476133431;5928.658180018954;5935.317438494629;5960.105984102419;5641.6050876439895;5641.887162256814;5647.435256474319;5651.208830763779;5659.462351076641;5548.528375088002;5558.249636299048;5622.634528755618;5664.716764161858;5686.744096515749;5564.693941833076;5579.572885794692;5595.468430499096;5596.468335508121;5613.550915926634;5615.298087739033;5708.372079071216;5726.942730572641;5747.683877386784;5749.97125014389;5514.228008078952;5518.88183176504;5522.502974732293;5541.307336582927;5584.329880414376 11:47:15 INFO - PID 20869 | |5;yui.html;675.4056430341299;677.881370760117;684.9828754281142;684.9897251541228;698.7414656577066;11902.940485297573;12412.937935310334;12501.874981250185;12523.812142817866;12544.37278136094;12441.875581244185;12496.375181240946;12510.437030333656;12554.183978041443;12610.684732881682;825.4263287015526;829.9170082991698;844.7254642241265;847.9067302596709;860.114082495028;869.1916517638593;869.7347309070731;870.0559892516595;870.7431307764193;871.6949067826242;895.7760559860035;896.3501461440469;896.901340852509;899.2356496977582;902.264654306738;891.9910800891973;893.0489029183898;894.150556970877;894.6600291889106;895.0825403960927;654.4077609763171;658.799066284783;659.152988409891;659.7262136213466;660.1022609251414;13957.651058723512;13991.510297139654;14017.43930242789;14025.579232623038;14629.561113166623;13316.86683133166;13779.931100344535;13936.860631393658;14002.92998535011;14181.93635477333;10039.648612298608;10278.640247591298;10346.12057975073;10488.31825931312;10635.787284254271;3143.3713257348395;3173.428782819092;3231.919202019945;3285.0473362724783;3349.8492567834505;55520.16719749207;55945.720271398786;56096.99999999959;56563.15155272674;58273;10069.69790906274;10188.694339169837;10270.33242839228;10490.370577765207;10859.457027148612;19787.208511659373;19932.402027939184;19978;19988.700169497468;20012.099455524538;6495.707693153725;6596.142501474777;6701.363370479797;6863.759768408082;6891.620960847202;3461.2039230977016;3464.497647841049;3465.341585098823;3497.0208341664375;3579.6599323064265;2882.6684931233176;2942.087952734659;2968.257935516121;2974.1523665755158;2976.523756199041;495.9330490383752;497.34847349971653;501.5786739139141;508.8066534716784;509.3149713635155;593.664579512574;622.4273668225244;632.2065807411669;635.4249404289126;636.700750647195;8219.794505137419;8506.61720222579;8615;8889.727084584407;9106.908930910606;589.5548860610212;593.6868649263107;608.4645511949457;610.2646311194999;614.1555361378105;4283.2932566126865;4288.764117973541;4331.610155085994;4342.6308763754805;4393.221148345773;60240.698796505734;60539;61714;63137;63240.68379658072;52568.474315257125;54243.18635220475;54273.45726542684;55028.449715503135;55449;48508.757456212494;49260;49810.50189498131;50040.49959500431;51039.489605104216;7743;8146.470479418819;8160.5511696854865;8302.377321701017;8320.084790673141;33824.323513529096;34284.48573271353;34848.65151348556;35411.645883540834;35702.28595428025;39122.608773911896;39529.80235098806;40384.39423408592;41769.164616708105;41921.161576767685;9841.409515429097;10359.689209323733;10428.530716117944;10566.788664226826;10608.840867387149;10544.314619549705;10705.785884282426;10706.518206680874;10894.400807955639;11406.828897566376;9778.9022109778;9930.702078937644;9949.253805964438;10048.84926726085;10495.947520262349;10399.48002599882;10563.15494760402;10581.4709264538;10852.077573406348;10891.891081089088;10559.841602375816;10575.471226438802;10745.301555398873;10825.079868210974;11091.279066860629;8774.4296620722;9004.954975225082;9300.813983720423;9357.85963210566;9370.67202647904;8681.331842861846;9111.817763644822;9212.861807073034;9372.828396450444;9522.714318570454 11:47:15 INFO - PID 20869 | __end_tp_report 11:47:15 INFO - PID 20869 | __start_cc_report 11:47:15 INFO - PID 20869 | _x_x_mozilla_cycle_collect,385 11:47:15 INFO - PID 20869 | __end_cc_report 11:47:15 INFO - PID 20869 | __startTimestamp1489776435546__endTimestamp 11:47:15 INFO - PID 20869 | 11:47:15 INFO - PID 20869 | ------- Summary: start ------- 11:47:15 INFO - PID 20869 | Number of tests: 6 11:47:15 INFO - PID 20869 | 11:47:15 INFO - PID 20869 | [#0] dojo.html Cycles:165 Average:5072.67 Median:5216.27 stddev:560.43 (10.7%) stddev-sans-first:531.12 11:47:15 INFO - PID 20869 | Values: 2728.1 2748.1 2755.5 2764.6 2780.6 5020.1 5160.1 5178.9 5213.6 5215.6 5037.8 5153.9 5177.1 5219.0 5224.9 4699.9 4715.1 4745.1 4758.8 4783.0 4773.9 4798.7 4827.6 4838.4 4874.4 4682.2 4727.4 4741.2 4749.1 4756.8 4633.8 4637.2 4637.4 4677.8 4682.0 4527.5 4575.4 4616.7 4625.5 4650.6 4942.8 5012.7 5050.5 5051.7 5140.7 5556.2 5575.8 5580.4 5614.3 5649.7 5599.3 5599.8 5609.8 5614.7 5627.7 4968.0 5015.0 5021.8 5175.2 5279.6 5498.3 5519.9 5527.0 5528.4 5534.9 5385.0 5448.5 5463.6 5482.0 5511.9 5476.3 5569.6 5574.4 5580.9 5584.9 5295.0 5361.0 5445.8 5501.9 5579.3 5465.0 5482.1 5488.4 5537.3 5549.4 4643.0 4662.4 4668.1 4673.3 4729.0 3922.3 4026.8 4040.3 4067.5 4075.5 4522.6 4717.0 4747.3 4747.6 4771.2 5544.8 5554.3 5582.2 5582.6 5586.8 4736.6 4761.3 4762.3 4763.2 4796.3 4809.7 4868.3 4871.8 4872.0 4876.7 5067.5 5111.6 5112.9 5117.2 5121.4 5426.9 5493.5 5548.5 5591.6 5615.2 5132.8 5146.0 5206.1 5216.3 5256.7 5405.2 5473.5 5478.2 5495.4 5527.3 5341.4 5382.8 5544.0 5573.3 5582.7 5346.0 5346.3 5384.9 5385.4 5427.6 5305.3 5331.7 5347.8 5357.8 5428.3 5059.4 5121.6 5221.7 5244.2 5296.9 5364.1 5383.9 5406.6 5437.3 5448.9 5221.0 5227.5 5234.7 5237.3 5283.5 11:47:15 INFO - PID 20869 | 11:47:15 INFO - PID 20869 | [#1] ext.html Cycles:180 Average:34040.48 Median:31035.92 stddev:54102.44 (174.3%) stddev-sans-first:54196.29 11:47:15 INFO - PID 20869 | Values: 699.7 720.2 770.6 783.5 822.3 33691.3 34714.7 34766.7 34773.0 34773.7 30916.8 31155.0 31267.8 31276.8 31396.2 6254.9 6399.7 6402.5 8920.4 9152.3 9109.5 9147.4 9251.8 9264.6 9268.7 9171.3 9271.1 9292.7 9292.9 9295.6 9374.3 9429.9 9478.0 9487.6 9495.9 9152.5 9174.1 9185.7 9189.2 9208.9 34021.8 34188.3 34399.8 34519.1 34595.5 3360.4 3436.2 3451.8 3454.3 3486.9 22357.8 22868.5 22876.9 23241.1 23286.8 3349.9 3435.5 3449.8 3477.2 3493.7 155208.0 155935.0 155990.2 156244.2 156953.0 31387.2 31652.8 37209.6 41217.6 41314.4 40948.8 41827.8 42000.4 42105.4 42214.4 13070.3 13099.9 13110.6 13113.1 13135.3 10656.9 10673.9 10685.3 10686.3 10718.7 13169.9 13189.0 13197.6 13227.7 13430.3 5399.7 5481.5 5494.9 5508.5 5669.4 803.3 819.6 828.2 832.8 854.8 21332.7 22324.0 22506.4 22520.0 22529.5 866.8 870.4 881.2 882.8 898.9 11650.7 12094.5 12161.8 12168.6 12272.9 237591.0 243940.0 244377.0 244644.0 244958.0 41324.8 41815.4 41823.6 41840.8 41888.8 1211.6 1249.8 1254.2 1261.7 1384.5 20541.3 20578.6 21810.0 21836.8 22377.6 31198.8 31208.8 31220.5 31354.5 31361.7 214574.0 215231.0 215360.0 215905.0 216962.0 21991.7 22052.8 25043.5 25084.2 28323.4 29122.6 29237.0 29409.3 29593.4 29610.6 25368.7 27296.7 27498.7 27647.9 28101.0 27101.5 27208.3 27583.3 28159.7 28434.7 27878.6 28076.3 28410.9 28590.4 28623.7 23845.5 25211.4 25318.6 25582.7 26028.9 20449.7 20456.3 20513.3 20659.0 20708.0 11:47:15 INFO - PID 20869 | 11:47:15 INFO - PID 20869 | [#2] jquery.html Cycles:180 Average:29812.07 Median:517112.60 stddev:82400.82 (15.9%) stddev-sans-first:82602.41 11:47:15 INFO - PID 20869 | Values: 413.8 418.2 423.6 432.8 435.3 14110.9 16918.4 17464.3 17470.2 17941.0 16605.2 16663.8 16825.2 17260.1 17521.5 5762.7 5988.1 5996.7 6559.7 6848.3 6680.7 6684.1 6705.1 6706.2 6719.8 6546.6 6995.4 6997.8 6998.8 7005.1 6520.3 6797.9 6957.4 6997.8 7040.8 6617.2 6647.5 6657.1 6664.0 6666.9 21051.2 21507.5 21534.9 21610.4 22616.0 2180.3 2286.8 2330.0 2353.1 2400.4 13955.1 14665.0 14813.7 14837.6 15137.8 1841.5 1855.5 1889.6 1897.5 1908.9 87509.6 87844.0 87963.0 89010.6 91356.1 16457.3 16476.4 16748.2 16756.0 16968.3 26823.3 28905.9 28958.3 28966.0 29165.3 9027.0 9060.4 9070.5 9076.4 9202.8 7326.7 7372.7 7559.8 7611.8 7643.2 9113.0 9255.5 9509.6 9542.9 9598.0 3734.6 3742.8 3841.7 3932.2 4010.6 978.3 994.1 1005.4 1009.4 1012.9 19180.8 19746.5 22190.6 22212.8 22297.8 874.5 877.1 877.6 878.2 881.4 6559.7 6631.4 6673.4 6727.6 6908.2 488423.0 489684.0 490607.0 513688.2 520537.0 83538.6 84282.0 85531.6 86035.1 87788.6 1111.2 1149.9 1172.6 1172.9 1188.4 16447.5 16589.8 16782.7 17833.4 18743.0 41778.8 42136.4 42706.4 43779.8 44221.3 53272.7 53693.5 54035.0 54669.7 55832.2 6474.8 8130.6 9748.8 9980.4 10425.8 11644.4 11659.8 11697.5 11800.9 12080.4 9006.1 9361.4 9368.0 9378.9 9699.5 9748.9 9908.2 9966.0 10213.4 10296.6 9525.4 9801.8 9850.5 9946.1 10009.1 9870.6 10018.6 10195.7 10417.2 10568.9 9559.1 9582.1 9843.5 9937.1 10026.6 11:47:15 INFO - PID 20869 | 11:47:15 INFO - PID 20869 | [#3] mootools.html Cycles:180 Average:5870.73 Median:4795.60 stddev:3771.20 (78.6%) stddev-sans-first:3766.83 11:47:15 INFO - PID 20869 | Values: 1401.0 1409.7 1431.3 1453.1 1525.9 8276.4 8508.9 9029.0 9351.3 9370.9 8988.8 9323.2 9333.6 9333.6 9364.3 1937.7 1948.2 1974.4 1976.8 1977.5 1944.6 1996.8 2004.4 2012.6 2022.0 1970.8 2004.5 2005.2 2041.5 2048.0 1892.8 1894.5 1901.9 1904.7 1905.2 1845.8 1863.4 1902.4 1947.5 1955.3 9602.8 9631.2 9728.7 9730.8 9753.7 4765.8 4955.0 4957.1 4959.7 4959.8 2622.2 2801.5 2869.1 2871.1 2877.1 1012.7 1078.3 1093.2 1107.0 1121.0 13187.9 13231.0 13317.4 13339.2 13361.0 3923.5 4122.2 4204.2 4211.4 4379.6 11523.6 11556.4 11587.5 11590.1 11628.4 4943.9 4997.3 5006.7 5032.0 5060.7 4275.4 4376.4 4532.6 4546.8 4549.9 3364.3 3432.8 3433.4 3464.8 3511.4 913.9 925.4 927.2 931.2 935.7 750.4 765.7 779.4 781.8 785.5 5364.2 5425.9 5471.5 5573.2 5578.4 867.9 869.7 876.5 884.6 891.7 3489.7 3588.5 3660.4 3725.4 3801.2 12250.6 12335.6 12676.2 12681.6 12707.7 12293.9 12322.6 12327.6 12331.6 12334.6 8787.5 8882.2 8977.8 9059.2 9203.2 5470.3 5529.3 5599.1 5620.6 5640.5 10310.0 10372.3 10394.6 10493.8 10631.5 10781.2 10869.9 10956.7 11020.0 11049.4 6955.7 7158.8 7766.8 8023.2 8064.7 8565.6 8595.1 8641.3 8648.1 8720.7 7902.2 7964.2 7975.6 8036.2 8052.0 7893.8 7953.5 7983.5 7992.9 8068.7 6673.6 6783.7 6823.5 6828.9 6903.2 4825.4 4912.5 4952.5 4978.4 5014.8 4961.7 5076.5 5097.0 5112.7 5178.1 11:47:15 INFO - PID 20869 | 11:47:15 INFO - PID 20869 | [#4] prototype.html Cycles:180 Average:4848.54 Median:5401.30 stddev:1315.19 (24.3%) stddev-sans-first:1274.99 11:47:15 INFO - PID 20869 | Values: 359.6 370.9 377.0 380.8 384.7 5498.3 5501.2 5542.3 5545.1 5587.8 5399.6 5414.2 5418.5 5425.5 5427.8 4277.9 4333.4 4345.7 4350.9 4367.6 4328.4 4334.8 4339.8 4348.8 4349.7 4320.6 4326.5 4327.8 4328.5 4344.4 4237.3 4290.1 4342.7 4358.7 4372.5 3826.3 3831.4 3869.3 3871.3 3893.5 5306.2 5320.8 5326.3 5333.3 5335.8 4844.8 4982.5 4983.6 4997.2 5011.1 5655.9 5662.5 5703.9 5705.9 5722.6 4247.6 4257.8 4270.4 4273.3 4275.7 5486.1 5569.2 5933.6 6034.3 6042.5 5125.5 5135.9 5138.1 5138.7 5155.2 5250.2 5265.5 5266.9 5270.6 5273.3 4921.9 5162.1 5227.6 5369.6 5441.8 5688.1 5690.4 5706.2 5719.0 5721.0 1665.2 1685.7 1691.2 1692.0 1692.4 1204.6 1248.8 1264.0 1273.4 1279.3 4964.3 4975.2 4975.4 4980.8 4982.8 5857.3 5896.5 5905.9 5919.2 5969.4 4816.7 4879.3 4928.6 4948.8 4964.0 3111.9 3133.3 3137.6 3145.4 3156.4 5351.3 5457.6 5457.9 5470.7 5481.1 5711.4 5903.4 5954.9 5961.0 6007.2 5402.9 5481.8 5483.2 5499.8 5517.2 5909.0 5941.7 5954.7 5958.3 5990.3 5633.3 5759.6 5794.8 5817.2 5838.9 5476.5 5508.8 5521.7 5530.0 5539.3 4527.1 4705.7 4720.0 4725.7 4737.6 5907.2 5925.2 5928.7 5935.3 5960.1 5641.6 5641.9 5647.4 5651.2 5659.5 5548.5 5558.2 5622.6 5664.7 5686.7 5564.7 5579.6 5595.5 5596.5 5613.6 5615.3 5708.4 5726.9 5747.7 5750.0 5514.2 5518.9 5522.5 5541.3 5584.3 11:47:15 INFO - PID 20869 | 11:47:15 INFO - PID 20869 | [#5] yui.html Cycles:180 Average:14064.08 Median:49925.50 stddev:17084.92 (34.2%) stddev-sans-first:17103.27 11:47:15 INFO - PID 20869 | Values: 675.4 677.9 685.0 685.0 698.7 11902.9 12412.9 12501.9 12523.8 12544.4 12441.9 12496.4 12510.4 12554.2 12610.7 825.4 829.9 844.7 847.9 860.1 869.2 869.7 870.1 870.7 871.7 895.8 896.4 896.9 899.2 902.3 892.0 893.0 894.2 894.7 895.1 654.4 658.8 659.2 659.7 660.1 13957.7 13991.5 14017.4 14025.6 14629.6 13316.9 13779.9 13936.9 14002.9 14181.9 10039.6 10278.6 10346.1 10488.3 10635.8 3143.4 3173.4 3231.9 3285.0 3349.8 55520.2 55945.7 56097.0 56563.2 58273.0 10069.7 10188.7 10270.3 10490.4 10859.5 19787.2 19932.4 19978.0 19988.7 20012.1 6495.7 6596.1 6701.4 6863.8 6891.6 3461.2 3464.5 3465.3 3497.0 3579.7 2882.7 2942.1 2968.3 2974.2 2976.5 495.9 497.3 501.6 508.8 509.3 593.7 622.4 632.2 635.4 636.7 8219.8 8506.6 8615.0 8889.7 9106.9 589.6 593.7 608.5 610.3 614.2 4283.3 4288.8 4331.6 4342.6 4393.2 60240.7 60539.0 61714.0 63137.0 63240.7 52568.5 54243.2 54273.5 55028.4 55449.0 48508.8 49260.0 49810.5 50040.5 51039.5 7743.0 8146.5 8160.6 8302.4 8320.1 33824.3 34284.5 34848.7 35411.6 35702.3 39122.6 39529.8 40384.4 41769.2 41921.2 9841.4 10359.7 10428.5 10566.8 10608.8 10544.3 10705.8 10706.5 10894.4 11406.8 9778.9 9930.7 9949.3 10048.8 10495.9 10399.5 10563.2 10581.5 10852.1 10891.9 10559.8 10575.5 10745.3 10825.1 11091.3 8774.4 9005.0 9300.8 9357.9 9370.7 8681.3 9111.8 9212.9 9372.8 9522.7 11:47:15 INFO - PID 20869 | -------- Summary: end -------- 11:47:15 INFO - PID 20869 | 11:47:16 INFO - TEST-INFO | 20869: exit 0 11:47:16 INFO - TEST-OK | dromaeo_css | took 1120614ms 11:47:16 INFO - TEST-START | kraken 11:47:16 INFO - operating with platform_type : linux_ 11:47:16 INFO - Initialising browser for kraken test... 11:47:16 INFO - TEST-INFO | started process 21249 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC8oTds/profile http://localhost:47556/getInfo.html) 11:47:20 INFO - PID 21249 | __metrics Screen width/height:1600/1200 11:47:20 INFO - PID 21249 | colorDepth:24 11:47:20 INFO - PID 21249 | Browser inner width/height: 1024/697 11:47:20 INFO - PID 21249 | __metrics 11:47:21 ERROR - PID 21249 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 11:47:22 INFO - TEST-INFO | 21249: exit 0 11:47:22 INFO - Browser initialized. 11:47:22 INFO - Running cycle 1/1 for kraken test... 11:47:22 INFO - TEST-INFO | started process 21376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC8oTds/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:34 INFO - PID 21376 | RSS: Main: 154845184 11:47:34 INFO - PID 21376 | 11:47:37 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47556/tests/kraken/driver.html?testName=audio-beat-detection) 11:47:38 INFO - PID 21376 | RSS: Main: 160321536 11:47:38 INFO - PID 21376 | 11:47:40 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47556/tests/kraken/driver.html?testName=audio-dft) 11:47:41 INFO - PID 21376 | RSS: Main: 159997952 11:47:41 INFO - PID 21376 | 11:47:44 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47556/tests/kraken/driver.html?testName=audio-fft) 11:47:45 INFO - PID 21376 | RSS: Main: 156889088 11:47:45 INFO - PID 21376 | 11:47:47 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47556/tests/kraken/driver.html?testName=audio-oscillator) 11:47:47 INFO - PID 21376 | RSS: Main: 157618176 11:47:47 INFO - PID 21376 | 11:47:50 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47556/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:47:50 INFO - PID 21376 | RSS: Main: 158060544 11:47:50 INFO - PID 21376 | 11:47:53 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47556/tests/kraken/driver.html?testName=imaging-darkroom) 11:47:54 INFO - PID 21376 | RSS: Main: 163995648 11:47:54 INFO - PID 21376 | 11:47:58 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47556/tests/kraken/driver.html?testName=imaging-desaturate) 11:47:58 INFO - PID 21376 | RSS: Main: 161443840 11:47:58 INFO - PID 21376 | 11:48:01 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47556/tests/kraken/driver.html?testName=json-parse-financial) 11:48:02 INFO - PID 21376 | RSS: Main: 161918976 11:48:02 INFO - PID 21376 | 11:48:04 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47556/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:48:04 INFO - PID 21376 | RSS: Main: 162045952 11:48:04 INFO - PID 21376 | 11:48:06 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47556/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:48:07 INFO - PID 21376 | RSS: Main: 162185216 11:48:07 INFO - PID 21376 | 11:48:09 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47556/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:48:10 INFO - PID 21376 | RSS: Main: 162525184 11:48:10 INFO - PID 21376 | 11:48:12 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:48:13 INFO - PID 21376 | RSS: Main: 164130816 11:48:13 INFO - PID 21376 | 11:48:16 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:48:17 INFO - PID 21376 | RSS: Main: 162869248 11:48:17 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | Cycle 1(1): loaded http://localhost:47556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47556/tests/kraken/driver.html?testName=ai-astar) 11:48:19 INFO - PID 21376 | RSS: Main: 165068800 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | __start_tp_report 11:48:19 INFO - PID 21376 | _x_x_mozilla_page_load 11:48:19 INFO - PID 21376 | _x_x_mozilla_page_load_details 11:48:19 INFO - PID 21376 | |i|pagename|runs| 11:48:19 INFO - PID 21376 | |0;ai-astar;113;121;121;120;119;120;117;127;120;119 11:48:19 INFO - PID 21376 | |1;audio-beat-detection;149;131;128;175;129;127;125;126;146;128 11:48:19 INFO - PID 21376 | |2;audio-dft;166;165;164;169;171;168;162;166;163;162 11:48:19 INFO - PID 21376 | |3;audio-fft;87;77;77;112;75;76;78;75;91;75 11:48:19 INFO - PID 21376 | |4;audio-oscillator;86;87;108;85;85;85;101;85;85;110 11:48:19 INFO - PID 21376 | |5;imaging-gaussian-blur;118;115;114;114;114;123;117;114;114;114 11:48:19 INFO - PID 21376 | |6;imaging-darkroom;151;149;151;150;151;152;151;150;152;150 11:48:19 INFO - PID 21376 | |7;imaging-desaturate;94;95;94;94;94;95;94;95;95;94 11:48:19 INFO - PID 21376 | |8;json-parse-financial;67;68;67;68;69;68;71;69;69;69 11:48:19 INFO - PID 21376 | |9;json-stringify-tinderbox;55;56;56;56;55;56;55;56;56;55 11:48:19 INFO - PID 21376 | |10;stanford-crypto-aes;84;84;89;83;84;84;83;91;83;82 11:48:19 INFO - PID 21376 | |11;stanford-crypto-ccm;140;134;148;134;133;145;143;138;190;147 11:48:19 INFO - PID 21376 | |12;stanford-crypto-pbkdf2;186;200;188;197;201;197;203;198;198;186 11:48:19 INFO - PID 21376 | |13;stanford-crypto-sha256-iterative;75;73;72;74;75;72;72;73;70;72 11:48:19 INFO - PID 21376 | __end_tp_report 11:48:19 INFO - PID 21376 | __start_cc_report 11:48:19 INFO - PID 21376 | _x_x_mozilla_cycle_collect,901 11:48:19 INFO - PID 21376 | __end_cc_report 11:48:19 INFO - PID 21376 | __startTimestamp1489776499640__endTimestamp 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | ------- Summary: start ------- 11:48:19 INFO - PID 21376 | Number of tests: 14 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#0] ai-astar Cycles:10 Average:119.70 Median:120.00 stddev:3.50 (2.9%) stddev-sans-first:2.74 11:48:19 INFO - PID 21376 | Values: 113.0 121.0 121.0 120.0 119.0 120.0 117.0 127.0 120.0 119.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:130.00 stddev:15.96 (12.3%) stddev-sans-first:16.26 11:48:19 INFO - PID 21376 | Values: 149.0 131.0 128.0 175.0 129.0 127.0 125.0 126.0 146.0 128.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#2] audio-dft Cycles:10 Average:165.60 Median:166.00 stddev:3.03 (1.8%) stddev-sans-first:3.21 11:48:19 INFO - PID 21376 | Values: 166.0 165.0 164.0 169.0 171.0 168.0 162.0 166.0 163.0 162.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#3] audio-fft Cycles:10 Average:82.30 Median:77.00 stddev:11.80 (15.3%) stddev-sans-first:12.40 11:48:19 INFO - PID 21376 | Values: 87.0 77.0 77.0 112.0 75.0 76.0 78.0 75.0 91.0 75.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:85.00 stddev:10.36 (12.2%) stddev-sans-first:10.78 11:48:19 INFO - PID 21376 | Values: 86.0 87.0 108.0 85.0 85.0 85.0 101.0 85.0 85.0 110.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:114.50 stddev:2.95 (2.6%) stddev-sans-first:3.00 11:48:19 INFO - PID 21376 | Values: 118.0 115.0 114.0 114.0 114.0 123.0 117.0 114.0 114.0 114.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 11:48:19 INFO - PID 21376 | Values: 151.0 149.0 151.0 150.0 151.0 152.0 151.0 150.0 152.0 150.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:48:19 INFO - PID 21376 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:69.00 stddev:1.18 (1.7%) stddev-sans-first:1.12 11:48:19 INFO - PID 21376 | Values: 67.0 68.0 67.0 68.0 69.0 68.0 71.0 69.0 69.0 69.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 11:48:19 INFO - PID 21376 | Values: 55.0 56.0 56.0 56.0 55.0 56.0 55.0 56.0 56.0 55.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:2.91 (3.5%) stddev-sans-first:3.07 11:48:19 INFO - PID 21376 | Values: 84.0 84.0 89.0 83.0 84.0 84.0 83.0 91.0 83.0 82.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:144.00 stddev:16.67 (11.6%) stddev-sans-first:17.58 11:48:19 INFO - PID 21376 | Values: 140.0 134.0 148.0 134.0 133.0 145.0 143.0 138.0 190.0 147.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.40 Median:198.00 stddev:6.33 (3.2%) stddev-sans-first:5.73 11:48:19 INFO - PID 21376 | Values: 186.0 200.0 188.0 197.0 201.0 197.0 203.0 198.0 198.0 186.0 11:48:19 INFO - PID 21376 | 11:48:19 INFO - PID 21376 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:1.55 (2.1%) stddev-sans-first:1.42 11:48:19 INFO - PID 21376 | Values: 75.0 73.0 72.0 74.0 75.0 72.0 72.0 73.0 70.0 72.0 11:48:19 INFO - PID 21376 | -------- Summary: end -------- 11:48:19 INFO - PID 21376 | 11:48:20 INFO - TEST-INFO | 21376: exit 0 11:48:20 INFO - TEST-OK | kraken | took 64415ms 11:48:20 INFO - SUITE-END | took 1185s 11:48:21 INFO - Completed test suite (00:19:45) 11:48:21 INFO - javascript benchmark 11:48:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6715.402121491417, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2728.1406356997545, 2748.1343376836307, 2755.50400927833, 2764.5853122031695, 2780.6107144999696, 5020.146575082235, 5160.0711871863, 5178.896422071556, 5213.635045546814, 5215.556677682397, 5037.77330020149, 5153.922691159635, 5177.094008548498, 5219.0, 5224.8693782655455, 4699.90600187996, 4715.12770137524, 4745.09843129806, 4758.833440829571, 4783.0, 4773.856784296477, 4798.688085274463, 4827.56551910328, 4838.443578988426, 4874.366332376786, 4682.227432473638, 4727.385439892826, 4741.241401375763, 4749.121412538657, 4756.7859446325, 4633.7914793834025, 4637.211674015425, 4637.443506779175, 4677.812887484497, 4682.0, 4527.456705195397, 4575.405197324327, 4616.676832621718, 4625.4911959684405, 4650.581447669692, 4942.827001054981, 5012.674176178537, 5050.545450909399, 5051.696898186121, 5140.665856719302, 5556.16657501374, 5575.804846830341, 5580.414056524088, 5614.27014488118, 5649.745761440745, 5599.32808063031, 5599.776008959637, 5609.803656872031, 5614.719264036782, 5627.662340259557, 4968.0312339093525, 5015.0, 5021.824236151717, 5175.249588809676, 5279.577633789288, 5498.3127109111365, 5519.889602207933, 5527.032769265363, 5528.364238112668, 5534.86162845924, 5384.973075134678, 5448.482394172547, 5463.562914966793, 5481.985832620978, 5511.862203444946, 5476.288082549243, 5569.637973531708, 5574.442555744393, 5580.944190558123, 5584.888302233932, 5295.046891559479, 5361.035013697494, 5445.782168713286, 5501.889962200814, 5579.302587176603, 5464.972675136599, 5482.068048431696, 5488.423715509894, 5537.280153580009, 5549.445055494418, 4643.024964757439, 4662.393888794435, 4668.11305851887, 4673.275642275453, 4728.976355118202, 3922.3135951208997, 4026.7785271809744, 4040.313146765057, 4067.491563554556, 4075.49056367954, 4522.615577675869, 4716.952830471651, 4747.2879068140055, 4747.596454301354, 4771.23660214364, 5544.833654990357, 5554.250176226158, 5582.218489411485, 5582.609217354828, 5586.804461843816, 4736.5973892219545, 4761.309610106515, 4762.285657151386, 4763.237881938942, 4796.304535842283, 4809.711417314972, 4868.269759536027, 4871.829485968045, 4872.049950259736, 4876.683015603974, 5067.543921047123, 5111.616628752784, 5112.948870511396, 5117.2068329409, 5121.436641969455, 5426.945730542644, 5493.533049690821, 5548.472895074961, 5591.580631452576, 5615.213870058276, 5132.769025393941, 5145.9965306764825, 5206.088934436383, 5216.269722238965, 5256.658317209369, 5405.189221616789, 5473.504324455821, 5478.178273259043, 5495.368032676293, 5527.2538207343105, 5341.412444631165, 5382.784688612568, 5544.029794785815, 5573.27547418833, 5582.748776304995, 5346.0, 5346.251524786455, 5384.946150538444, 5385.380681221553, 5427.6200665953, 5305.31030965972, 5331.70675612845, 5347.812826551052, 5357.785688572413, 5428.348598168245, 5059.367579052619, 5121.615878809179, 5221.712805795718, 5244.187150991603, 5296.867578310573, 5364.14173732201, 5383.946160538345, 5406.567474602101, 5437.293151890229, 5448.918266225931, 5221.008008478377, 5227.477252274742, 5234.738263086907, 5237.319148510669, 5283.524482796567], "value": 5034.48803224032, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.699129374369, 720.2149656874006, 770.6493545436826, 783.5455435847209, 822.3215846926287, 33691.32617347652, 34714.65285347146, 34766.65233347669, 34773.0, 34773.65226347736, 30916.84541577289, 31155.0, 31267.843660781666, 31276.843615781945, 31396.215094622647, 6254.937450625493, 6399.712012959428, 6402.487800975934, 8920.375573709844, 9152.31357648179, 9109.498977556232, 9147.405418647766, 9251.768705782342, 9264.583093760797, 9268.721938341827, 9171.266298696122, 9271.072892710708, 9292.674756383529, 9292.907070929272, 9295.62817487303, 9374.343795934288, 9429.905700943005, 9478.0, 9487.573059212353, 9495.90504094957, 9152.54237288133, 9174.128457796498, 9185.724428267162, 9189.172974432333, 9208.907910920872, 34021.82989085063, 34188.31623367544, 34399.828000860085, 34519.13702157441, 34595.48106778401, 3360.395128876801, 3436.1924947637285, 3451.758376913617, 3454.3264063507627, 3486.877959271413, 22357.776422235733, 22868.542629147323, 22876.941075303137, 23241.070357185694, 23286.76713232863, 3349.949750753741, 3435.519027336175, 3449.758516903818, 3477.1828620274214, 3493.68556829884, 155208.0, 155935.0, 155990.22004890017, 156244.2187789065, 156952.99999999886, 31387.215319617193, 31652.827698599012, 37209.62790372062, 41217.587824121976, 41314.38028429576, 40948.79525602353, 41827.79086104611, 42000.369994450106, 42105.36841947373, 42214.366784498256, 13070.34648267602, 13099.934500327628, 13110.606681799562, 13113.147645403018, 13135.277559734115, 10656.94671526653, 10673.893261067446, 10685.305455145392, 10686.251962362716, 10718.678439646823, 13169.868301317056, 13189.0, 13197.604071877859, 13227.669308267177, 13430.328483575977, 5399.676019438846, 5481.506664400144, 5494.890102197934, 5508.483004157006, 5669.433056694297, 803.3252068262688, 819.5697258939105, 828.2090603473669, 832.812617161146, 854.786303424144, 21332.680009799555, 22324.0, 22506.437339066328, 22520.0, 22529.52175260753, 866.757307953774, 870.3950754225752, 881.1540920716056, 882.8278485695356, 898.883145191121, 11650.70873228176, 12094.516219351304, 12161.756764864653, 12168.634940951786, 12272.938635306766, 237591.0, 243940.0, 244377.0, 244644.0, 244958.0, 41324.79337603353, 41815.37276940848, 41823.58176418197, 41840.790796046436, 41888.790556047024, 1211.594115971142, 1249.7937840256257, 1254.1785130739381, 1261.6845788553046, 1384.5015794314038, 20541.281055163, 20578.58842823105, 21810.0, 21836.781632183476, 22377.552448951257, 31198.844005779825, 31208.843955780078, 31220.531692024182, 31354.52968205433, 31361.686383135875, 214574.0, 215231.0, 215360.0, 215905.0, 216962.0, 21991.670124948458, 22052.77947220507, 25043.499130017663, 25084.24747257585, 28323.433531328847, 29122.56316155302, 29237.0, 29409.264768380963, 29593.40813183681, 29610.55584166196, 25368.746312536638, 27296.727032729417, 27498.725012749615, 27647.861760691067, 28101.0, 27101.457970840078, 27208.319792005357, 27583.31041723973, 28159.71840281653, 28434.715652843206, 27878.581821273103, 28076.29809254785, 28410.85794571014, 28590.42819143647, 28623.713762862106, 23845.52308953846, 25211.369715757253, 25318.620220697074, 25582.744172558036, 26028.86985565136, 20449.69325460149, 20456.284030058876, 20513.282035128697, 20659.0, 20708.0], "value": 15129.672294868207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.80344336440174, 418.2304559610316, 423.64413892330447, 432.7663061946549, 435.26874850251573, 14110.858891411082, 16918.407855725036, 17464.301427942883, 17470.213840377164, 17941.0, 16605.169741512935, 16663.75004374932, 16825.242864071115, 17260.136993150354, 17521.474355769315, 5762.711864406773, 5988.1317209004665, 5996.730147143389, 6559.737610495575, 6848.315168483162, 6680.66596670167, 6684.064231007663, 6705.094812200339, 6706.161729783777, 6719.798406047827, 6546.607203567777, 6995.440364770831, 6997.755078572251, 6998.790036298919, 7005.124359455068, 6520.250171230275, 6797.898031529531, 6957.408620267283, 6997.82505437363, 7040.753573624924, 6617.239017512999, 6647.501437392215, 6657.068010478537, 6664.0, 6666.866662666768, 21051.157953681835, 21507.46231344213, 21534.89232553843, 21610.35168944934, 22616.0, 2180.3349978256624, 2286.8056215221727, 2329.9650505242435, 2353.1411034972284, 2400.411899084718, 13955.092918960236, 14665.0, 14813.703725925528, 14837.554873353816, 15137.848621513755, 1841.4659748673002, 1855.5175654329971, 1889.6031833315021, 1897.4592241211326, 1908.9236430542762, 87509.56245218797, 87844.0, 87963.0, 89010.5549472255, 91356.08643913543, 16457.341706331852, 16476.4233251838, 16748.24632891523, 16756.0, 16968.321267149175, 26823.329416764736, 28905.855470722512, 28958.27604309909, 28965.986190483232, 29165.270868228465, 9027.0, 9060.411073280347, 9070.501122438198, 9076.41003334781, 9202.769930751785, 7326.743563975342, 7372.741954031583, 7559.773206803805, 7611.847763044819, 7643.235676432423, 9113.0, 9255.49094799779, 9509.619615215452, 9542.904570954202, 9597.952010240044, 3734.5518537775642, 3742.7754334740002, 3841.654251117413, 3932.174243408916, 4010.5588385277597, 978.2760757039739, 994.1251698505414, 1005.406809982114, 1009.3641006166068, 1012.8531362952479, 19180.808191918182, 19746.50633734168, 22190.556188876133, 22212.77787222107, 22297.777022229893, 874.5452364770284, 877.1360210192955, 877.6489404238356, 878.1876763993408, 881.4402854187509, 6559.704813283318, 6631.436327912182, 6673.432758215606, 6727.629980351127, 6908.240093589701, 488423.0, 489684.0, 490607.0, 513688.1996210354, 520537.0, 83538.58230708807, 84282.0, 85531.5723421379, 86035.13964860271, 87788.56105719431, 1111.183280288987, 1149.9022583080532, 1172.607176595833, 1172.8592568891788, 1188.423614546944, 16447.506574802774, 16589.83410165931, 16782.66434671324, 17833.375831845824, 18743.0, 41778.79110604428, 42136.36795448132, 42706.35940460833, 43779.78110109429, 44221.336679949185, 53272.73363633157, 53693.46306537041, 54035.0, 54669.72665136649, 55832.16251756145, 6474.773382931575, 8130.593470326578, 9748.80502389934, 9980.401175929468, 10425.791484170426, 11644.35956022427, 11659.76680466369, 11697.532098715956, 11800.881991179978, 12080.39598020113, 9006.144416280444, 9361.4383137012, 9368.0, 9378.906210937803, 9699.496578030417, 9748.853767193355, 9908.231285060781, 9966.0, 10213.387196768217, 10296.639617613348, 9525.428474291564, 9801.80396392054, 9850.507474626384, 9946.055124763136, 10009.099181073738, 9870.605175792887, 10018.64934727281, 10195.7451063724, 10417.166626669698, 10568.947155264175, 9559.091886270793, 9582.137607615348, 9843.507824608598, 9937.055979681918, 10026.598936042477], "value": 9838.641346496788, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.0387180938794, 1409.7039621679446, 1431.270052273341, 1453.1136007035707, 1525.9394720669136, 8276.420650554464, 8508.872366914502, 9029.0, 9351.345405821587, 9370.85943710844, 8988.775280617987, 9323.160915517603, 9333.626654933794, 9333.626654933794, 9364.34449588529, 1937.7093435984646, 1948.1720268885738, 1974.3879397386784, 1976.8418526517844, 1977.54516461214, 1944.6013567218686, 1996.820286174244, 2004.3686238834794, 2012.617602655498, 2021.9898900505477, 1970.753655793026, 2004.4988752811796, 2005.2079428625684, 2041.4998325410295, 2048.0476578391044, 1892.8201820826998, 1894.4979580411202, 1901.9334323298617, 1904.6857268550673, 1905.199816077251, 1845.7877344105332, 1863.394396821025, 1902.3722171683312, 1947.5423275530238, 1955.286320493024, 9602.75993100171, 9631.181349585293, 9728.708138755848, 9730.756731081708, 9753.707388778348, 4765.761711914391, 4954.950450495521, 4957.107720610289, 4959.727215003173, 4959.784852711109, 2622.2133359992117, 2801.4817258806984, 2869.1249169003445, 2871.1099559136733, 2877.1224776443178, 1012.6759436980169, 1078.2560033576806, 1093.1801149138146, 1106.9576631115578, 1120.960766373173, 13187.934060329733, 13231.0, 13317.400716967759, 13339.19964802115, 13361.0, 3923.548791888912, 4122.216778812016, 4204.201201771653, 4211.410402543646, 4379.605835474823, 11523.596674116534, 11556.364399958084, 11587.478563464665, 11590.13074019452, 11628.360440175702, 4943.901121977612, 4997.325361076281, 5006.749662516932, 5032.043911656773, 5060.746962651852, 4275.422817919541, 4376.3654270130655, 4532.5694059065, 4546.795394207269, 4549.931751023737, 3364.2598628301735, 3432.7768695034742, 3433.399155147889, 3464.7921124732597, 3511.4030614795547, 913.862920561921, 925.4077390470104, 927.1701826865053, 931.2270815223349, 935.7333160049353, 750.3959312753286, 765.7243392378739, 779.4154384211841, 781.7771934998498, 785.5012067337168, 5364.22218778275, 5425.891482170335, 5471.534919531884, 5573.164025396142, 5578.442155784389, 867.9045305016443, 869.6564856881496, 876.5398165962921, 884.606744377595, 891.6611687558686, 3489.6803034677787, 3588.515550400715, 3660.359437098497, 3725.403935370328, 3801.163743976321, 12250.632481025583, 12335.568255111028, 12676.23942563449, 12681.556145534862, 12707.745845083047, 12293.93853030729, 12322.568710095284, 12327.630171094881, 12331.568395106127, 12334.568290109803, 8787.516686582172, 8882.200601945726, 8977.775555611031, 9059.22996545301, 9203.171714545722, 5470.316210473691, 5529.33647962231, 5599.1041433370465, 5620.606557540933, 5640.54875609942, 10310.0, 10372.325798823053, 10394.584216631552, 10493.842592360968, 10631.521581529005, 10781.191410644076, 10869.891301087204, 10956.726081847699, 11020.0, 11049.447527623426, 6955.721771129098, 7158.821029474305, 7766.805829854299, 8023.197680232163, 8064.717734879251, 8565.614547345509, 8595.05454400028, 8641.265492433213, 8648.135186481302, 8720.694775682821, 7902.24928631779, 7964.20357964199, 7975.641096150804, 8036.236557527026, 8051.959740201261, 7893.763187104396, 7953.5227886327, 7983.5209887406945, 7992.920070799218, 8068.677252909818, 6673.632950187786, 6783.660816959231, 6823.488238382042, 6828.863422731617, 6903.206131294965, 4825.445073816556, 4912.459629440687, 4952.47998960104, 4978.4274808397495, 5014.84955451337, 4961.74449110696, 5076.517730815566, 5096.974515127401, 5112.667676601009, 5178.119719647593], "value": 4434.283476907581, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.5936591651433, 370.8998570385996, 377.04607343421145, 380.77343980331693, 384.6807150065444, 5498.3127109111365, 5501.229827824103, 5542.279503664518, 5545.112781954888, 5587.7764889404425, 5399.649022813514, 5414.214938833867, 5418.512333889949, 5425.511703946644, 5427.83716488505, 4277.850275240367, 4333.436653235075, 4345.739255644656, 4350.8912277193, 4367.563243675639, 4328.372386004027, 4334.826606935719, 4339.804708788096, 4348.760388399976, 4349.717268377562, 4320.567943205686, 4326.459192600925, 4327.783610819462, 4328.480582330109, 4344.3917851500655, 4237.258479766028, 4290.056187638715, 4342.739435633856, 4358.651307895392, 4372.540883207281, 3826.3112639724836, 3831.3525184170794, 3869.3422118239687, 3871.264459752666, 3893.53277606689, 5306.204069389584, 5320.813771518017, 5326.307580014612, 5333.280007199017, 5335.839924802262, 4844.757762111915, 4982.526659967298, 4983.6013118950395, 4997.2004479283505, 5011.1481048221885, 5655.915161272585, 5662.462066103713, 5703.857403564944, 5705.942940570582, 5722.599418040739, 4247.5540068293, 4257.8296868125235, 4270.402143699885, 4273.273543497582, 4275.700700950934, 5486.149646804752, 5569.164625306196, 5933.554983376221, 6034.275886893557, 6042.486388656969, 5125.513076257824, 5135.947130838169, 5138.126518491866, 5138.6814646841085, 5155.226715992631, 5250.159974404077, 5265.4730128263145, 5266.92099618506, 5270.604704647167, 5273.288106105703, 4921.876953076202, 5162.1224391853475, 5227.607929405233, 5369.624126311199, 5441.782328706808, 5688.146777983336, 5690.374058853523, 5706.172604972256, 5719.027765279912, 5720.971395142998, 1665.1674162918541, 1685.6881476926562, 1691.222037862597, 1691.9746203806953, 1692.3653629888793, 1204.644629834201, 1248.8189212564128, 1263.9557615483413, 1273.4142294544613, 1279.3155661720934, 4964.304997300381, 4975.203967365204, 4975.402951645826, 4980.77586508608, 4982.750862456863, 5857.26784151981, 5896.498797602166, 5905.852353691193, 5919.230500035054, 5969.432903874125, 4816.686915350491, 4879.2925025871045, 4928.630352723489, 4948.802047918043, 4964.0, 3111.937761244808, 3133.2950086230417, 3137.607799025122, 3145.370925814846, 3156.352947645727, 5351.304330437096, 5457.61796674229, 5457.890842183134, 5470.671759694431, 5481.149182973098, 5711.371749107595, 5903.409659034062, 5954.940450595439, 5961.0, 6007.219061522062, 5402.945970540323, 5481.835544933659, 5483.232347471358, 5499.780008799603, 5517.227588137664, 5908.970455147697, 5941.702914854326, 5954.732037058429, 5958.255218097738, 5990.311114221746, 5633.324001119892, 5759.596828221985, 5794.82615521535, 5817.214676018683, 5838.854028649318, 5476.507114359727, 5508.807191748269, 5521.668699878021, 5529.972350138223, 5539.279893613965, 4527.139843429738, 4705.670603057753, 4720.0, 4725.653188841164, 4737.573618374363, 5907.202527658711, 5925.170476133431, 5928.658180018954, 5935.317438494629, 5960.105984102419, 5641.6050876439895, 5641.887162256814, 5647.435256474319, 5651.208830763779, 5659.462351076641, 5548.528375088002, 5558.249636299048, 5622.634528755618, 5664.716764161858, 5686.744096515749, 5564.693941833076, 5579.572885794692, 5595.468430499096, 5596.468335508121, 5613.550915926634, 5615.298087739033, 5708.372079071216, 5726.942730572641, 5747.683877386784, 5749.97125014389, 5514.228008078952, 5518.88183176504, 5522.502974732293, 5541.307336582927, 5584.329880414376], "value": 4455.032926863139, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.4056430341299, 677.881370760117, 684.9828754281142, 684.9897251541228, 698.7414656577066, 11902.940485297573, 12412.937935310334, 12501.874981250185, 12523.812142817866, 12544.37278136094, 12441.875581244185, 12496.375181240946, 12510.437030333656, 12554.183978041443, 12610.684732881682, 825.4263287015526, 829.9170082991698, 844.7254642241265, 847.9067302596709, 860.114082495028, 869.1916517638593, 869.7347309070731, 870.0559892516595, 870.7431307764193, 871.6949067826242, 895.7760559860035, 896.3501461440469, 896.901340852509, 899.2356496977582, 902.264654306738, 891.9910800891973, 893.0489029183898, 894.150556970877, 894.6600291889106, 895.0825403960927, 654.4077609763171, 658.799066284783, 659.152988409891, 659.7262136213466, 660.1022609251414, 13957.651058723512, 13991.510297139654, 14017.43930242789, 14025.579232623038, 14629.561113166623, 13316.86683133166, 13779.931100344535, 13936.860631393658, 14002.92998535011, 14181.93635477333, 10039.648612298608, 10278.640247591298, 10346.12057975073, 10488.31825931312, 10635.787284254271, 3143.3713257348395, 3173.428782819092, 3231.919202019945, 3285.0473362724783, 3349.8492567834505, 55520.16719749207, 55945.720271398786, 56096.99999999959, 56563.15155272674, 58273.0, 10069.69790906274, 10188.694339169837, 10270.33242839228, 10490.370577765207, 10859.457027148612, 19787.208511659373, 19932.402027939184, 19978.0, 19988.700169497468, 20012.099455524538, 6495.707693153725, 6596.142501474777, 6701.363370479797, 6863.759768408082, 6891.620960847202, 3461.2039230977016, 3464.497647841049, 3465.341585098823, 3497.0208341664375, 3579.6599323064265, 2882.6684931233176, 2942.087952734659, 2968.257935516121, 2974.1523665755158, 2976.523756199041, 495.9330490383752, 497.34847349971653, 501.5786739139141, 508.8066534716784, 509.3149713635155, 593.664579512574, 622.4273668225244, 632.2065807411669, 635.4249404289126, 636.700750647195, 8219.794505137419, 8506.61720222579, 8615.0, 8889.727084584407, 9106.908930910606, 589.5548860610212, 593.6868649263107, 608.4645511949457, 610.2646311194999, 614.1555361378105, 4283.2932566126865, 4288.764117973541, 4331.610155085994, 4342.6308763754805, 4393.221148345773, 60240.698796505734, 60539.0, 61714.0, 63137.0, 63240.68379658072, 52568.474315257125, 54243.18635220475, 54273.45726542684, 55028.449715503135, 55449.0, 48508.757456212494, 49260.0, 49810.50189498131, 50040.49959500431, 51039.489605104216, 7743.0, 8146.470479418819, 8160.5511696854865, 8302.377321701017, 8320.084790673141, 33824.323513529096, 34284.48573271353, 34848.65151348556, 35411.645883540834, 35702.28595428025, 39122.608773911896, 39529.80235098806, 40384.39423408592, 41769.164616708105, 41921.161576767685, 9841.409515429097, 10359.689209323733, 10428.530716117944, 10566.788664226826, 10608.840867387149, 10544.314619549705, 10705.785884282426, 10706.518206680874, 10894.400807955639, 11406.828897566376, 9778.9022109778, 9930.702078937644, 9949.253805964438, 10048.84926726085, 10495.947520262349, 10399.48002599882, 10563.15494760402, 10581.4709264538, 10852.077573406348, 10891.891081089088, 10559.841602375816, 10575.471226438802, 10745.301555398873, 10825.079868210974, 11091.279066860629, 8774.4296620722, 9004.954975225082, 9300.813983720423, 9357.85963210566, 9370.67202647904, 8681.331842861846, 9111.817763644822, 9212.861807073034, 9372.828396450444, 9522.714318570454], "value": 6194.4278655899225, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 121.0, 121.0, 120.0, 119.0, 120.0, 117.0, 127.0, 120.0, 119.0], "value": 119.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 131.0, 128.0, 175.0, 129.0, 127.0, 125.0, 126.0, 146.0, 128.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 164.0, 169.0, 171.0, 168.0, 162.0, 166.0, 163.0, 162.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 77.0, 77.0, 112.0, 75.0, 76.0, 78.0, 75.0, 91.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 108.0, 85.0, 85.0, 85.0, 101.0, 85.0, 85.0, 110.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 114.0, 114.0, 114.0, 123.0, 117.0, 114.0, 114.0, 114.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 151.0, 150.0, 151.0, 152.0, 151.0, 150.0, 152.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 69.0, 68.0, 71.0, 69.0, 69.0, 69.0], "value": 68.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 55.0, 56.0, 55.0, 56.0, 56.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 89.0, 83.0, 84.0, 84.0, 83.0, 91.0, 83.0, 82.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 148.0, 134.0, 133.0, 145.0, 143.0, 138.0, 190.0, 147.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 200.0, 188.0, 197.0, 201.0, 197.0, 203.0, 198.0, 198.0, 186.0], "value": 195.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 72.0, 74.0, 75.0, 72.0, 72.0, 73.0, 70.0, 72.0], "value": 72.8, "unit": "score"}]}]} 11:48:21 INFO - Return code: 0 11:48:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:48:21 ERROR - # TBPL SUCCESS # 11:48:21 INFO - Running post-action listener: _resource_record_post_action 11:48:21 INFO - [mozharness: 2017-03-17 18:48:21.452653Z] Finished run-tests step (success) 11:48:21 INFO - Running post-run listener: _resource_record_post_run 11:48:21 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 16384; Write bytes: 363753472; Read time: 276; Write time: 281760 11:48:21 INFO - TinderboxPrint: CPU usage
13.3% 11:48:21 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 276 11:48:21 INFO - TinderboxPrint: I/O write bytes / time
363,753,472 / 281,760 11:48:21 INFO - TinderboxPrint: CPU idle
8,308.5 (86.7%) 11:48:21 INFO - TinderboxPrint: CPU user
1,219.0 (12.7%) 11:48:21 INFO - TinderboxPrint: Swap in / out
0 / 0 11:48:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 104960000; Read time: 0; Write time: 97408 11:48:21 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 16384; Write bytes: 258392064; Read time: 276; Write time: 184328 11:48:22 INFO - Running post-run listener: _upload_blobber_files 11:48:22 INFO - Blob upload gear active. 11:48:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:48:22 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 11:48:22 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'] 11:48:22 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 11:48:22 INFO - (blobuploader) - INFO - Open directory for files ... 11:48:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:48:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:48:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:23 INFO - (blobuploader) - INFO - Done attempting. 11:48:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:48:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:48:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:24 INFO - (blobuploader) - INFO - Done attempting. 11:48:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:48:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:48:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:27 INFO - (blobuploader) - INFO - Done attempting. 11:48:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:48:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:48:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:28 INFO - (blobuploader) - INFO - Done attempting. 11:48:28 INFO - (blobuploader) - INFO - Iteration through files over. 11:48:28 INFO - Return code: 0 11:48:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:48:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:48:28 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1f4e6d5a2de825b990b6da36af5a12ee9c3b9343759f68258261178840d760f8d1d5c533175480a7adbe3d4a6a1f13135549346fd6cdd204bccae797baccd9e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48a5098a13464b40f0040f76d5443e321a0e808357a9a1a94162a7e81a089889e1647f07d208138c6d20e760002cf272eb3e52ed0b9c09fddf9ab607a777f6e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/951e947f2428ed29e3812b9d25306205ebb8530b1080b7cf92febd411b7ce8fb36435f4d299a6a6b2f3c3906a5e404be24eb0d2a3239d91ff02887c33615d877", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2ad4855b2679024ac190e496ec41a3b32909abf874f6bd2b2f70914a03b43cdf38aaf9c05676b51d03d7da65dc5c6485793db45f8f3658f9d277ae0b508c164"} 11:48:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:48:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:48:28 INFO - Contents: 11:48:28 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1f4e6d5a2de825b990b6da36af5a12ee9c3b9343759f68258261178840d760f8d1d5c533175480a7adbe3d4a6a1f13135549346fd6cdd204bccae797baccd9e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48a5098a13464b40f0040f76d5443e321a0e808357a9a1a94162a7e81a089889e1647f07d208138c6d20e760002cf272eb3e52ed0b9c09fddf9ab607a777f6e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/951e947f2428ed29e3812b9d25306205ebb8530b1080b7cf92febd411b7ce8fb36435f4d299a6a6b2f3c3906a5e404be24eb0d2a3239d91ff02887c33615d877", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2ad4855b2679024ac190e496ec41a3b32909abf874f6bd2b2f70914a03b43cdf38aaf9c05676b51d03d7da65dc5c6485793db45f8f3658f9d277ae0b508c164"} 11:48:28 INFO - Running post-run listener: copy_logs_to_upload_dir 11:48:28 INFO - Copying logs to upload dir... 11:48:28 INFO - mkdir: /builds/slave/test/build/upload/logs 11:48:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.528736 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-17 11:48:28.528068) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 11:48:28.531653) ========= 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=826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984 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/b1f4e6d5a2de825b990b6da36af5a12ee9c3b9343759f68258261178840d760f8d1d5c533175480a7adbe3d4a6a1f13135549346fd6cdd204bccae797baccd9e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48a5098a13464b40f0040f76d5443e321a0e808357a9a1a94162a7e81a089889e1647f07d208138c6d20e760002cf272eb3e52ed0b9c09fddf9ab607a777f6e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/951e947f2428ed29e3812b9d25306205ebb8530b1080b7cf92febd411b7ce8fb36435f4d299a6a6b2f3c3906a5e404be24eb0d2a3239d91ff02887c33615d877", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2ad4855b2679024ac190e496ec41a3b32909abf874f6bd2b2f70914a03b43cdf38aaf9c05676b51d03d7da65dc5c6485793db45f8f3658f9d277ae0b508c164"} build_url:https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/PveYK3-lSSa-H8qxbtmpWw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1f4e6d5a2de825b990b6da36af5a12ee9c3b9343759f68258261178840d760f8d1d5c533175480a7adbe3d4a6a1f13135549346fd6cdd204bccae797baccd9e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48a5098a13464b40f0040f76d5443e321a0e808357a9a1a94162a7e81a089889e1647f07d208138c6d20e760002cf272eb3e52ed0b9c09fddf9ab607a777f6e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/951e947f2428ed29e3812b9d25306205ebb8530b1080b7cf92febd411b7ce8fb36435f4d299a6a6b2f3c3906a5e404be24eb0d2a3239d91ff02887c33615d877", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2ad4855b2679024ac190e496ec41a3b32909abf874f6bd2b2f70914a03b43cdf38aaf9c05676b51d03d7da65dc5c6485793db45f8f3658f9d277ae0b508c164"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 11:48:28.556475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:48:28.556788) ========= 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=826874ccc97bd7bf541b4875000001d5-1489773362.2898-1463179984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:48:28.642022) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 11:48:28.642340) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 11:48:28.642635) ========= ========= Total master_lag: 0.16 =========