builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1490830760.57 results: success (0) revision: 60d7a0496a3673450ddbc37ec387525148c32604 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:20.571945) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:20.572407) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:20.572677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:20.587318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:20.587577) ========= 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=923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-29 16:39:20-- 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% 225M=0s 2017-03-29 16:39:20 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126696 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:20.727926) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:20.728241) ========= 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=923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019727 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:20.777375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:20.777702) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 60d7a0496a3673450ddbc37ec387525148c32604 --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 60d7a0496a3673450ddbc37ec387525148c32604 --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=923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-29 16:39:20,848 truncating revision to first 12 chars 2017-03-29 16:39:20,848 Setting DEBUG logging. 2017-03-29 16:39:20,848 attempt 1/10 2017-03-29 16:39:20,848 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/60d7a0496a36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 16:39:21,195 unpacking tar archive at: mozilla-central-60d7a0496a36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668909 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:21.459930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:21.460300) ========= script_repo_revision: 60d7a0496a3673450ddbc37ec387525148c32604 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:21.460710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:21.460977) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 16:39:21.470226) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-29 16:39:21.470573) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:39:21 INFO - MultiFileLogger online at 20170329 16:39:21 in /builds/slave/test 16:39:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:39:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:39:21 INFO - {'append_to_log': False, 16:39:21 INFO - 'base_work_dir': '/builds/slave/test', 16:39:21 INFO - 'blob_upload_branch': 'Firefox', 16:39:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:39:21 INFO - 'branch': 'Firefox', 16:39:21 INFO - 'buildbot_json_path': 'buildprops.json', 16:39:21 INFO - 'config_files': ('talos/linux_config.py',), 16:39:21 INFO - 'default_actions': ('clobber', 16:39:21 INFO - 'read-buildbot-config', 16:39:21 INFO - 'download-and-extract', 16:39:21 INFO - 'populate-webroot', 16:39:21 INFO - 'create-virtualenv', 16:39:21 INFO - 'install', 16:39:21 INFO - 'run-tests'), 16:39:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:39:21 INFO - 'download_minidump_stackwalk': True, 16:39:21 INFO - 'download_symbols': 'ondemand', 16:39:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:39:21 INFO - 'tooltool.py': '/tools/tooltool.py', 16:39:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:39:21 INFO - '/tools/misc-python/virtualenv.py')}, 16:39:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:39:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:39:21 INFO - 'gecko_profile': False, 16:39:21 INFO - 'gecko_profile_interval': 0, 16:39:21 INFO - 'installer_path': 'installer.exe', 16:39:21 INFO - 'log_level': 'info', 16:39:21 INFO - 'log_name': 'talos', 16:39:21 INFO - 'log_to_console': True, 16:39:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:39:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:39:21 INFO - 'opt_config_files': (), 16:39:21 INFO - 'pip_index': False, 16:39:21 INFO - 'suite': 'dromaeojs', 16:39:21 INFO - 'system_bits': '32', 16:39:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:39:21 INFO - 'title': 'talos-linux64-ix-007', 16:39:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:39:21 INFO - 'use_talos_json': True, 16:39:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:39:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:39:21 INFO - 'work_dir': 'build'} 16:39:21 INFO - [mozharness: 2017-03-29 23:39:21.643864Z] Running clobber step. 16:39:21 INFO - Running pre-action listener: _resource_record_pre_action 16:39:21 INFO - Running main action method: clobber 16:39:21 INFO - rmtree: /builds/slave/test/build 16:39:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:39:22 INFO - Running post-action listener: _resource_record_post_action 16:39:22 INFO - [mozharness: 2017-03-29 23:39:22.581270Z] Finished clobber step (success) 16:39:22 INFO - [mozharness: 2017-03-29 23:39:22.581370Z] Running read-buildbot-config step. 16:39:22 INFO - Running pre-action listener: _resource_record_pre_action 16:39:22 INFO - Running main action method: read_buildbot_config 16:39:22 INFO - Using buildbot properties: 16:39:22 INFO - { 16:39:22 INFO - "project": "", 16:39:22 INFO - "product": "firefox", 16:39:22 INFO - "who": "kwierso@gmail.com", 16:39:22 INFO - "installer_path": "public/build/target.tar.bz2", 16:39:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:39:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:39:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:39:22 INFO - "stage_platform": "linux64-pgo", 16:39:22 INFO - "basedir": "/builds/slave/test", 16:39:22 INFO - "buildnumber": 115, 16:39:22 INFO - "platform": "ubuntu64_hw", 16:39:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:39:22 INFO - "slavebuilddir": "test", 16:39:22 INFO - "taskId": "IzsZd3dcSIGbVz6Ig4p6MQ", 16:39:22 INFO - "branch": "mozilla-central", 16:39:22 INFO - "script_repo_revision": "production", 16:39:22 INFO - "revision": "60d7a0496a3673450ddbc37ec387525148c32604", 16:39:22 INFO - "slavename": "talos-linux64-ix-007", 16:39:22 INFO - "repo_path": "mozilla-central" 16:39:22 INFO - } 16:39:22 INFO - Finding installer, test and symbols from parent task. 16:39:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IzsZd3dcSIGbVz6Ig4p6MQ'}, attempt #1 16:39:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IzsZd3dcSIGbVz6Ig4p6MQ'}, attempt #1 16:39:23 INFO - Task dependencies: HWy8y5ymSJGouwusOmJF7g 16:39:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g'}, attempt #1 16:39:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.tar.bz2 16:39:23 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/test_packages.json 16:39:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.crashreporter-symbols.zip 16:39:23 INFO - Running post-action listener: _resource_record_post_action 16:39:23 INFO - [mozharness: 2017-03-29 23:39:23.995608Z] Finished read-buildbot-config step (success) 16:39:23 INFO - [mozharness: 2017-03-29 23:39:23.995827Z] Running download-and-extract step. 16:39:23 INFO - Running pre-action listener: _resource_record_pre_action 16:39:23 INFO - Running main action method: download_and_extract 16:39:23 INFO - mkdir: /builds/slave/test/build/tests 16:39:23 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')]} 16:39:23 INFO - trying https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.test_packages.json 16:39:23 INFO - Downloading https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:39:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:39:24 INFO - Downloaded 986 bytes. 16:39:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:39:24 INFO - Using the following test package requirements: 16:39:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:39:24 INFO - u'common': [u'target.common.tests.zip'], 16:39:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:39:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:39:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:39:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:39:24 INFO - u'mozbase': [u'target.common.tests.zip'], 16:39:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:39:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:39:24 INFO - u'web-platform': [u'target.common.tests.zip', 16:39:24 INFO - u'target.web-platform.tests.zip'], 16:39:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:39:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:39:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.common.tests.zip 16:39:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:39:24 INFO - Fetch https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.common.tests.zip into memory 16:39:25 INFO - Expected file size: 60348899 16:39:25 INFO - Obtained file size: 60348899 16:39:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:39:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.common.tests.zip 16:39:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:39:35 INFO - Fetch https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.common.tests.zip into memory 16:39:36 INFO - Expected file size: 60348899 16:39:36 INFO - Obtained file size: 60348899 16:39:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.talos.tests.zip 16:39:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:39:47 INFO - Fetch https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.talos.tests.zip into memory 16:39:48 INFO - Expected file size: 14404171 16:39:48 INFO - Obtained file size: 14404171 16:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:39:48 INFO - trying https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.tar.bz2 16:39:48 INFO - Downloading https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:39:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:39:49 INFO - Downloaded 67925490 bytes. 16:39:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.tar.bz2 16:39:49 INFO - mkdir: /builds/slave/test/properties 16:39:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:39:49 INFO - Writing to file /builds/slave/test/properties/build_url 16:39:49 INFO - Contents: 16:39:49 INFO - build_url:https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.tar.bz2 16:39:49 INFO - Running post-action listener: _resource_record_post_action 16:39:49 INFO - Running post-action listener: set_extra_try_arguments 16:39:49 INFO - [mozharness: 2017-03-29 23:39:49.534651Z] Finished download-and-extract step (success) 16:39:49 INFO - [mozharness: 2017-03-29 23:39:49.534748Z] Running populate-webroot step. 16:39:49 INFO - Running pre-action listener: _resource_record_pre_action 16:39:49 INFO - Running main action method: populate_webroot 16:39:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:39:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:39:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:39:49 INFO - '--tppagecycles', 16:39:49 INFO - '7'], 16:39:49 INFO - 'tests': ['tsvgm']}}, 16:39:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:39:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:39:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:39:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:39:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:39:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:39:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:39:49 INFO - 'talos_options': ['--disable-e10s'], 16:39:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:39:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:39:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:39:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:39:49 INFO - 'talos_options': ['--disable-e10s'], 16:39:49 INFO - 'tests': ['damp', 'tps']}, 16:39:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:39:49 INFO - 'tests': ['damp', 'tps']}, 16:39:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:39:49 INFO - 'tests': ['dromaeo_dom']}, 16:39:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:39:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:39:49 INFO - 'tests': ['basic_compositor_video']}, 16:39:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:39:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:39:49 INFO - 'tests': ['a11yr', 16:39:49 INFO - 'ts_paint', 16:39:49 INFO - 'tpaint', 16:39:49 INFO - 'sessionrestore', 16:39:49 INFO - 'sessionrestore_no_auto_restore', 16:39:49 INFO - 'tabpaint']}, 16:39:49 INFO - 'other-e10s': {'tests': ['a11yr', 16:39:49 INFO - 'ts_paint', 16:39:49 INFO - 'tpaint', 16:39:49 INFO - 'sessionrestore', 16:39:49 INFO - 'sessionrestore_no_auto_restore', 16:39:49 INFO - 'tabpaint']}, 16:39:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:39:49 INFO - 'ts_paint', 16:39:49 INFO - 'tpaint', 16:39:49 INFO - 'sessionrestore', 16:39:49 INFO - 'sessionrestore_no_auto_restore', 16:39:49 INFO - 'tabpaint']}, 16:39:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:39:49 INFO - 'ts_paint', 16:39:49 INFO - 'tpaint', 16:39:49 INFO - 'sessionrestore', 16:39:49 INFO - 'sessionrestore_no_auto_restore', 16:39:49 INFO - 'tabpaint']}, 16:39:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:39:49 INFO - 'tests': ['a11yr', 16:39:49 INFO - 'ts_paint', 16:39:49 INFO - 'tpaint', 16:39:49 INFO - 'sessionrestore', 16:39:49 INFO - 'sessionrestore_no_auto_restore', 16:39:49 INFO - 'tabpaint']}, 16:39:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:39:49 INFO - 'tests': ['a11yr', 16:39:49 INFO - 'ts_paint', 16:39:49 INFO - 'tpaint', 16:39:49 INFO - 'sessionrestore', 16:39:49 INFO - 'sessionrestore_no_auto_restore', 16:39:49 INFO - 'tabpaint']}, 16:39:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:39:49 INFO - 'tests': ['tsvgx', 16:39:49 INFO - 'tsvgr_opacity', 16:39:49 INFO - 'tart', 16:39:49 INFO - 'tscrollx', 16:39:49 INFO - 'cart', 16:39:49 INFO - 'tsvg_static']}, 16:39:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:39:49 INFO - 'tsvgr_opacity', 16:39:49 INFO - 'tart', 16:39:49 INFO - 'tscrollx', 16:39:49 INFO - 'cart', 16:39:49 INFO - 'tsvg_static']}, 16:39:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:39:49 INFO - 'talos_options': ['--disable-e10s'], 16:39:49 INFO - 'tests': ['tp5o']}, 16:39:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:39:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:39:49 INFO - 'talos_options': ['--disable-e10s', 16:39:49 INFO - '--xperf_path', 16:39:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:39:49 INFO - 'tests': ['tp5n']}, 16:39:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:39:49 INFO - 'talos_options': ['--xperf_path', 16:39:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:39:49 INFO - 'tests': ['tp5n']}}, 16:39:49 INFO - 'talos.zip': {'path': '', 16:39:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:39:49 INFO - Running post-action listener: _resource_record_post_action 16:39:49 INFO - [mozharness: 2017-03-29 23:39:49.547945Z] Finished populate-webroot step (success) 16:39:49 INFO - [mozharness: 2017-03-29 23:39:49.548036Z] Running create-virtualenv step. 16:39:49 INFO - Running pre-action listener: _resource_record_pre_action 16:39:49 INFO - Running main action method: create_virtualenv 16:39:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:39:49 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 16:39:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:39:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:39:49 INFO - Using real prefix '/usr' 16:39:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:39:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:39:52 INFO - Installing pip.................done. 16:39:52 INFO - Return code: 0 16:39:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:39:52 INFO - Reading from file tmpfile_stdout 16:39:52 INFO - Output received: 16:39:52 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) 16:39:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:39:52 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')]} 16:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:52 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')]} 16:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1c601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, '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 0x1efc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc840>, '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': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', '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 16:39:52 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 16:39:52 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 16:39:52 INFO - Using env: {'DISPLAY': ':0', 16:39:52 INFO - 'HOME': '/home/cltbld', 16:39:52 INFO - 'LANG': 'en_US.UTF-8', 16:39:52 INFO - 'LANGUAGE': 'en_US:en', 16:39:52 INFO - 'LOGNAME': 'cltbld', 16:39:52 INFO - 'MAIL': '/var/mail/cltbld', 16:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:52 INFO - 'MOZ_NO_REMOTE': '1', 16:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:52 INFO - 'NO_EM_RESTART': '1', 16:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:52 INFO - 'PWD': '/builds/slave/test', 16:39:52 INFO - 'SHELL': '/bin/bash', 16:39:52 INFO - 'SHLVL': '1', 16:39:52 INFO - 'TERM': 'linux', 16:39:52 INFO - 'TMOUT': '86400', 16:39:52 INFO - 'USER': 'cltbld', 16:39:52 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', 16:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:52 INFO - '_': '/tools/buildbot/bin/python'} 16:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:52 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 16:39:52 INFO - Cleaning up... 16:39:52 INFO - Return code: 0 16:39:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:39:52 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')]} 16:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:52 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')]} 16:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1c601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, '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 0x1efc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc840>, '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': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', '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 16:39:52 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 16:39:52 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 16:39:52 INFO - Using env: {'DISPLAY': ':0', 16:39:52 INFO - 'HOME': '/home/cltbld', 16:39:52 INFO - 'LANG': 'en_US.UTF-8', 16:39:52 INFO - 'LANGUAGE': 'en_US:en', 16:39:52 INFO - 'LOGNAME': 'cltbld', 16:39:52 INFO - 'MAIL': '/var/mail/cltbld', 16:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:52 INFO - 'MOZ_NO_REMOTE': '1', 16:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:52 INFO - 'NO_EM_RESTART': '1', 16:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:52 INFO - 'PWD': '/builds/slave/test', 16:39:52 INFO - 'SHELL': '/bin/bash', 16:39:52 INFO - 'SHLVL': '1', 16:39:52 INFO - 'TERM': 'linux', 16:39:52 INFO - 'TMOUT': '86400', 16:39:52 INFO - 'USER': 'cltbld', 16:39:52 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', 16:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:52 INFO - '_': '/tools/buildbot/bin/python'} 16:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:52 INFO - Downloading/unpacking psutil>=3.1.1 16:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:52 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 16:39:52 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 16:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:39:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:54 INFO - Installing collected packages: psutil 16:39:54 INFO - Running setup.py install for psutil 16:39:54 INFO - building 'psutil._psutil_linux' extension 16:39:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:39:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:39:55 INFO - building 'psutil._psutil_posix' extension 16:39:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:39:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:39:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:55 INFO - Successfully installed psutil 16:39:55 INFO - Cleaning up... 16:39:55 INFO - Return code: 0 16:39:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:39:55 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')]} 16:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:55 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')]} 16:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1c601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, '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 0x1efc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc840>, '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': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', '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 16:39:55 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 16:39:55 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 16:39:55 INFO - Using env: {'DISPLAY': ':0', 16:39:55 INFO - 'HOME': '/home/cltbld', 16:39:55 INFO - 'LANG': 'en_US.UTF-8', 16:39:55 INFO - 'LANGUAGE': 'en_US:en', 16:39:55 INFO - 'LOGNAME': 'cltbld', 16:39:55 INFO - 'MAIL': '/var/mail/cltbld', 16:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:55 INFO - 'MOZ_NO_REMOTE': '1', 16:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:55 INFO - 'NO_EM_RESTART': '1', 16:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:55 INFO - 'PWD': '/builds/slave/test', 16:39:55 INFO - 'SHELL': '/bin/bash', 16:39:55 INFO - 'SHLVL': '1', 16:39:55 INFO - 'TERM': 'linux', 16:39:55 INFO - 'TMOUT': '86400', 16:39:55 INFO - 'USER': 'cltbld', 16:39:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', 16:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:55 INFO - '_': '/tools/buildbot/bin/python'} 16:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:39:57 INFO - Installing collected packages: mozsystemmonitor 16:39:57 INFO - Running setup.py install for mozsystemmonitor 16:39:57 INFO - Successfully installed mozsystemmonitor 16:39:57 INFO - Cleaning up... 16:39:57 INFO - Return code: 0 16:39:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, '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 0x1efc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc840>, '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': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', '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 16:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:39:57 INFO - Using env: {'DISPLAY': ':0', 16:39:57 INFO - 'HOME': '/home/cltbld', 16:39:57 INFO - 'LANG': 'en_US.UTF-8', 16:39:57 INFO - 'LANGUAGE': 'en_US:en', 16:39:57 INFO - 'LOGNAME': 'cltbld', 16:39:57 INFO - 'MAIL': '/var/mail/cltbld', 16:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:57 INFO - 'MOZ_NO_REMOTE': '1', 16:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:57 INFO - 'NO_EM_RESTART': '1', 16:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:57 INFO - 'PWD': '/builds/slave/test', 16:39:57 INFO - 'SHELL': '/bin/bash', 16:39:57 INFO - 'SHLVL': '1', 16:39:57 INFO - 'TERM': 'linux', 16:39:57 INFO - 'TMOUT': '86400', 16:39:57 INFO - 'USER': 'cltbld', 16:39:57 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', 16:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:57 INFO - '_': '/tools/buildbot/bin/python'} 16:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:58 INFO - Downloading/unpacking jsonschema==2.5.1 16:39: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 16:39: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 16:39: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 16:39: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 16:39: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 16:39: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 16:40:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:40:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:00 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 16:40:00 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 16:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:00 INFO - Downloading functools32-3.2.3-2.tar.gz 16:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:40:00 INFO - warning: no files found matching '*.txt' 16:40:00 INFO - no previously-included directories found matching 'build' 16:40:00 INFO - no previously-included directories found matching 'dist' 16:40:00 INFO - no previously-included directories found matching '.git*' 16:40:00 INFO - Installing collected packages: jsonschema, functools32 16:40:00 INFO - Running setup.py install for functools32 16:40:00 INFO - warning: no files found matching '*.txt' 16:40:00 INFO - no previously-included directories found matching 'build' 16:40:00 INFO - no previously-included directories found matching 'dist' 16:40:00 INFO - no previously-included directories found matching '.git*' 16:40:00 INFO - Successfully installed jsonschema functools32 16:40:00 INFO - Cleaning up... 16:40:00 INFO - Return code: 0 16:40:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:40:00 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')]} 16:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:00 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')]} 16:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:00 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 0x1c601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, '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 0x1efc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc840>, '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': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', '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 16:40:00 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 16:40:00 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 16:40:00 INFO - Using env: {'DISPLAY': ':0', 16:40:00 INFO - 'HOME': '/home/cltbld', 16:40:00 INFO - 'LANG': 'en_US.UTF-8', 16:40:00 INFO - 'LANGUAGE': 'en_US:en', 16:40:00 INFO - 'LOGNAME': 'cltbld', 16:40:00 INFO - 'MAIL': '/var/mail/cltbld', 16:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:00 INFO - 'MOZ_NO_REMOTE': '1', 16:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:00 INFO - 'NO_EM_RESTART': '1', 16:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:00 INFO - 'PWD': '/builds/slave/test', 16:40:00 INFO - 'SHELL': '/bin/bash', 16:40:00 INFO - 'SHLVL': '1', 16:40:00 INFO - 'TERM': 'linux', 16:40:00 INFO - 'TMOUT': '86400', 16:40:00 INFO - 'USER': 'cltbld', 16:40:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', 16:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:00 INFO - '_': '/tools/buildbot/bin/python'} 16:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:40:00 INFO - Cleaning up... 16:40:00 INFO - Return code: 0 16:40:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:40:00 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')]} 16:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:00 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')]} 16:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:00 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 0x1c601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, '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 0x1efc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc840>, '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': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', '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 16:40:00 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 16:40:00 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 16:40:00 INFO - Using env: {'DISPLAY': ':0', 16:40:00 INFO - 'HOME': '/home/cltbld', 16:40:00 INFO - 'LANG': 'en_US.UTF-8', 16:40:00 INFO - 'LANGUAGE': 'en_US:en', 16:40:00 INFO - 'LOGNAME': 'cltbld', 16:40:00 INFO - 'MAIL': '/var/mail/cltbld', 16:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:00 INFO - 'MOZ_NO_REMOTE': '1', 16:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:00 INFO - 'NO_EM_RESTART': '1', 16:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:00 INFO - 'PWD': '/builds/slave/test', 16:40:00 INFO - 'SHELL': '/bin/bash', 16:40:00 INFO - 'SHLVL': '1', 16:40:00 INFO - 'TERM': 'linux', 16:40:00 INFO - 'TMOUT': '86400', 16:40:00 INFO - 'USER': 'cltbld', 16:40:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', 16:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:00 INFO - '_': '/tools/buildbot/bin/python'} 16:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:01 INFO - Downloading/unpacking blobuploader==1.2.4 16:40: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 16:40: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 16:40: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 16:40: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 16:40: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 16:40: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 16:40:03 INFO - Downloading blobuploader-1.2.4.tar.gz 16:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:40:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:40:03 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 16:40:03 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 16:40:03 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 16:40:03 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 16:40:03 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 16:40:03 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 16:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:40:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:40:03 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 16:40:03 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 16:40:03 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 16:40:03 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 16:40:03 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 16:40:03 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 16:40:03 INFO - Downloading docopt-0.6.1.tar.gz 16:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:40:03 INFO - Installing collected packages: blobuploader, requests, docopt 16:40:03 INFO - Running setup.py install for blobuploader 16:40:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:40:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:40:03 INFO - Running setup.py install for requests 16:40:04 INFO - Running setup.py install for docopt 16:40:04 INFO - Successfully installed blobuploader requests docopt 16:40:04 INFO - Cleaning up... 16:40:04 INFO - Return code: 0 16:40:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40: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')]} 16:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40: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')]} 16:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:04 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 0x1c601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, '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 0x1efc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc840>, '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': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', '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 16:40:04 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 16:40:04 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 16:40:04 INFO - Using env: {'DISPLAY': ':0', 16:40:04 INFO - 'HOME': '/home/cltbld', 16:40:04 INFO - 'LANG': 'en_US.UTF-8', 16:40:04 INFO - 'LANGUAGE': 'en_US:en', 16:40:04 INFO - 'LOGNAME': 'cltbld', 16:40:04 INFO - 'MAIL': '/var/mail/cltbld', 16:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:04 INFO - 'MOZ_NO_REMOTE': '1', 16:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:04 INFO - 'NO_EM_RESTART': '1', 16:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:04 INFO - 'PWD': '/builds/slave/test', 16:40:04 INFO - 'SHELL': '/bin/bash', 16:40:04 INFO - 'SHLVL': '1', 16:40:04 INFO - 'TERM': 'linux', 16:40:04 INFO - 'TMOUT': '86400', 16:40:04 INFO - 'USER': 'cltbld', 16:40:04 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', 16:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:04 INFO - '_': '/tools/buildbot/bin/python'} 16:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:40:04 INFO - Running setup.py (path:/tmp/pip-gpS3cM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:40:04 INFO - Running setup.py (path:/tmp/pip-WGTbWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:40:04 INFO - Running setup.py (path:/tmp/pip-PoA_xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:40:04 INFO - Running setup.py (path:/tmp/pip-PycyWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:40:04 INFO - Running setup.py (path:/tmp/pip-RYXzic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:40:05 INFO - Running setup.py (path:/tmp/pip-s5m5Mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:40:05 INFO - Running setup.py (path:/tmp/pip-LucJVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:40:05 INFO - Running setup.py (path:/tmp/pip-1UUnd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:40:05 INFO - Running setup.py (path:/tmp/pip-YT4xGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:40:05 INFO - Running setup.py (path:/tmp/pip-ZNoShp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:40:05 INFO - Running setup.py (path:/tmp/pip-d7QqWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:40:05 INFO - Running setup.py (path:/tmp/pip-pr0pXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:40:05 INFO - Running setup.py (path:/tmp/pip-dKzPch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:40:05 INFO - Running setup.py (path:/tmp/pip-wIXsqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:05 INFO - Running setup.py (path:/tmp/pip-FO7kdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:40:05 INFO - Running setup.py (path:/tmp/pip-umrlpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:40:05 INFO - Running setup.py (path:/tmp/pip-HcVGOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:40:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:40:05 INFO - Running setup.py install for manifestparser 16:40:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:40:05 INFO - Running setup.py install for mozcrash 16:40:06 INFO - Running setup.py install for mozdebug 16:40:06 INFO - Running setup.py install for mozdevice 16:40:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:40:06 INFO - Running setup.py install for mozfile 16:40:06 INFO - Running setup.py install for mozhttpd 16:40:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:40:06 INFO - Running setup.py install for mozinfo 16:40:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:40:06 INFO - Running setup.py install for mozInstall 16:40:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:40:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:40:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:40:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:40:06 INFO - Running setup.py install for mozleak 16:40:06 INFO - Running setup.py install for mozlog 16:40:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:40:06 INFO - Running setup.py install for moznetwork 16:40:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:40:06 INFO - Running setup.py install for mozprocess 16:40:07 INFO - Running setup.py install for mozprofile 16:40:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Running setup.py install for mozrunner 16:40:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Running setup.py install for mozscreenshot 16:40:07 INFO - Running setup.py install for moztest 16:40:07 INFO - Running setup.py install for mozversion 16:40:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:40:07 INFO - Cleaning up... 16:40:07 INFO - Return code: 0 16:40:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40: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')]} 16:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40: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')]} 16:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:07 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 0x1c601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, '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 0x1efc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc840>, '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': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', '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 16:40:07 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 16:40:07 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 16:40:07 INFO - Using env: {'DISPLAY': ':0', 16:40:07 INFO - 'HOME': '/home/cltbld', 16:40:07 INFO - 'LANG': 'en_US.UTF-8', 16:40:07 INFO - 'LANGUAGE': 'en_US:en', 16:40:07 INFO - 'LOGNAME': 'cltbld', 16:40:07 INFO - 'MAIL': '/var/mail/cltbld', 16:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:07 INFO - 'MOZ_NO_REMOTE': '1', 16:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:07 INFO - 'NO_EM_RESTART': '1', 16:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:07 INFO - 'PWD': '/builds/slave/test', 16:40:07 INFO - 'SHELL': '/bin/bash', 16:40:07 INFO - 'SHLVL': '1', 16:40:07 INFO - 'TERM': 'linux', 16:40:07 INFO - 'TMOUT': '86400', 16:40:07 INFO - 'USER': 'cltbld', 16:40:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', 16:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:07 INFO - '_': '/tools/buildbot/bin/python'} 16:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:40:07 INFO - Running setup.py (path:/tmp/pip-cCsRYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:40:07 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)) 16:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:40:07 INFO - Running setup.py (path:/tmp/pip-mAyf2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:40:08 INFO - Running setup.py (path:/tmp/pip-QTo7Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:40:08 INFO - Running setup.py (path:/tmp/pip-ls04og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:40:08 INFO - Running setup.py (path:/tmp/pip-W1pOM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:40:08 INFO - Running setup.py (path:/tmp/pip-m26URZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:40:08 INFO - Running setup.py (path:/tmp/pip-gxaVii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:40:08 INFO - Running setup.py (path:/tmp/pip-yn9IMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:40:08 INFO - Running setup.py (path:/tmp/pip-TDLjgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:40:08 INFO - Running setup.py (path:/tmp/pip-9JYbDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:40:08 INFO - Running setup.py (path:/tmp/pip-Rv_A9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:40:08 INFO - Running setup.py (path:/tmp/pip-8w6zQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:40:08 INFO - Running setup.py (path:/tmp/pip-0aj13_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:40:08 INFO - Running setup.py (path:/tmp/pip-i6f0LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:08 INFO - Running setup.py (path:/tmp/pip-JjgVij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:08 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)) 16:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:40:08 INFO - Running setup.py (path:/tmp/pip-H3H0cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:40:09 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)) 16:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:40:09 INFO - Running setup.py (path:/tmp/pip-UXBWe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:40:09 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)) 16:40:09 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)) 16:40:09 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)) 16:40:09 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)) 16:40:09 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)) 16:40:09 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)) 16:40:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:40: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 16:40: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 16:40: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 16:40: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 16:40: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 16:40: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 16:40:11 INFO - Downloading blessings-1.6.tar.gz 16:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:40:11 INFO - Installing collected packages: blessings 16:40:11 INFO - Running setup.py install for blessings 16:40:11 INFO - Successfully installed blessings 16:40:11 INFO - Cleaning up... 16:40:11 INFO - Return code: 0 16:40:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:40:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:40:11 INFO - Reading from file tmpfile_stdout 16:40:11 INFO - Current package versions: 16:40:11 INFO - argparse == 1.2.1 16:40:11 INFO - blessings == 1.6 16:40:11 INFO - blobuploader == 1.2.4 16:40:11 INFO - docopt == 0.6.1 16:40:11 INFO - functools32 == 3.2.3-2 16:40:11 INFO - jsonschema == 2.5.1 16:40:11 INFO - manifestparser == 1.1 16:40:11 INFO - mozInstall == 1.12 16:40:11 INFO - mozcrash == 1.0 16:40:11 INFO - mozdebug == 0.1 16:40:11 INFO - mozdevice == 0.49 16:40:11 INFO - mozfile == 1.2 16:40:11 INFO - mozhttpd == 0.7 16:40:11 INFO - mozinfo == 0.9 16:40:11 INFO - mozleak == 0.1 16:40:11 INFO - mozlog == 3.4 16:40:11 INFO - moznetwork == 0.27 16:40:11 INFO - mozprocess == 0.25 16:40:11 INFO - mozprofile == 0.28 16:40:11 INFO - mozrunner == 6.13 16:40:11 INFO - mozscreenshot == 0.1 16:40:11 INFO - mozsystemmonitor == 0.3 16:40:11 INFO - moztest == 0.8 16:40:11 INFO - mozversion == 1.4 16:40:11 INFO - psutil == 3.1.1 16:40:11 INFO - requests == 1.2.3 16:40:11 INFO - wsgiref == 0.1.2 16:40:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40: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')]} 16:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40: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')]} 16:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:11 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 0x1c601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, '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 0x1efc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc840>, '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': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', '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 16:40:11 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 16:40:11 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 16:40:11 INFO - Using env: {'DISPLAY': ':0', 16:40:11 INFO - 'HOME': '/home/cltbld', 16:40:11 INFO - 'LANG': 'en_US.UTF-8', 16:40:11 INFO - 'LANGUAGE': 'en_US:en', 16:40:11 INFO - 'LOGNAME': 'cltbld', 16:40:11 INFO - 'MAIL': '/var/mail/cltbld', 16:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:11 INFO - 'MOZ_NO_REMOTE': '1', 16:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:11 INFO - 'NO_EM_RESTART': '1', 16:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:11 INFO - 'PWD': '/builds/slave/test', 16:40:11 INFO - 'SHELL': '/bin/bash', 16:40:11 INFO - 'SHLVL': '1', 16:40:11 INFO - 'TERM': 'linux', 16:40:11 INFO - 'TMOUT': '86400', 16:40:11 INFO - 'USER': 'cltbld', 16:40:11 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', 16:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:11 INFO - '_': '/tools/buildbot/bin/python'} 16:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:11 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)) 16:40:11 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)) 16:40:11 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)) 16:40:11 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)) 16:40:11 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)) 16:40:11 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)) 16:40:11 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)) 16:40:11 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)) 16:40:11 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)) 16:40:11 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)) 16:40:11 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)) 16:40:11 INFO - Cleaning up... 16:40:11 INFO - Return code: 0 16:40:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:40: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')]} 16:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40: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')]} 16:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1c601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, '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 0x1efc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc840>, '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': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', '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 16:40:11 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 16:40:11 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 16:40:11 INFO - Using env: {'DISPLAY': ':0', 16:40:11 INFO - 'HOME': '/home/cltbld', 16:40:11 INFO - 'LANG': 'en_US.UTF-8', 16:40:11 INFO - 'LANGUAGE': 'en_US:en', 16:40:11 INFO - 'LOGNAME': 'cltbld', 16:40:11 INFO - 'MAIL': '/var/mail/cltbld', 16:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:11 INFO - 'MOZ_NO_REMOTE': '1', 16:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:11 INFO - 'NO_EM_RESTART': '1', 16:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:11 INFO - 'PWD': '/builds/slave/test', 16:40:11 INFO - 'SHELL': '/bin/bash', 16:40:11 INFO - 'SHLVL': '1', 16:40:11 INFO - 'TERM': 'linux', 16:40:11 INFO - 'TMOUT': '86400', 16:40:11 INFO - 'USER': 'cltbld', 16:40:11 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', 16:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:11 INFO - '_': '/tools/buildbot/bin/python'} 16:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:40:12 INFO - Cleaning up... 16:40:12 INFO - Return code: 0 16:40:12 INFO - Running post-action listener: _resource_record_post_action 16:40:12 INFO - Running post-action listener: _start_resource_monitoring 16:40:12 INFO - Starting resource monitoring. 16:40:12 INFO - [mozharness: 2017-03-29 23:40:12.068796Z] Finished create-virtualenv step (success) 16:40:12 INFO - [mozharness: 2017-03-29 23:40:12.069325Z] Running install step. 16:40:12 INFO - Running pre-action listener: _resource_record_pre_action 16:40:12 INFO - Running main action method: install 16:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:40:12 INFO - Reading from file tmpfile_stdout 16:40:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:40:12 INFO - Reading from file tmpfile_stdout 16:40:12 INFO - Output received: 16:40:12 INFO - Usage: mozinstall [options] installer 16:40:12 INFO - Options: 16:40:12 INFO - -h, --help show this help message and exit 16:40:12 INFO - -d DEST, --destination=DEST 16:40:12 INFO - Directory to install application into. [default: 16:40:12 INFO - "/builds/slave/test"] 16:40:12 INFO - --app=APP Application being installed. [default: firefox] 16:40:12 INFO - mkdir: /builds/slave/test/build/application 16:40:12 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'] 16:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:40:29 INFO - Reading from file tmpfile_stdout 16:40:29 INFO - Output received: 16:40:29 INFO - /builds/slave/test/build/application/firefox/firefox 16:40:29 INFO - Running post-action listener: _resource_record_post_action 16:40:29 INFO - [mozharness: 2017-03-29 23:40:29.295693Z] Finished install step (success) 16:40:29 INFO - [mozharness: 2017-03-29 23:40:29.295969Z] Running run-tests step. 16:40:29 INFO - Running pre-action listener: _resource_record_pre_action 16:40:29 INFO - Running main action method: run_tests 16:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:40:29 INFO - Python 2.7.3 16:40:29 INFO - Return code: 0 16:40:29 INFO - grabbing minidump binary from tooltool 16:40: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')]} 16:40:29 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 0x1efb400>, '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 0x1efc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:40:29 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 16:40:29 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 16:40:29 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 16:40:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:40:29 INFO - Return code: 0 16:40:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:40:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:40:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:40:29 INFO - ENV: RUST_BACKTRACE is now 1 16:40:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:40:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:40:29 INFO - Using env: {'DISPLAY': ':0', 16:40:29 INFO - 'HOME': '/home/cltbld', 16:40:29 INFO - 'LANG': 'en_US.UTF-8', 16:40:29 INFO - 'LANGUAGE': 'en_US:en', 16:40:29 INFO - 'LOGNAME': 'cltbld', 16:40:29 INFO - 'MAIL': '/var/mail/cltbld', 16:40:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:40:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:29 INFO - 'MOZ_NO_REMOTE': '1', 16:40:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:29 INFO - 'NO_EM_RESTART': '1', 16:40:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:29 INFO - 'PWD': '/builds/slave/test', 16:40:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:40:29 INFO - 'RUST_BACKTRACE': '1', 16:40:29 INFO - 'SHELL': '/bin/bash', 16:40:29 INFO - 'SHLVL': '1', 16:40:29 INFO - 'TERM': 'linux', 16:40:29 INFO - 'TMOUT': '86400', 16:40:29 INFO - 'USER': 'cltbld', 16:40:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539', 16:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:29 INFO - '_': '/tools/buildbot/bin/python'} 16:40:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:40:29 INFO - mozversion application_buildid: 20170329224207 16:40:29 INFO - mozversion application_changeset: 60d7a0496a3673450ddbc37ec387525148c32604 16:40:29 INFO - mozversion application_display_name: Nightly 16:40:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:40:29 INFO - mozversion application_name: Firefox 16:40:29 INFO - mozversion application_remotingname: firefox 16:40:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:40:29 INFO - mozversion application_vendor: Mozilla 16:40:29 INFO - mozversion application_version: 55.0a1 16:40:29 INFO - mozversion platform_buildid: 20170329224207 16:40:29 INFO - mozversion platform_changeset: 60d7a0496a3673450ddbc37ec387525148c32604 16:40:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:40:29 INFO - mozversion platform_version: 55.0a1 16:40:29 INFO - using testdate: 1490830829 16:40:29 INFO - actual date: 1490830829 16:40:29 INFO - starting webserver on 'localhost:41505' 16:40:29 INFO - SUITE-START | Running 2 tests 16:40:29 INFO - TEST-START | dromaeo_css 16:40:29 INFO - operating with platform_type : linux_ 16:40:29 INFO - Initialising browser for dromaeo_css test... 16:40:29 INFO - TEST-INFO | started process 16565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYoBpFE/profile http://localhost:41505/getInfo.html) 16:40:33 INFO - PID 16565 | __metrics Screen width/height:1600/1200 16:40:33 INFO - PID 16565 | colorDepth:24 16:40:33 INFO - PID 16565 | Browser inner width/height: 1024/697 16:40:33 INFO - PID 16565 | __metrics 16:40:33 ERROR - PID 16565 | 1490830833793 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 16:40:33 INFO - PID 16565 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:40:33 INFO - PID 16565 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:40:34 INFO - TEST-INFO | 16565: exit 0 16:40:34 INFO - Browser initialized. 16:40:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:40:34 INFO - TEST-INFO | started process 16659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYoBpFE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:40:46 INFO - PID 16659 | RSS: Main: 144478208 16:40:46 INFO - PID 16659 | 16:43:48 INFO - PID 16659 | Cycle 1(1): loaded http://localhost:41505/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41505/tests/dromaeo/cssquery-ext.html) 16:43:50 INFO - PID 16659 | RSS: Main: 300920832 16:43:50 INFO - PID 16659 | 16:45:36 INFO - PID 16659 | ************************* 16:45:36 INFO - PID 16659 | A coding exception was thrown and uncaught in a Task. 16:45:36 INFO - PID 16659 | 16:45:36 ERROR - PID 16659 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:45:36 INFO - PID 16659 | Full stack: 16:45:36 INFO - PID 16659 | ************************* 16:45:36 INFO - PID 16659 | ************************* 16:45:36 INFO - PID 16659 | A coding exception was thrown and uncaught in a Task. 16:45:36 INFO - PID 16659 | 16:45:36 ERROR - PID 16659 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:45:36 INFO - PID 16659 | Full stack: 16:45:36 INFO - PID 16659 | ************************* 16:45:36 INFO - PID 16659 | ************************* 16:45:36 INFO - PID 16659 | A coding exception was thrown and uncaught in a Task. 16:45:36 INFO - PID 16659 | 16:45:36 ERROR - PID 16659 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:45:36 INFO - PID 16659 | Full stack: 16:45:36 INFO - PID 16659 | ************************* 16:45:36 INFO - PID 16659 | ************************* 16:45:36 INFO - PID 16659 | A coding exception was thrown and uncaught in a Task. 16:45:36 INFO - PID 16659 | 16:45:36 ERROR - PID 16659 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:45:36 INFO - PID 16659 | Full stack: 16:45:36 INFO - PID 16659 | ************************* 16:46:53 INFO - PID 16659 | Cycle 1(1): loaded http://localhost:41505/tests/dromaeo/cssquery-ext.html (next: http://localhost:41505/tests/dromaeo/cssquery-jquery.html) 16:46:53 INFO - PID 16659 | RSS: Main: 234377216 16:46:53 INFO - PID 16659 | 16:49:55 INFO - PID 16659 | Cycle 1(1): loaded http://localhost:41505/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41505/tests/dromaeo/cssquery-mootools.html) 16:49:56 INFO - PID 16659 | RSS: Main: 181563392 16:49:56 INFO - PID 16659 | 16:52:58 INFO - PID 16659 | Cycle 1(1): loaded http://localhost:41505/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41505/tests/dromaeo/cssquery-prototype.html) 16:52:58 INFO - PID 16659 | RSS: Main: 178556928 16:52:58 INFO - PID 16659 | 16:56:01 INFO - PID 16659 | Cycle 1(1): loaded http://localhost:41505/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41505/tests/dromaeo/cssquery-yui.html) 16:56:02 INFO - PID 16659 | RSS: Main: 182943744 16:56:02 INFO - PID 16659 | 16:59:04 INFO - PID 16659 | Cycle 1(1): loaded http://localhost:41505/tests/dromaeo/cssquery-yui.html (next: http://localhost:41505/tests/dromaeo/cssquery-dojo.html) 16:59:04 INFO - PID 16659 | RSS: Main: 273965056 16:59:04 INFO - PID 16659 | 16:59:04 INFO - PID 16659 | __start_tp_report 16:59:04 INFO - PID 16659 | _x_x_mozilla_page_load 16:59:04 INFO - PID 16659 | _x_x_mozilla_page_load_details 16:59:04 INFO - PID 16659 | |i|pagename|runs| 16:59:04 INFO - PID 16659 | |0;dojo.html;3247.626522949861;3259.8696052157916;3296.6373698893117;3322.202671358875;3331.550240717502;5819.709014549277;5895.263092113486;5904.143899134629;5922.615030023051;5943.435373639508;5865.76536938522;5910.172575839375;5915.378885217055;5976.133460648203;6051.213342265511;5198.246254293125;5274.525292723654;5309.522143007129;5333.653312534673;5415.64798288112;5288.286081379003;5321.414644389133;5367.892642147155;5369.7583608737505;5370.758315875795;5220.817271395502;5266.710330931797;5300.867478313054;5307.601929855237;5357.249985002103;5284.022455845642;5319.361676598833;5342.946570534284;5379.67721936685;5397.433269506724;5257.710825904612;5270.894582108374;5288.65623734456;5338.039152952467;5360.303160589137;5783.132530120473;5848.561357898175;5874.030784920483;5922.230110085704;5957.791477298274;6219.937800622027;6331.8417039573915;6336.96831515844;6340.524460665469;6345.80962571119;6483.7082331295205;6486.481081513515;6497.18785151856;6507.056476810836;6517.055027021055;5881.705914704247;5963.642181469126;5976.103584462322;5992.64044157352;5999.820005399845;6324.9051264231075;6417.358264173546;6492.318306577836;6577.967110164514;6578.440832529192;6133.570650054453;6165.938340616536;6171.382861713792;6214.751409943642;6288.088227207029;6329.556931014877;6336.968315158395;6344.175257216532;6365.108884756138;6392;6382.776602818879;6386.10594516768;6394.456471199907;6397.072424498421;6401.55189136756;6149.200603921551;6225.28409232935;6304.873902522016;6363.5863668861375;6372;4838.153323168432;4841.830535931225;4842.249451335048;4879.39007624047;4887.560119589183;4272.124214536013;4274.380214868826;4275.40144379787;4314.956850431518;4319.114581510783;5755.309362876482;5843.123531470228;5893.027650437715;5913.965056115248;5916.645001299936;6390.680465976682;6415.615063096229;6418.614883107029;6427.678616069178;6431;5892.734826932799;5924.4667979882015;5941.494972927349;5943.995194765866;5989.640621562633;5338.3060202173465;5361.571074314045;5402.567794576425;5423.701696406735;5436;6477.028445733178;6554.082428460019;6561.179852518435;6561.179852518435;6572.211334639874;6425.453836423956;6429;6434.935650643621;6437.774677886251;6438.066480360415;6473.77341793035;6611.404973552211;6674.866502670016;6677.799666010027;6680.432163266177;6233;6247.96876015617;6289.182406287154;6331.303556608861;6337.524685648687;6469.353064693493;6472.838179045561;6477.740890364333;6480.351964803671;6482.513811464065;6097.0105204680185;6121.571489995657;6171.444569988723;6270.090836828543;6273.247210334789;6184.443400094013;6246.437820596168;6272.341404152498;6282.717277722422;6282.748690052529;6186.226721659793;6223.097650840693;6232.407921247474;6235.75056997715;6244.375562443719;6112.10835914862;6282.968585157228;6295.5907865988565;6298.1812364392335;6300.054991751274;6003.7898673546215;6054.727537260922;6100.694965251809;6105.603135796159;6106.847328816815 16:59:04 INFO - PID 16659 | |1;ext.html;712.9857402851943;772.980675483113;791.3471386106462;1120.9831852522213;1134.6482590396984;30820.38359232817;38349.424758628644;38844.53287871896;38895.41656875149;38924;41818.790906045506;42216.366754498704;42301.15397692045;42326.15347693044;42364.364534532004;8232.012158540969;8324.209200126008;8381.580920953958;8401.117882622328;8411.789705257357;5965.46310832025;6129.295131059941;7995.200479952016;8291.709790157345;8296.875546866802;8206.835863282731;8289.875651865197;8289.917100829005;8294.294984926288;8302.70940517082;8179.877301840477;8182.386321025947;8226.341892648634;8240.13478584746;8254.793630159264;8127.268545830844;8220.876686849702;8223.42436029478;8238;8250.339972802221;38347.616523834964;38583.42124868129;38653.80673096645;38664;38674.1325867411;2943.2200466876293;2976.2113040044405;2982.164993801717;2985.477541430241;2994.9850250748605;28098;28192.85903570469;28218.77228591801;28571.428571428456;28609.427811443653;3610.963890361089;3615.313090512794;3640.9453858192146;3644.835982380799;3784.3188226119287;228701;230526;230871;232762;233014.83492582597;49837.501624983284;49938;49953.50046499561;50063.749681251364;50194;51980.22029669558;52011;52203;52244.171453998926;52248.47751522436;14865.851341486446;15103;15115.924420377827;15124.39502419913;15128.773068403983;10748.462576871125;12279.508819647113;12292.508299667914;12320.075994300463;12323.198992065487;11749.118816088827;11922.523099076114;11950.223235489666;12166.939165304117;12196;5090.567301779316;5113.258577506315;5177.508136727005;5221.921671174935;5235.162374020215;1006.5822683586376;1018.3228153278135;1019.3527110285022;1029.577873072037;1037.9377237365782;25227.981642262443;25409.745902541108;25458.745412546006;25620.615690764655;25632;1105.9778804423865;1109.4951796932376;1124.2692250037542;1125.2798209146154;1125.876153623101;12706;12940.417681204368;13183.934080329536;13233.139845909986;13320.534741178462;275210;275467;275486;275630;276880;54010.18984715232;54101.45898540964;54200.45799542033;54218.728906355216;54293.45706542963;1427.7715565509468;1444.6117359942498;1477.8448262932452;1481.0373257382787;1485.6731519065788;23650.053997839892;24160.800019900853;24186.87906560456;24225.096301618723;24492;39434.80282598569;39567.80216098901;39612.80193599014;39623.40564891587;39680.80159599299;280929;281003;282076;282086;282778;26772.330691732084;32365.352692945537;32577;32732;32778.672213278514;34116.6007999128;39618.405723914744;40265.79867100646;40705.79647101746;42004;29920.25199370033;30182.547261790653;30698;31250.843745781127;31624.209394764395;31490;31514.52728209033;31663.52504712477;31836.681633183372;32522;37823.243535129695;38019.61980380161;38637.80681096577;38684.41973370458;38841.805790970866;30689.232769180948;31160.53259201159;31379.21551961128;31454.37091258208;31461.8426907864;23794.524109518057;25385.746142538337;25445.61831572565;25493.362665932756;25753.871230643726 16:59:04 INFO - PID 16659 | |2;jquery.html;430.6379508396446;433.5296203619073;439.5143366579929;450.4526999695369;453.4535884259466;19682.606347873036;20835;21309.36071917845;21593.568128637417;21712.89143554282;21177;21641.026153823077;21939.6709049364;22153.224637137704;22514.774852251474;5810.418958104187;5979.312379076418;6004.969975150118;6017.939820601781;6026.0960855871535;5660.235868157808;5893.38119497453;5924.466797988181;5937.37657545958;5946.821595352147;5816;5882.441168089046;5902.232709747726;5905.527557795366;5910.556708246877;5806.332271788735;5894.322152952401;5899.262592175999;5914.7929822456435;5923.763049478016;5313.203019547061;5324.520793128637;5353.143497040455;5356.651817631841;5369.865753356158;25451.745482545124;25622.359441013938;25885.870570647025;25940.481190376086;26113.477730445284;2054.6917962305624;2058.763242227133;2066.411072844232;2080.147139672727;2098.9265375711775;15700.528984130495;15960.840391596052;16272;16333.673326533522;17115.57211069721;1745.4240100766717;1765.3556451895095;1783.6432713457232;1804.2859283680557;1826.3516451659734;111145;116526.41736791261;116812.83187168105;116820;117664;12403.565875194325;12502.062345324137;12529.041650463047;12554.560590379293;12615.432305546272;17583.64832703339;17602.215523662475;17629.206685699173;17987.910060449613;18076.276948921895;8707.259882910024;8715.38992270535;8734.95632521846;8860.8670869937;9031.412958157698;8026.478278911852;8070.2333278338465;8236.217559331853;8265.586720663943;8310;7760.495567788075;7814;7843.9215607844335;7938.841223175504;7955.687311593638;2179.8854213930076;2187.147012665062;2217.8114860236738;2261.7285925688693;2365.9171928982405;983.3460748602242;993.5032483758121;1000.8748906386702;1006.4615430744517;1032.1742605915238;20090.39728808138;20360.18559257643;20392.592148156953;20525.38423847287;20628.17487300491;1043.113353649392;1046.35126221743;1049.6641074856125;1057.7201586080928;1069.9518521666544;9984.80030399388;11144.108471322275;11146.554137834395;11180.105591552656;11283.323000619988;553623;562580;563819;579876;580019.8991045413;99342.50328748455;100129;103655.96344036613;104562.81748729966;107902.46048769706;1167.3521195736278;1211.2006075989805;1231.8768123187788;1235.9629211123681;1236.715555422258;17125.842875952283;17244.310227591257;17284.91357543204;17541.298348065935;17713.380031698827;47245.29132062953;47945.520544794104;48139.037219254715;49139.75430122826;49330.013399732525;59632.40367596268;61071;62142;62198;62613;9101.77245568866;9331.86002209981;9419.481928493724;9563.713088607354;9778.07108324708;14922.284971762534;14992.100473971597;15078.849211508183;15115.395384184509;15403.922980385474;13052.5431609897;13075.738485230433;13258.270795106362;13262.204267743966;13562.86437135616;11253.043491303331;11467.713307167387;11691.298522088702;11720.062395008208;11899.286042837457;11341.376224307742;11432.485538150637;11692.47383867711;11788.70528236801;13111.803322949972;9230.35387522867;9316.906830931604;9348.719538413858;9406.905930940877;9569.330146889652;12631.684207894876;12797;12886;13275.937924966172;13485.190888546325 16:59:04 INFO - PID 16659 | |3;mootools.html;1180.3154170581063;1266.3858028856005;1318.7889937609982;1321.8281623388957;1327.8539360670325;9331.44011359318;10827.67516974491;11258.493367798448;11258.605948791794;11292.830607540893;10950.561977520909;10974.780504389928;11031.172662050338;11045.447727613628;11051.613193538227;1760.3662681434673;1839.8436132928716;2337.123578658003;2389.0921449849034;2390.3307074019217;2344.7186337639505;2405.9037638494437;2422.7819496245334;2430.744771798962;2431.841930274535;2333.9533209335805;2335.6613291072786;2341.3912382780513;2342.61346877765;2346.3430239532872;2296.8851557422063;2311.84972976756;2316.119874447716;2320.4662927526765;2323.3378487131085;2185.4317877351846;2281.5094754627835;2310.06442390832;2318.177047148255;2319.362175401778;10986.450677466095;11086.501107450104;11091.778164436746;11108.16688748347;11113.833292500538;5888;6061.605995610271;6063.393660633946;6063.969680151615;6069.6054756441135;3653.3971894637352;3676.8674168982193;3876.8449262029485;3931.0368959604793;3947.8026098695236;1325.3042152869725;1352.229229339277;1364.304204855521;1391.3182540555056;1411.4848080450665;16778.580535486588;16820.74768878468;16825.66348673032;16831.91584042072;16840.57898552546;5173;5498.642588231752;5565.833025009256;5598.776048957996;5614.691191984399;13610.863891361158;13621.795673064911;13630.386632601556;13634.727305453835;13635.727285454235;6325.335839736854;6357.841053973688;6358;6358.1416508771645;6358.205224346957;4829.73436460998;4982.701037937735;5666.320041595035;5791.768329266866;5819.359870414251;4111.502698357448;4138.296489596776;4175.144095460423;4193.686559284386;4199.874003779892;1183.5029287699188;1188.7028242939266;1199.0587388899671;1209.7036226124656;1212.3635091576816;775.2518819339365;779.3842864137268;783.3419927261128;792.3661071143063;799.0690845165434;6414.583052101599;6660;6692.364225398579;6729.49528785343;6866.279040700654;905.3255324783079;913.1918252346588;915.7939463620766;919.9034101419388;928.0441145620022;3906.3314129188766;4185.393117997874;4228.534861165269;4330.458692663417;4382.69321147523;14201.644958875904;14290.499832505813;14521.201333926525;14850.628734281514;14854.183019933791;14474.638134046732;14680.779788303184;14729.337179826933;14855.554333370017;14870.330835112445;10387.117095046855;10389.428581427943;10461.947690261652;10579.735506612396;10686.625968091079;6683.4319082876555;6722.563033402813;6772.11962444879;6781.525293229427;6789.558678685869;13062.085654004128;13198.80201796993;13302.866971330162;13334.733305334034;13355.131916425402;13116.081874269092;13242.867571324163;13251.66870828237;13314.600561983156;13391.263480508665;8017.759467215993;8226.30076443509;9249.583768730557;9476.763080923032;9500.524973751146;10299.279050466695;10627.149828013586;10712.946435267773;10736.248462607855;10748.570057197938;8940.552972351486;8948.73153805387;9006.144416280444;9090.863637045582;9148.222401095714;8788.34087443457;8899.822003559762;8954.731358059269;9038.141376569216;9057.68298109563;7780.183080776437;7795.207102366601;7896.921030789618;7937.285644292041;7966.243206895336;5891.116332550152;5972.13404056418;6016.458518733335;6031.09533569968;6032.879342413039;5856.472917437451;5905.40945905406;5912.5861189718025;6010.33886272501;6227.906581401192 16:59:04 INFO - PID 16659 | |4;prototype.html;401.37986810378;421.9914404573071;425.0690986739042;429.374816320228;434.25091716788523;5927.228580992305;5964.731587078586;5971.984762590359;5988.70056497175;5996.790112346069;5739.885202295952;5882.382349853268;5907.970460147693;5913.231279933602;5930.495907847828;4649.790759415826;4658.161530924449;4675.358422491281;4676.643773305737;4700.294955756647;4681.993371425143;4684.929726054112;4692.718436893781;4693.647976401767;4717.504662010491;4514.164879497303;4655.255159174532;4670.392848929651;4676.638297659694;4679.976600117012;4633.698809577383;4663.88340291492;4666.580007799314;4677.321788340706;4683.274092515666;4223.788810559459;4231.597998190197;4232.174725928445;4235.25882970479;4238.364245363189;5651.265335506358;5800;5837.474627283523;5859.150423188614;5864.794732184353;5484.122540393518;5489.533389661883;5491.846712190445;5496.642718223303;5523.171524271352;6294.87410251797;6297.590656607306;6300.3384644612115;6310.274318453391;6324.462420694201;4544;4689.460712018127;4702.4592171899985;4710.5289471052965;4717.433907931036;6239.220097487814;6386.87226255477;6405.455536279375;6478.611283322968;6481.4166724994975;4800.855974320776;4853.854384368475;4859.902801943941;4866.635002374836;4881.8535443936735;4647.140279048387;4770.332153498513;4921.926171107436;4929.334539837076;4931.358923340014;5346.251524786533;5439.891202175934;5439.980810650127;5441.156620723794;5450.3732070811575;6252.718627661766;6261.154744109487;6262.5929314594405;6280.1280802449855;6287.685615719287;1523.8494936323004;1582.6518166003461;1591.38731588337;1594.5933786884502;1691.8984860908386;1047.2407504559133;1081.0648788797791;1089.0253223365044;1090.7000574841982;1097.3635291530893;5881.2942446906645;5894.8821023579285;5897.262842144732;5939.495142912814;5951.256092988377;6360.332165122595;6399.55203135776;6404.615723056631;6405.903911441332;6436.195475565554;5740.454656807597;5892.558058145656;5936.970315148396;5999.610025348338;6023.216981792339;3380.5970522232997;3399.133221028622;3403.0981789825714;3414.3854106260615;3423.640517745651;6448.258450278278;6691.899621505681;6708.429783468362;6714.429273511709;6717.16035495563;6596;6608.107905432801;6629.237637671633;6630.403263706289;6646.567973081735;6512.706928188148;6681.599104053772;6701.664916754143;6721.00915092779;6748.4938629602975;6453.225612926479;6463.838404039937;6468.6442245676935;6476.514261430506;6478.449331806849;6131.785387511416;6221.844453888689;6264.123022776724;6394.136791533084;6410.262819775786;6217.720202590804;6549.541532092899;6608.207015158212;6610.768623098168;6635;4467.798949047366;4528.90942181148;4558.677983384914;4562.384078149407;4563.338315944236;6435.806925792233;6446.0975463434215;6454.8703976802935;6477.643729594917;6488.448481878904;6228.875422491616;6228.937710622836;6236.906446403217;6237.282712488122;6247.750089996349;6030.638161710312;6137.570370074052;6182.443580077815;6233.625982441068;6255.781047663492;6151.3541078186145;6187.628742275478;6190.907136392868;6201.441870231701;6208.192934918432;6002.759889604367;6227.844303892439;6236.719347629277;6261.937380626136;6268.216472940882;6059.787907423219;6059.818205453844;6067.211262535842;6094.603850749687;6115.296740874856 16:59:04 INFO - PID 16659 | |5;yui.html;679.4801976487985;696.2132789947359;699.6956323999061;700.0793955947928;706.3360441185289;16368.427105051325;17031.82968170318;17039.062851543193;17109.40117095902;17274.65450690987;14885.92557037216;15350.155741434217;15443.382264709398;15450.536483905473;15671.84328156721;869.061413673233;895.1853813030111;898.0256421782341;898.0884402331606;898.7169041751828;925.3846192282124;956.0869369751905;956.9617215311379;958.5351104714208;958.9136977672008;958.884933807944;989.1641562879391;990.6631745206628;991.013941128578;991.2516050381952;951.3293128344501;980.431349817108;981.5533932060895;982.3369225772575;982.778874753182;700.7722490190708;713.5076797010047;721;721.2426951700693;722.4076257468878;14138.50515231962;15221.61945951349;15331.846681533154;15349.232538373148;15397;12582.37088145589;12599.3070381129;12777.936110319482;12817;13180.604581862559;11173.72065698356;11305.095592352593;11498.482568284448;11540.826887596693;11583;2882.437924604703;2955.5123404638207;2973.5391014392803;2974.375381169957;3068.3096303331795;75858.62070689611;76068.23931760667;76576.63963522555;77302;77755.6112219441;9462.52687365629;9474.95262523683;9557.187639050619;9737.805243895082;9759.756006099904;19870.205191792455;19919.20323187085;19972.20111195565;20122.89938550298;20187.899060504602;7595.810104747315;7651.311381975537;7819.569923654253;7912.525248484994;8027.6788928443375;3972.324704800191;3987.7208595398624;4010.8287381123887;4013.4581831452965;4069.2675318442966;4045.2516284487465;4073.5111786585207;4091.243120022805;4109.075458021921;4117.382392641068;723.2153113871403;726.1576571177409;742.9962850185823;744.263179452349;752.1463139336892;587.4155215560545;600.6216083867135;604.3623976704619;616.6639181646013;616.8149555133532;10245.180385569136;10257.846132308021;10309.360153142781;10385.948070259601;10591.523381447852;616.703982088591;619.3985261899948;631.4159402552621;631.4727202785633;631.823089534931;4599.609033232213;4857.562819346276;4868.902621947541;4869.123557759566;4893.828715994994;77275.61362193154;77563.61218193873;77915;80389.59805200937;80407.59796200982;67573;68058;68232.6588367055;68300.3169968294;68341.65829170823;58191.418085819445;58788;58806.411935880096;59003.379391709044;59094;9495.952520237355;9786.217102631916;9854.901450985399;9869;10007.199424046205;32766.344673105927;33049.50425743664;33426;33556.328873422884;34839.30321393609;40826.591734083464;40843.38734918919;41657.58342416537;41665.1666966665;42154.578454215065;11839.26443384061;11966;11997.160198786001;12295.32375719344;12452.439640216031;13131.60605181846;13196;13226.933865330611;13523.188608683511;13931.512397066459;12198.756024879276;12203.633890983285;12439.191452555555;12638.304893230961;13091.410886509939;12294.46823804267;12764.425600847799;12929.288889110812;13006.609801705965;13124.803127953279;11996.520139194334;12625.305608191271;12740.872591273968;12811.87188128144;13033.608991730263;9233.58448869816;9501.904980950101;9676.806463870542;9693.515324233902;9696.369735967139;9522.381045232038;9947.801043979225;10107;10260.384376937109;10267 16:59:04 INFO - PID 16659 | __end_tp_report 16:59:04 INFO - PID 16659 | __start_cc_report 16:59:04 INFO - PID 16659 | _x_x_mozilla_cycle_collect,1621 16:59:04 INFO - PID 16659 | __end_cc_report 16:59:04 INFO - PID 16659 | __startTimestamp1490831944962__endTimestamp 16:59:04 INFO - PID 16659 | 16:59:04 INFO - PID 16659 | ------- Summary: start ------- 16:59:04 INFO - PID 16659 | Number of tests: 6 16:59:04 INFO - PID 16659 | 16:59:04 INFO - PID 16659 | [#0] dojo.html Cycles:165 Average:5884.85 Median:6121.57 stddev:709.33 (11.6%) stddev-sans-first:680.67 16:59:04 INFO - PID 16659 | Values: 3247.6 3259.9 3296.6 3322.2 3331.6 5819.7 5895.3 5904.1 5922.6 5943.4 5865.8 5910.2 5915.4 5976.1 6051.2 5198.2 5274.5 5309.5 5333.7 5415.6 5288.3 5321.4 5367.9 5369.8 5370.8 5220.8 5266.7 5300.9 5307.6 5357.2 5284.0 5319.4 5342.9 5379.7 5397.4 5257.7 5270.9 5288.7 5338.0 5360.3 5783.1 5848.6 5874.0 5922.2 5957.8 6219.9 6331.8 6337.0 6340.5 6345.8 6483.7 6486.5 6497.2 6507.1 6517.1 5881.7 5963.6 5976.1 5992.6 5999.8 6324.9 6417.4 6492.3 6578.0 6578.4 6133.6 6165.9 6171.4 6214.8 6288.1 6329.6 6337.0 6344.2 6365.1 6392.0 6382.8 6386.1 6394.5 6397.1 6401.6 6149.2 6225.3 6304.9 6363.6 6372.0 4838.2 4841.8 4842.2 4879.4 4887.6 4272.1 4274.4 4275.4 4315.0 4319.1 5755.3 5843.1 5893.0 5914.0 5916.6 6390.7 6415.6 6418.6 6427.7 6431.0 5892.7 5924.5 5941.5 5944.0 5989.6 5338.3 5361.6 5402.6 5423.7 5436.0 6477.0 6554.1 6561.2 6561.2 6572.2 6425.5 6429.0 6434.9 6437.8 6438.1 6473.8 6611.4 6674.9 6677.8 6680.4 6233.0 6248.0 6289.2 6331.3 6337.5 6469.4 6472.8 6477.7 6480.4 6482.5 6097.0 6121.6 6171.4 6270.1 6273.2 6184.4 6246.4 6272.3 6282.7 6282.7 6186.2 6223.1 6232.4 6235.8 6244.4 6112.1 6283.0 6295.6 6298.2 6300.1 6003.8 6054.7 6100.7 6105.6 6106.8 16:59:04 INFO - PID 16659 | 16:59:04 INFO - PID 16659 | [#1] ext.html Cycles:180 Average:42151.31 Median:31643.87 stddev:68906.82 (217.8%) stddev-sans-first:69029.88 16:59:04 INFO - PID 16659 | Values: 713.0 773.0 791.3 1121.0 1134.6 30820.4 38349.4 38844.5 38895.4 38924.0 41818.8 42216.4 42301.2 42326.2 42364.4 8232.0 8324.2 8381.6 8401.1 8411.8 5965.5 6129.3 7995.2 8291.7 8296.9 8206.8 8289.9 8289.9 8294.3 8302.7 8179.9 8182.4 8226.3 8240.1 8254.8 8127.3 8220.9 8223.4 8238.0 8250.3 38347.6 38583.4 38653.8 38664.0 38674.1 2943.2 2976.2 2982.2 2985.5 2995.0 28098.0 28192.9 28218.8 28571.4 28609.4 3611.0 3615.3 3640.9 3644.8 3784.3 228701.0 230526.0 230871.0 232762.0 233014.8 49837.5 49938.0 49953.5 50063.7 50194.0 51980.2 52011.0 52203.0 52244.2 52248.5 14865.9 15103.0 15115.9 15124.4 15128.8 10748.5 12279.5 12292.5 12320.1 12323.2 11749.1 11922.5 11950.2 12166.9 12196.0 5090.6 5113.3 5177.5 5221.9 5235.2 1006.6 1018.3 1019.4 1029.6 1037.9 25228.0 25409.7 25458.7 25620.6 25632.0 1106.0 1109.5 1124.3 1125.3 1125.9 12706.0 12940.4 13183.9 13233.1 13320.5 275210.0 275467.0 275486.0 275630.0 276880.0 54010.2 54101.5 54200.5 54218.7 54293.5 1427.8 1444.6 1477.8 1481.0 1485.7 23650.1 24160.8 24186.9 24225.1 24492.0 39434.8 39567.8 39612.8 39623.4 39680.8 280929.0 281003.0 282076.0 282086.0 282778.0 26772.3 32365.4 32577.0 32732.0 32778.7 34116.6 39618.4 40265.8 40705.8 42004.0 29920.3 30182.5 30698.0 31250.8 31624.2 31490.0 31514.5 31663.5 31836.7 32522.0 37823.2 38019.6 38637.8 38684.4 38841.8 30689.2 31160.5 31379.2 31454.4 31461.8 23794.5 25385.7 25445.6 25493.4 25753.9 16:59:04 INFO - PID 16659 | 16:59:04 INFO - PID 16659 | [#2] jquery.html Cycles:180 Average:33557.78 Median:21617.30 stddev:94090.32 (435.3%) stddev-sans-first:94321.39 16:59:04 INFO - PID 16659 | Values: 430.6 433.5 439.5 450.5 453.5 19682.6 20835.0 21309.4 21593.6 21712.9 21177.0 21641.0 21939.7 22153.2 22514.8 5810.4 5979.3 6005.0 6017.9 6026.1 5660.2 5893.4 5924.5 5937.4 5946.8 5816.0 5882.4 5902.2 5905.5 5910.6 5806.3 5894.3 5899.3 5914.8 5923.8 5313.2 5324.5 5353.1 5356.7 5369.9 25451.7 25622.4 25885.9 25940.5 26113.5 2054.7 2058.8 2066.4 2080.1 2098.9 15700.5 15960.8 16272.0 16333.7 17115.6 1745.4 1765.4 1783.6 1804.3 1826.4 111145.0 116526.4 116812.8 116820.0 117664.0 12403.6 12502.1 12529.0 12554.6 12615.4 17583.6 17602.2 17629.2 17987.9 18076.3 8707.3 8715.4 8735.0 8860.9 9031.4 8026.5 8070.2 8236.2 8265.6 8310.0 7760.5 7814.0 7843.9 7938.8 7955.7 2179.9 2187.1 2217.8 2261.7 2365.9 983.3 993.5 1000.9 1006.5 1032.2 20090.4 20360.2 20392.6 20525.4 20628.2 1043.1 1046.4 1049.7 1057.7 1070.0 9984.8 11144.1 11146.6 11180.1 11283.3 553623.0 562580.0 563819.0 579876.0 580019.9 99342.5 100129.0 103656.0 104562.8 107902.5 1167.4 1211.2 1231.9 1236.0 1236.7 17125.8 17244.3 17284.9 17541.3 17713.4 47245.3 47945.5 48139.0 49139.8 49330.0 59632.4 61071.0 62142.0 62198.0 62613.0 9101.8 9331.9 9419.5 9563.7 9778.1 14922.3 14992.1 15078.8 15115.4 15403.9 13052.5 13075.7 13258.3 13262.2 13562.9 11253.0 11467.7 11691.3 11720.1 11899.3 11341.4 11432.5 11692.5 11788.7 13111.8 9230.4 9316.9 9348.7 9406.9 9569.3 12631.7 12797.0 12886.0 13275.9 13485.2 16:59:04 INFO - PID 16659 | 16:59:04 INFO - PID 16659 | [#3] mootools.html Cycles:180 Average:7024.67 Median:2414.34 stddev:4546.73 (188.3%) stddev-sans-first:4538.27 16:59:04 INFO - PID 16659 | Values: 1180.3 1266.4 1318.8 1321.8 1327.9 9331.4 10827.7 11258.5 11258.6 11292.8 10950.6 10974.8 11031.2 11045.4 11051.6 1760.4 1839.8 2337.1 2389.1 2390.3 2344.7 2405.9 2422.8 2430.7 2431.8 2334.0 2335.7 2341.4 2342.6 2346.3 2296.9 2311.8 2316.1 2320.5 2323.3 2185.4 2281.5 2310.1 2318.2 2319.4 10986.5 11086.5 11091.8 11108.2 11113.8 5888.0 6061.6 6063.4 6064.0 6069.6 3653.4 3676.9 3876.8 3931.0 3947.8 1325.3 1352.2 1364.3 1391.3 1411.5 16778.6 16820.7 16825.7 16831.9 16840.6 5173.0 5498.6 5565.8 5598.8 5614.7 13610.9 13621.8 13630.4 13634.7 13635.7 6325.3 6357.8 6358.0 6358.1 6358.2 4829.7 4982.7 5666.3 5791.8 5819.4 4111.5 4138.3 4175.1 4193.7 4199.9 1183.5 1188.7 1199.1 1209.7 1212.4 775.3 779.4 783.3 792.4 799.1 6414.6 6660.0 6692.4 6729.5 6866.3 905.3 913.2 915.8 919.9 928.0 3906.3 4185.4 4228.5 4330.5 4382.7 14201.6 14290.5 14521.2 14850.6 14854.2 14474.6 14680.8 14729.3 14855.6 14870.3 10387.1 10389.4 10461.9 10579.7 10686.6 6683.4 6722.6 6772.1 6781.5 6789.6 13062.1 13198.8 13302.9 13334.7 13355.1 13116.1 13242.9 13251.7 13314.6 13391.3 8017.8 8226.3 9249.6 9476.8 9500.5 10299.3 10627.1 10712.9 10736.2 10748.6 8940.6 8948.7 9006.1 9090.9 9148.2 8788.3 8899.8 8954.7 9038.1 9057.7 7780.2 7795.2 7896.9 7937.3 7966.2 5891.1 5972.1 6016.5 6031.1 6032.9 5856.5 5905.4 5912.6 6010.3 6227.9 16:59:04 INFO - PID 16659 | 16:59:04 INFO - PID 16659 | [#4] prototype.html Cycles:180 Average:5295.59 Median:5933.73 stddev:1530.48 (25.8%) stddev-sans-first:1490.04 16:59:04 INFO - PID 16659 | Values: 401.4 422.0 425.1 429.4 434.3 5927.2 5964.7 5972.0 5988.7 5996.8 5739.9 5882.4 5908.0 5913.2 5930.5 4649.8 4658.2 4675.4 4676.6 4700.3 4682.0 4684.9 4692.7 4693.6 4717.5 4514.2 4655.3 4670.4 4676.6 4680.0 4633.7 4663.9 4666.6 4677.3 4683.3 4223.8 4231.6 4232.2 4235.3 4238.4 5651.3 5800.0 5837.5 5859.2 5864.8 5484.1 5489.5 5491.8 5496.6 5523.2 6294.9 6297.6 6300.3 6310.3 6324.5 4544.0 4689.5 4702.5 4710.5 4717.4 6239.2 6386.9 6405.5 6478.6 6481.4 4800.9 4853.9 4859.9 4866.6 4881.9 4647.1 4770.3 4921.9 4929.3 4931.4 5346.3 5439.9 5440.0 5441.2 5450.4 6252.7 6261.2 6262.6 6280.1 6287.7 1523.8 1582.7 1591.4 1594.6 1691.9 1047.2 1081.1 1089.0 1090.7 1097.4 5881.3 5894.9 5897.3 5939.5 5951.3 6360.3 6399.6 6404.6 6405.9 6436.2 5740.5 5892.6 5937.0 5999.6 6023.2 3380.6 3399.1 3403.1 3414.4 3423.6 6448.3 6691.9 6708.4 6714.4 6717.2 6596.0 6608.1 6629.2 6630.4 6646.6 6512.7 6681.6 6701.7 6721.0 6748.5 6453.2 6463.8 6468.6 6476.5 6478.4 6131.8 6221.8 6264.1 6394.1 6410.3 6217.7 6549.5 6608.2 6610.8 6635.0 4467.8 4528.9 4558.7 4562.4 4563.3 6435.8 6446.1 6454.9 6477.6 6488.4 6228.9 6228.9 6236.9 6237.3 6247.8 6030.6 6137.6 6182.4 6233.6 6255.8 6151.4 6187.6 6190.9 6201.4 6208.2 6002.8 6227.8 6236.7 6261.9 6268.2 6059.8 6059.8 6067.2 6094.6 6115.3 16:59:04 INFO - PID 16659 | 16:59:04 INFO - PID 16659 | [#5] yui.html Cycles:180 Average:16461.12 Median:4863.23 stddev:21229.52 (436.5%) stddev-sans-first:21256.00 16:59:04 INFO - PID 16659 | Values: 679.5 696.2 699.7 700.1 706.3 16368.4 17031.8 17039.1 17109.4 17274.7 14885.9 15350.2 15443.4 15450.5 15671.8 869.1 895.2 898.0 898.1 898.7 925.4 956.1 957.0 958.5 958.9 958.9 989.2 990.7 991.0 991.3 951.3 980.4 981.6 982.3 982.8 700.8 713.5 721.0 721.2 722.4 14138.5 15221.6 15331.8 15349.2 15397.0 12582.4 12599.3 12777.9 12817.0 13180.6 11173.7 11305.1 11498.5 11540.8 11583.0 2882.4 2955.5 2973.5 2974.4 3068.3 75858.6 76068.2 76576.6 77302.0 77755.6 9462.5 9475.0 9557.2 9737.8 9759.8 19870.2 19919.2 19972.2 20122.9 20187.9 7595.8 7651.3 7819.6 7912.5 8027.7 3972.3 3987.7 4010.8 4013.5 4069.3 4045.3 4073.5 4091.2 4109.1 4117.4 723.2 726.2 743.0 744.3 752.1 587.4 600.6 604.4 616.7 616.8 10245.2 10257.8 10309.4 10385.9 10591.5 616.7 619.4 631.4 631.5 631.8 4599.6 4857.6 4868.9 4869.1 4893.8 77275.6 77563.6 77915.0 80389.6 80407.6 67573.0 68058.0 68232.7 68300.3 68341.7 58191.4 58788.0 58806.4 59003.4 59094.0 9496.0 9786.2 9854.9 9869.0 10007.2 32766.3 33049.5 33426.0 33556.3 34839.3 40826.6 40843.4 41657.6 41665.2 42154.6 11839.3 11966.0 11997.2 12295.3 12452.4 13131.6 13196.0 13226.9 13523.2 13931.5 12198.8 12203.6 12439.2 12638.3 13091.4 12294.5 12764.4 12929.3 13006.6 13124.8 11996.5 12625.3 12740.9 12811.9 13033.6 9233.6 9501.9 9676.8 9693.5 9696.4 9522.4 9947.8 10107.0 10260.4 10267.0 16:59:04 INFO - PID 16659 | -------- Summary: end -------- 16:59:04 INFO - PID 16659 | 16:59:05 INFO - TEST-INFO | 16659: exit 0 16:59:05 INFO - TEST-OK | dromaeo_css | took 1116268ms 16:59:05 INFO - TEST-START | kraken 16:59:05 INFO - operating with platform_type : linux_ 16:59:05 INFO - Initialising browser for kraken test... 16:59:05 INFO - TEST-INFO | started process 16984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfaRFrk/profile http://localhost:41505/getInfo.html) 16:59:09 INFO - PID 16984 | __metrics Screen width/height:1600/1200 16:59:09 INFO - PID 16984 | colorDepth:24 16:59:09 INFO - PID 16984 | Browser inner width/height: 1024/697 16:59:09 INFO - PID 16984 | __metrics 16:59:10 ERROR - PID 16984 | 1490831950067 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 16:59:10 INFO - PID 16984 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:59:10 INFO - PID 16984 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:59:11 INFO - TEST-INFO | 16984: exit 0 16:59:11 INFO - Browser initialized. 16:59:11 INFO - Running cycle 1/1 for kraken test... 16:59:11 INFO - TEST-INFO | started process 17078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfaRFrk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:22 INFO - PID 17078 | RSS: Main: 144367616 16:59:22 INFO - PID 17078 | 16:59:25 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41505/tests/kraken/driver.html?testName=audio-beat-detection) 16:59:26 INFO - PID 17078 | RSS: Main: 200425472 16:59:26 INFO - PID 17078 | 16:59:29 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41505/tests/kraken/driver.html?testName=audio-dft) 16:59:29 INFO - PID 17078 | RSS: Main: 179564544 16:59:29 INFO - PID 17078 | 16:59:32 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41505/tests/kraken/driver.html?testName=audio-fft) 16:59:33 INFO - PID 17078 | RSS: Main: 261898240 16:59:33 INFO - PID 17078 | 16:59:35 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41505/tests/kraken/driver.html?testName=audio-oscillator) 16:59:35 INFO - PID 17078 | RSS: Main: 172322816 16:59:35 INFO - PID 17078 | 16:59:38 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41505/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:59:38 INFO - PID 17078 | RSS: Main: 176861184 16:59:38 INFO - PID 17078 | 16:59:41 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41505/tests/kraken/driver.html?testName=imaging-darkroom) 16:59:42 INFO - PID 17078 | RSS: Main: 215388160 16:59:42 INFO - PID 17078 | 16:59:45 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41505/tests/kraken/driver.html?testName=imaging-desaturate) 16:59:46 INFO - PID 17078 | RSS: Main: 227581952 16:59:46 INFO - PID 17078 | 16:59:49 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41505/tests/kraken/driver.html?testName=json-parse-financial) 16:59:49 INFO - PID 17078 | RSS: Main: 237420544 16:59:49 INFO - PID 17078 | 16:59:51 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41505/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:59:52 INFO - PID 17078 | RSS: Main: 178032640 16:59:52 INFO - PID 17078 | 16:59:53 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41505/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:59:54 INFO - PID 17078 | RSS: Main: 183607296 16:59:54 INFO - PID 17078 | 16:59:56 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41505/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:59:57 INFO - PID 17078 | RSS: Main: 193937408 16:59:57 INFO - PID 17078 | 16:59:59 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41505/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:00:00 INFO - PID 17078 | RSS: Main: 203190272 17:00:00 INFO - PID 17078 | 17:00:03 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41505/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:00:04 INFO - PID 17078 | RSS: Main: 199708672 17:00:04 INFO - PID 17078 | 17:00:05 INFO - PID 17078 | Cycle 1(1): loaded http://localhost:41505/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41505/tests/kraken/driver.html?testName=ai-astar) 17:00:06 INFO - PID 17078 | RSS: Main: 268087296 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | __start_tp_report 17:00:06 INFO - PID 17078 | _x_x_mozilla_page_load 17:00:06 INFO - PID 17078 | _x_x_mozilla_page_load_details 17:00:06 INFO - PID 17078 | |i|pagename|runs| 17:00:06 INFO - PID 17078 | |0;ai-astar;101;109;110;110;110;110;110;110;109;110 17:00:06 INFO - PID 17078 | |1;audio-beat-detection;156;118;117;159;127;119;116;117;140;123 17:00:06 INFO - PID 17078 | |2;audio-dft;164;165;164;163;165;164;165;164;163;165 17:00:06 INFO - PID 17078 | |3;audio-fft;74;75;75;103;78;75;75;75;90;76 17:00:06 INFO - PID 17078 | |4;audio-oscillator;83;84;118;84;83;84;98;84;84;113 17:00:06 INFO - PID 17078 | |5;imaging-gaussian-blur;114;114;113;113;113;114;115;114;114;114 17:00:06 INFO - PID 17078 | |6;imaging-darkroom;147;148;148;149;149;147;148;149;149;148 17:00:06 INFO - PID 17078 | |7;imaging-desaturate;95;94;95;94;94;94;94;95;94;95 17:00:06 INFO - PID 17078 | |8;json-parse-financial;55;55;55;56;56;62;55;56;55;56 17:00:06 INFO - PID 17078 | |9;json-stringify-tinderbox;55;54;55;55;55;55;55;55;56;55 17:00:06 INFO - PID 17078 | |10;stanford-crypto-aes;82;82;81;80;80;80;81;82;81;80 17:00:06 INFO - PID 17078 | |11;stanford-crypto-ccm;140;128;147;133;129;134;129;128;168;138 17:00:06 INFO - PID 17078 | |12;stanford-crypto-pbkdf2;181;194;189;187;184;192;200;181;193;180 17:00:06 INFO - PID 17078 | |13;stanford-crypto-sha256-iterative;67;67;66;69;71;66;67;65;65;73 17:00:06 INFO - PID 17078 | __end_tp_report 17:00:06 INFO - PID 17078 | __start_cc_report 17:00:06 INFO - PID 17078 | _x_x_mozilla_cycle_collect,1705 17:00:06 INFO - PID 17078 | __end_cc_report 17:00:06 INFO - PID 17078 | __startTimestamp1490832006210__endTimestamp 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | ------- Summary: start ------- 17:00:06 INFO - PID 17078 | Number of tests: 14 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.81 (2.6%) stddev-sans-first:0.44 17:00:06 INFO - PID 17078 | Values: 101.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:125.00 stddev:16.56 (13.2%) stddev-sans-first:14.45 17:00:06 INFO - PID 17078 | Values: 156.0 118.0 117.0 159.0 127.0 119.0 116.0 117.0 140.0 123.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 17:00:06 INFO - PID 17078 | Values: 164.0 165.0 164.0 163.0 165.0 164.0 165.0 164.0 163.0 165.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#3] audio-fft Cycles:10 Average:79.60 Median:75.00 stddev:9.48 (12.6%) stddev-sans-first:9.83 17:00:06 INFO - PID 17078 | Values: 74.0 75.0 75.0 103.0 78.0 75.0 75.0 75.0 90.0 76.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:84.00 stddev:13.47 (16.0%) stddev-sans-first:13.93 17:00:06 INFO - PID 17078 | Values: 83.0 84.0 118.0 84.0 83.0 84.0 98.0 84.0 84.0 113.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 17:00:06 INFO - PID 17078 | Values: 114.0 114.0 113.0 113.0 113.0 114.0 115.0 114.0 114.0 114.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 17:00:06 INFO - PID 17078 | Values: 147.0 148.0 148.0 149.0 149.0 147.0 148.0 149.0 149.0 148.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:00:06 INFO - PID 17078 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:2.13 (3.8%) stddev-sans-first:2.22 17:00:06 INFO - PID 17078 | Values: 55.0 55.0 55.0 56.0 56.0 62.0 55.0 56.0 55.0 56.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 17:00:06 INFO - PID 17078 | Values: 55.0 54.0 55.0 55.0 55.0 55.0 55.0 55.0 56.0 55.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:0.88 (1.1%) stddev-sans-first:0.83 17:00:06 INFO - PID 17078 | Values: 82.0 82.0 81.0 80.0 80.0 80.0 81.0 82.0 81.0 80.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:136.00 stddev:12.40 (9.1%) stddev-sans-first:13.12 17:00:06 INFO - PID 17078 | Values: 140.0 128.0 147.0 133.0 129.0 134.0 129.0 128.0 168.0 138.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.10 Median:190.50 stddev:6.67 (3.5%) stddev-sans-first:6.57 17:00:06 INFO - PID 17078 | Values: 181.0 194.0 189.0 187.0 184.0 192.0 200.0 181.0 193.0 180.0 17:00:06 INFO - PID 17078 | 17:00:06 INFO - PID 17078 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:2.63 (3.9%) stddev-sans-first:2.78 17:00:06 INFO - PID 17078 | Values: 67.0 67.0 66.0 69.0 71.0 66.0 67.0 65.0 65.0 73.0 17:00:06 INFO - PID 17078 | -------- Summary: end -------- 17:00:06 INFO - PID 17078 | 17:00:07 INFO - TEST-INFO | 17078: exit 0 17:00:07 INFO - TEST-OK | kraken | took 61415ms 17:00:07 INFO - SUITE-END | took 1177s 17:00:07 INFO - Completed test suite (00:19:37) 17:00:07 INFO - javascript benchmark 17:00:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7520.24393271119, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3247.626522949861, 3259.8696052157916, 3296.6373698893117, 3322.202671358875, 3331.550240717502, 5819.709014549277, 5895.263092113486, 5904.143899134629, 5922.615030023051, 5943.435373639508, 5865.76536938522, 5910.172575839375, 5915.378885217055, 5976.133460648203, 6051.213342265511, 5198.246254293125, 5274.525292723654, 5309.522143007129, 5333.653312534673, 5415.64798288112, 5288.286081379003, 5321.414644389133, 5367.892642147155, 5369.7583608737505, 5370.758315875795, 5220.817271395502, 5266.710330931797, 5300.867478313054, 5307.601929855237, 5357.249985002103, 5284.022455845642, 5319.361676598833, 5342.946570534284, 5379.67721936685, 5397.433269506724, 5257.710825904612, 5270.894582108374, 5288.65623734456, 5338.039152952467, 5360.303160589137, 5783.132530120473, 5848.561357898175, 5874.030784920483, 5922.230110085704, 5957.791477298274, 6219.937800622027, 6331.8417039573915, 6336.96831515844, 6340.524460665469, 6345.80962571119, 6483.7082331295205, 6486.481081513515, 6497.18785151856, 6507.056476810836, 6517.055027021055, 5881.705914704247, 5963.642181469126, 5976.103584462322, 5992.64044157352, 5999.820005399845, 6324.9051264231075, 6417.358264173546, 6492.318306577836, 6577.967110164514, 6578.440832529192, 6133.570650054453, 6165.938340616536, 6171.382861713792, 6214.751409943642, 6288.088227207029, 6329.556931014877, 6336.968315158395, 6344.175257216532, 6365.108884756138, 6392.0, 6382.776602818879, 6386.10594516768, 6394.456471199907, 6397.072424498421, 6401.55189136756, 6149.200603921551, 6225.28409232935, 6304.873902522016, 6363.5863668861375, 6372.0, 4838.153323168432, 4841.830535931225, 4842.249451335048, 4879.39007624047, 4887.560119589183, 4272.124214536013, 4274.380214868826, 4275.40144379787, 4314.956850431518, 4319.114581510783, 5755.309362876482, 5843.123531470228, 5893.027650437715, 5913.965056115248, 5916.645001299936, 6390.680465976682, 6415.615063096229, 6418.614883107029, 6427.678616069178, 6431.0, 5892.734826932799, 5924.4667979882015, 5941.494972927349, 5943.995194765866, 5989.640621562633, 5338.3060202173465, 5361.571074314045, 5402.567794576425, 5423.701696406735, 5436.0, 6477.028445733178, 6554.082428460019, 6561.179852518435, 6561.179852518435, 6572.211334639874, 6425.453836423956, 6429.0, 6434.935650643621, 6437.774677886251, 6438.066480360415, 6473.77341793035, 6611.404973552211, 6674.866502670016, 6677.799666010027, 6680.432163266177, 6233.0, 6247.96876015617, 6289.182406287154, 6331.303556608861, 6337.524685648687, 6469.353064693493, 6472.838179045561, 6477.740890364333, 6480.351964803671, 6482.513811464065, 6097.0105204680185, 6121.571489995657, 6171.444569988723, 6270.090836828543, 6273.247210334789, 6184.443400094013, 6246.437820596168, 6272.341404152498, 6282.717277722422, 6282.748690052529, 6186.226721659793, 6223.097650840693, 6232.407921247474, 6235.75056997715, 6244.375562443719, 6112.10835914862, 6282.968585157228, 6295.5907865988565, 6298.1812364392335, 6300.054991751274, 6003.7898673546215, 6054.727537260922, 6100.694965251809, 6105.603135796159, 6106.847328816815], "value": 5833.529064344521, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.9857402851943, 772.980675483113, 791.3471386106462, 1120.9831852522213, 1134.6482590396984, 30820.38359232817, 38349.424758628644, 38844.53287871896, 38895.41656875149, 38924.0, 41818.790906045506, 42216.366754498704, 42301.15397692045, 42326.15347693044, 42364.364534532004, 8232.012158540969, 8324.209200126008, 8381.580920953958, 8401.117882622328, 8411.789705257357, 5965.46310832025, 6129.295131059941, 7995.200479952016, 8291.709790157345, 8296.875546866802, 8206.835863282731, 8289.875651865197, 8289.917100829005, 8294.294984926288, 8302.70940517082, 8179.877301840477, 8182.386321025947, 8226.341892648634, 8240.13478584746, 8254.793630159264, 8127.268545830844, 8220.876686849702, 8223.42436029478, 8238.0, 8250.339972802221, 38347.616523834964, 38583.42124868129, 38653.80673096645, 38664.0, 38674.1325867411, 2943.2200466876293, 2976.2113040044405, 2982.164993801717, 2985.477541430241, 2994.9850250748605, 28098.0, 28192.85903570469, 28218.77228591801, 28571.428571428456, 28609.427811443653, 3610.963890361089, 3615.313090512794, 3640.9453858192146, 3644.835982380799, 3784.3188226119287, 228701.0, 230526.0, 230871.0, 232762.0, 233014.83492582597, 49837.501624983284, 49938.0, 49953.50046499561, 50063.749681251364, 50194.0, 51980.22029669558, 52011.0, 52203.0, 52244.171453998926, 52248.47751522436, 14865.851341486446, 15103.0, 15115.924420377827, 15124.39502419913, 15128.773068403983, 10748.462576871125, 12279.508819647113, 12292.508299667914, 12320.075994300463, 12323.198992065487, 11749.118816088827, 11922.523099076114, 11950.223235489666, 12166.939165304117, 12196.0, 5090.567301779316, 5113.258577506315, 5177.508136727005, 5221.921671174935, 5235.162374020215, 1006.5822683586376, 1018.3228153278135, 1019.3527110285022, 1029.577873072037, 1037.9377237365782, 25227.981642262443, 25409.745902541108, 25458.745412546006, 25620.615690764655, 25632.0, 1105.9778804423865, 1109.4951796932376, 1124.2692250037542, 1125.2798209146154, 1125.876153623101, 12706.0, 12940.417681204368, 13183.934080329536, 13233.139845909986, 13320.534741178462, 275210.0, 275467.0, 275486.0, 275630.0, 276880.0, 54010.18984715232, 54101.45898540964, 54200.45799542033, 54218.728906355216, 54293.45706542963, 1427.7715565509468, 1444.6117359942498, 1477.8448262932452, 1481.0373257382787, 1485.6731519065788, 23650.053997839892, 24160.800019900853, 24186.87906560456, 24225.096301618723, 24492.0, 39434.80282598569, 39567.80216098901, 39612.80193599014, 39623.40564891587, 39680.80159599299, 280929.0, 281003.0, 282076.0, 282086.0, 282778.0, 26772.330691732084, 32365.352692945537, 32577.0, 32732.0, 32778.672213278514, 34116.6007999128, 39618.405723914744, 40265.79867100646, 40705.79647101746, 42004.0, 29920.25199370033, 30182.547261790653, 30698.0, 31250.843745781127, 31624.209394764395, 31490.0, 31514.52728209033, 31663.52504712477, 31836.681633183372, 32522.0, 37823.243535129695, 38019.61980380161, 38637.80681096577, 38684.41973370458, 38841.805790970866, 30689.232769180948, 31160.53259201159, 31379.21551961128, 31454.37091258208, 31461.8426907864, 23794.524109518057, 25385.746142538337, 25445.61831572565, 25493.362665932756, 25753.871230643726], "value": 17230.58411977716, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.6379508396446, 433.5296203619073, 439.5143366579929, 450.4526999695369, 453.4535884259466, 19682.606347873036, 20835.0, 21309.36071917845, 21593.568128637417, 21712.89143554282, 21177.0, 21641.026153823077, 21939.6709049364, 22153.224637137704, 22514.774852251474, 5810.418958104187, 5979.312379076418, 6004.969975150118, 6017.939820601781, 6026.0960855871535, 5660.235868157808, 5893.38119497453, 5924.466797988181, 5937.37657545958, 5946.821595352147, 5816.0, 5882.441168089046, 5902.232709747726, 5905.527557795366, 5910.556708246877, 5806.332271788735, 5894.322152952401, 5899.262592175999, 5914.7929822456435, 5923.763049478016, 5313.203019547061, 5324.520793128637, 5353.143497040455, 5356.651817631841, 5369.865753356158, 25451.745482545124, 25622.359441013938, 25885.870570647025, 25940.481190376086, 26113.477730445284, 2054.6917962305624, 2058.763242227133, 2066.411072844232, 2080.147139672727, 2098.9265375711775, 15700.528984130495, 15960.840391596052, 16272.0, 16333.673326533522, 17115.57211069721, 1745.4240100766717, 1765.3556451895095, 1783.6432713457232, 1804.2859283680557, 1826.3516451659734, 111145.0, 116526.41736791261, 116812.83187168105, 116820.0, 117664.0, 12403.565875194325, 12502.062345324137, 12529.041650463047, 12554.560590379293, 12615.432305546272, 17583.64832703339, 17602.215523662475, 17629.206685699173, 17987.910060449613, 18076.276948921895, 8707.259882910024, 8715.38992270535, 8734.95632521846, 8860.8670869937, 9031.412958157698, 8026.478278911852, 8070.2333278338465, 8236.217559331853, 8265.586720663943, 8310.0, 7760.495567788075, 7814.0, 7843.9215607844335, 7938.841223175504, 7955.687311593638, 2179.8854213930076, 2187.147012665062, 2217.8114860236738, 2261.7285925688693, 2365.9171928982405, 983.3460748602242, 993.5032483758121, 1000.8748906386702, 1006.4615430744517, 1032.1742605915238, 20090.39728808138, 20360.18559257643, 20392.592148156953, 20525.38423847287, 20628.17487300491, 1043.113353649392, 1046.35126221743, 1049.6641074856125, 1057.7201586080928, 1069.9518521666544, 9984.80030399388, 11144.108471322275, 11146.554137834395, 11180.105591552656, 11283.323000619988, 553623.0, 562580.0, 563819.0, 579876.0, 580019.8991045413, 99342.50328748455, 100129.0, 103655.96344036613, 104562.81748729966, 107902.46048769706, 1167.3521195736278, 1211.2006075989805, 1231.8768123187788, 1235.9629211123681, 1236.715555422258, 17125.842875952283, 17244.310227591257, 17284.91357543204, 17541.298348065935, 17713.380031698827, 47245.29132062953, 47945.520544794104, 48139.037219254715, 49139.75430122826, 49330.013399732525, 59632.40367596268, 61071.0, 62142.0, 62198.0, 62613.0, 9101.77245568866, 9331.86002209981, 9419.481928493724, 9563.713088607354, 9778.07108324708, 14922.284971762534, 14992.100473971597, 15078.849211508183, 15115.395384184509, 15403.922980385474, 13052.5431609897, 13075.738485230433, 13258.270795106362, 13262.204267743966, 13562.86437135616, 11253.043491303331, 11467.713307167387, 11691.298522088702, 11720.062395008208, 11899.286042837457, 11341.376224307742, 11432.485538150637, 11692.47383867711, 11788.70528236801, 13111.803322949972, 9230.35387522867, 9316.906830931604, 9348.719538413858, 9406.905930940877, 9569.330146889652, 12631.684207894876, 12797.0, 12886.0, 13275.937924966172, 13485.190888546325], "value": 10174.039933225993, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1180.3154170581063, 1266.3858028856005, 1318.7889937609982, 1321.8281623388957, 1327.8539360670325, 9331.44011359318, 10827.67516974491, 11258.493367798448, 11258.605948791794, 11292.830607540893, 10950.561977520909, 10974.780504389928, 11031.172662050338, 11045.447727613628, 11051.613193538227, 1760.3662681434673, 1839.8436132928716, 2337.123578658003, 2389.0921449849034, 2390.3307074019217, 2344.7186337639505, 2405.9037638494437, 2422.7819496245334, 2430.744771798962, 2431.841930274535, 2333.9533209335805, 2335.6613291072786, 2341.3912382780513, 2342.61346877765, 2346.3430239532872, 2296.8851557422063, 2311.84972976756, 2316.119874447716, 2320.4662927526765, 2323.3378487131085, 2185.4317877351846, 2281.5094754627835, 2310.06442390832, 2318.177047148255, 2319.362175401778, 10986.450677466095, 11086.501107450104, 11091.778164436746, 11108.16688748347, 11113.833292500538, 5888.0, 6061.605995610271, 6063.393660633946, 6063.969680151615, 6069.6054756441135, 3653.3971894637352, 3676.8674168982193, 3876.8449262029485, 3931.0368959604793, 3947.8026098695236, 1325.3042152869725, 1352.229229339277, 1364.304204855521, 1391.3182540555056, 1411.4848080450665, 16778.580535486588, 16820.74768878468, 16825.66348673032, 16831.91584042072, 16840.57898552546, 5173.0, 5498.642588231752, 5565.833025009256, 5598.776048957996, 5614.691191984399, 13610.863891361158, 13621.795673064911, 13630.386632601556, 13634.727305453835, 13635.727285454235, 6325.335839736854, 6357.841053973688, 6358.0, 6358.1416508771645, 6358.205224346957, 4829.73436460998, 4982.701037937735, 5666.320041595035, 5791.768329266866, 5819.359870414251, 4111.502698357448, 4138.296489596776, 4175.144095460423, 4193.686559284386, 4199.874003779892, 1183.5029287699188, 1188.7028242939266, 1199.0587388899671, 1209.7036226124656, 1212.3635091576816, 775.2518819339365, 779.3842864137268, 783.3419927261128, 792.3661071143063, 799.0690845165434, 6414.583052101599, 6660.0, 6692.364225398579, 6729.49528785343, 6866.279040700654, 905.3255324783079, 913.1918252346588, 915.7939463620766, 919.9034101419388, 928.0441145620022, 3906.3314129188766, 4185.393117997874, 4228.534861165269, 4330.458692663417, 4382.69321147523, 14201.644958875904, 14290.499832505813, 14521.201333926525, 14850.628734281514, 14854.183019933791, 14474.638134046732, 14680.779788303184, 14729.337179826933, 14855.554333370017, 14870.330835112445, 10387.117095046855, 10389.428581427943, 10461.947690261652, 10579.735506612396, 10686.625968091079, 6683.4319082876555, 6722.563033402813, 6772.11962444879, 6781.525293229427, 6789.558678685869, 13062.085654004128, 13198.80201796993, 13302.866971330162, 13334.733305334034, 13355.131916425402, 13116.081874269092, 13242.867571324163, 13251.66870828237, 13314.600561983156, 13391.263480508665, 8017.759467215993, 8226.30076443509, 9249.583768730557, 9476.763080923032, 9500.524973751146, 10299.279050466695, 10627.149828013586, 10712.946435267773, 10736.248462607855, 10748.570057197938, 8940.552972351486, 8948.73153805387, 9006.144416280444, 9090.863637045582, 9148.222401095714, 8788.34087443457, 8899.822003559762, 8954.731358059269, 9038.141376569216, 9057.68298109563, 7780.183080776437, 7795.207102366601, 7896.921030789618, 7937.285644292041, 7966.243206895336, 5891.116332550152, 5972.13404056418, 6016.458518733335, 6031.09533569968, 6032.879342413039, 5856.472917437451, 5905.40945905406, 5912.5861189718025, 6010.33886272501, 6227.906581401192], "value": 5252.027360775484, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.37986810378, 421.9914404573071, 425.0690986739042, 429.374816320228, 434.25091716788523, 5927.228580992305, 5964.731587078586, 5971.984762590359, 5988.70056497175, 5996.790112346069, 5739.885202295952, 5882.382349853268, 5907.970460147693, 5913.231279933602, 5930.495907847828, 4649.790759415826, 4658.161530924449, 4675.358422491281, 4676.643773305737, 4700.294955756647, 4681.993371425143, 4684.929726054112, 4692.718436893781, 4693.647976401767, 4717.504662010491, 4514.164879497303, 4655.255159174532, 4670.392848929651, 4676.638297659694, 4679.976600117012, 4633.698809577383, 4663.88340291492, 4666.580007799314, 4677.321788340706, 4683.274092515666, 4223.788810559459, 4231.597998190197, 4232.174725928445, 4235.25882970479, 4238.364245363189, 5651.265335506358, 5800.0, 5837.474627283523, 5859.150423188614, 5864.794732184353, 5484.122540393518, 5489.533389661883, 5491.846712190445, 5496.642718223303, 5523.171524271352, 6294.87410251797, 6297.590656607306, 6300.3384644612115, 6310.274318453391, 6324.462420694201, 4544.0, 4689.460712018127, 4702.4592171899985, 4710.5289471052965, 4717.433907931036, 6239.220097487814, 6386.87226255477, 6405.455536279375, 6478.611283322968, 6481.4166724994975, 4800.855974320776, 4853.854384368475, 4859.902801943941, 4866.635002374836, 4881.8535443936735, 4647.140279048387, 4770.332153498513, 4921.926171107436, 4929.334539837076, 4931.358923340014, 5346.251524786533, 5439.891202175934, 5439.980810650127, 5441.156620723794, 5450.3732070811575, 6252.718627661766, 6261.154744109487, 6262.5929314594405, 6280.1280802449855, 6287.685615719287, 1523.8494936323004, 1582.6518166003461, 1591.38731588337, 1594.5933786884502, 1691.8984860908386, 1047.2407504559133, 1081.0648788797791, 1089.0253223365044, 1090.7000574841982, 1097.3635291530893, 5881.2942446906645, 5894.8821023579285, 5897.262842144732, 5939.495142912814, 5951.256092988377, 6360.332165122595, 6399.55203135776, 6404.615723056631, 6405.903911441332, 6436.195475565554, 5740.454656807597, 5892.558058145656, 5936.970315148396, 5999.610025348338, 6023.216981792339, 3380.5970522232997, 3399.133221028622, 3403.0981789825714, 3414.3854106260615, 3423.640517745651, 6448.258450278278, 6691.899621505681, 6708.429783468362, 6714.429273511709, 6717.16035495563, 6596.0, 6608.107905432801, 6629.237637671633, 6630.403263706289, 6646.567973081735, 6512.706928188148, 6681.599104053772, 6701.664916754143, 6721.00915092779, 6748.4938629602975, 6453.225612926479, 6463.838404039937, 6468.6442245676935, 6476.514261430506, 6478.449331806849, 6131.785387511416, 6221.844453888689, 6264.123022776724, 6394.136791533084, 6410.262819775786, 6217.720202590804, 6549.541532092899, 6608.207015158212, 6610.768623098168, 6635.0, 4467.798949047366, 4528.90942181148, 4558.677983384914, 4562.384078149407, 4563.338315944236, 6435.806925792233, 6446.0975463434215, 6454.8703976802935, 6477.643729594917, 6488.448481878904, 6228.875422491616, 6228.937710622836, 6236.906446403217, 6237.282712488122, 6247.750089996349, 6030.638161710312, 6137.570370074052, 6182.443580077815, 6233.625982441068, 6255.781047663492, 6151.3541078186145, 6187.628742275478, 6190.907136392868, 6201.441870231701, 6208.192934918432, 6002.759889604367, 6227.844303892439, 6236.719347629277, 6261.937380626136, 6268.216472940882, 6059.787907423219, 6059.818205453844, 6067.211262535842, 6094.603850749687, 6115.296740874856], "value": 4819.287322467818, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.4801976487985, 696.2132789947359, 699.6956323999061, 700.0793955947928, 706.3360441185289, 16368.427105051325, 17031.82968170318, 17039.062851543193, 17109.40117095902, 17274.65450690987, 14885.92557037216, 15350.155741434217, 15443.382264709398, 15450.536483905473, 15671.84328156721, 869.061413673233, 895.1853813030111, 898.0256421782341, 898.0884402331606, 898.7169041751828, 925.3846192282124, 956.0869369751905, 956.9617215311379, 958.5351104714208, 958.9136977672008, 958.884933807944, 989.1641562879391, 990.6631745206628, 991.013941128578, 991.2516050381952, 951.3293128344501, 980.431349817108, 981.5533932060895, 982.3369225772575, 982.778874753182, 700.7722490190708, 713.5076797010047, 721.0, 721.2426951700693, 722.4076257468878, 14138.50515231962, 15221.61945951349, 15331.846681533154, 15349.232538373148, 15397.0, 12582.37088145589, 12599.3070381129, 12777.936110319482, 12817.0, 13180.604581862559, 11173.72065698356, 11305.095592352593, 11498.482568284448, 11540.826887596693, 11583.0, 2882.437924604703, 2955.5123404638207, 2973.5391014392803, 2974.375381169957, 3068.3096303331795, 75858.62070689611, 76068.23931760667, 76576.63963522555, 77302.0, 77755.6112219441, 9462.52687365629, 9474.95262523683, 9557.187639050619, 9737.805243895082, 9759.756006099904, 19870.205191792455, 19919.20323187085, 19972.20111195565, 20122.89938550298, 20187.899060504602, 7595.810104747315, 7651.311381975537, 7819.569923654253, 7912.525248484994, 8027.6788928443375, 3972.324704800191, 3987.7208595398624, 4010.8287381123887, 4013.4581831452965, 4069.2675318442966, 4045.2516284487465, 4073.5111786585207, 4091.243120022805, 4109.075458021921, 4117.382392641068, 723.2153113871403, 726.1576571177409, 742.9962850185823, 744.263179452349, 752.1463139336892, 587.4155215560545, 600.6216083867135, 604.3623976704619, 616.6639181646013, 616.8149555133532, 10245.180385569136, 10257.846132308021, 10309.360153142781, 10385.948070259601, 10591.523381447852, 616.703982088591, 619.3985261899948, 631.4159402552621, 631.4727202785633, 631.823089534931, 4599.609033232213, 4857.562819346276, 4868.902621947541, 4869.123557759566, 4893.828715994994, 77275.61362193154, 77563.61218193873, 77915.0, 80389.59805200937, 80407.59796200982, 67573.0, 68058.0, 68232.6588367055, 68300.3169968294, 68341.65829170823, 58191.418085819445, 58788.0, 58806.411935880096, 59003.379391709044, 59094.0, 9495.952520237355, 9786.217102631916, 9854.901450985399, 9869.0, 10007.199424046205, 32766.344673105927, 33049.50425743664, 33426.0, 33556.328873422884, 34839.30321393609, 40826.591734083464, 40843.38734918919, 41657.58342416537, 41665.1666966665, 42154.578454215065, 11839.26443384061, 11966.0, 11997.160198786001, 12295.32375719344, 12452.439640216031, 13131.60605181846, 13196.0, 13226.933865330611, 13523.188608683511, 13931.512397066459, 12198.756024879276, 12203.633890983285, 12439.191452555555, 12638.304893230961, 13091.410886509939, 12294.46823804267, 12764.425600847799, 12929.288889110812, 13006.609801705965, 13124.803127953279, 11996.520139194334, 12625.305608191271, 12740.872591273968, 12811.87188128144, 13033.608991730263, 9233.58448869816, 9501.904980950101, 9676.806463870542, 9693.515324233902, 9696.369735967139, 9522.381045232038, 9947.801043979225, 10107.0, 10260.384376937109, 10267.0], "value": 6987.570034347283, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 118.0, 117.0, 159.0, 127.0, 119.0, 116.0, 117.0, 140.0, 123.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 163.0, 165.0, 164.0, 165.0, 164.0, 163.0, 165.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 103.0, 78.0, 75.0, 75.0, 75.0, 90.0, 76.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 118.0, 84.0, 83.0, 84.0, 98.0, 84.0, 84.0, 113.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 115.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 149.0, 149.0, 147.0, 148.0, 149.0, 149.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 56.0, 62.0, 55.0, 56.0, 55.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 80.0, 80.0, 80.0, 81.0, 82.0, 81.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 128.0, 147.0, 133.0, 129.0, 134.0, 129.0, 128.0, 168.0, 138.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 194.0, 189.0, 187.0, 184.0, 192.0, 200.0, 181.0, 193.0, 180.0], "value": 188.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 69.0, 71.0, 66.0, 67.0, 65.0, 65.0, 73.0], "value": 67.6, "unit": "score"}]}]} 17:00:07 INFO - Return code: 0 17:00:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:00:07 ERROR - # TBPL SUCCESS # 17:00:07 INFO - Running post-action listener: _resource_record_post_action 17:00:07 INFO - [mozharness: 2017-03-30 00:00:07.499304Z] Finished run-tests step (success) 17:00:07 INFO - Running post-run listener: _resource_record_post_run 17:00:07 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 371666944; Read time: 12; Write time: 254508 17:00:07 INFO - TinderboxPrint: CPU usage
12.9% 17:00:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:00:07 INFO - TinderboxPrint: I/O write bytes / time
371,666,944 / 254,508 17:00:07 INFO - TinderboxPrint: CPU idle
8,303.7 (87.1%) 17:00:07 INFO - TinderboxPrint: CPU user
1,189.3 (12.5%) 17:00:07 INFO - TinderboxPrint: Swap in / out
0 / 0 17:00:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114081792; Read time: 0; Write time: 115196 17:00:07 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 257585152; Read time: 0; Write time: 139312 17:00:08 INFO - Running post-run listener: _upload_blobber_files 17:00:08 INFO - Blob upload gear active. 17:00:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:00:08 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 17:00:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:00:08 INFO - (blobuploader) - INFO - Open directory for files ... 17:00:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:00:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:00:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:00:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:00:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:00:09 INFO - (blobuploader) - INFO - Done attempting. 17:00:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:00:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:00:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:00:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:00:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:00:12 INFO - (blobuploader) - INFO - Done attempting. 17:00:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:00:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:00:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:00:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:00:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:00:13 INFO - (blobuploader) - INFO - Done attempting. 17:00:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:00:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:00:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:00:14 INFO - (blobuploader) - INFO - Done attempting. 17:00:14 INFO - (blobuploader) - INFO - Iteration through files over. 17:00:14 INFO - Return code: 0 17:00:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:00:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:00:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7d86a1d2bee5804b07043475b50f561fc1361958102d1ec2a91e13300244c9f22e544d463f407f17fb0fe74ef347d7139bc1587dafb6eb0bedbff029f506947", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bd199ffab07e6b98f35954d601938888c5e5a55b8560a0978d66a76d790791e9b9bc97399444699241b0d11e6416e8880f272bcb73de2439d2830f18a4bf16c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c64e5577c5617ea5916a7374e8371ac310ecd7c979e11c35698c06349b1fb325b9071435efcaf17d2e43b363c8033c8904dcf3c853e41a26399198af5dc31b7b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0c9bd28a65ab96994331b80cd831bc486df06f2aa8f864eaf06b5464f3b2dae020931ed80d9f232759933b69cfb026bf565c2fd3e8cea1c08b121ab335f8951"} 17:00:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:00:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:00:14 INFO - Contents: 17:00:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7d86a1d2bee5804b07043475b50f561fc1361958102d1ec2a91e13300244c9f22e544d463f407f17fb0fe74ef347d7139bc1587dafb6eb0bedbff029f506947", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bd199ffab07e6b98f35954d601938888c5e5a55b8560a0978d66a76d790791e9b9bc97399444699241b0d11e6416e8880f272bcb73de2439d2830f18a4bf16c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c64e5577c5617ea5916a7374e8371ac310ecd7c979e11c35698c06349b1fb325b9071435efcaf17d2e43b363c8033c8904dcf3c853e41a26399198af5dc31b7b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0c9bd28a65ab96994331b80cd831bc486df06f2aa8f864eaf06b5464f3b2dae020931ed80d9f232759933b69cfb026bf565c2fd3e8cea1c08b121ab335f8951"} 17:00:14 INFO - Running post-run listener: copy_logs_to_upload_dir 17:00:14 INFO - Copying logs to upload dir... 17:00:14 INFO - mkdir: /builds/slave/test/build/upload/logs 17:00:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.604148 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-29 17:00:14.117279) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 17:00:14.124211) ========= 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=923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7d86a1d2bee5804b07043475b50f561fc1361958102d1ec2a91e13300244c9f22e544d463f407f17fb0fe74ef347d7139bc1587dafb6eb0bedbff029f506947", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bd199ffab07e6b98f35954d601938888c5e5a55b8560a0978d66a76d790791e9b9bc97399444699241b0d11e6416e8880f272bcb73de2439d2830f18a4bf16c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c64e5577c5617ea5916a7374e8371ac310ecd7c979e11c35698c06349b1fb325b9071435efcaf17d2e43b363c8033c8904dcf3c853e41a26399198af5dc31b7b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0c9bd28a65ab96994331b80cd831bc486df06f2aa8f864eaf06b5464f3b2dae020931ed80d9f232759933b69cfb026bf565c2fd3e8cea1c08b121ab335f8951"} build_url:https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/HWy8y5ymSJGouwusOmJF7g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7d86a1d2bee5804b07043475b50f561fc1361958102d1ec2a91e13300244c9f22e544d463f407f17fb0fe74ef347d7139bc1587dafb6eb0bedbff029f506947", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bd199ffab07e6b98f35954d601938888c5e5a55b8560a0978d66a76d790791e9b9bc97399444699241b0d11e6416e8880f272bcb73de2439d2830f18a4bf16c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c64e5577c5617ea5916a7374e8371ac310ecd7c979e11c35698c06349b1fb325b9071435efcaf17d2e43b363c8033c8904dcf3c853e41a26399198af5dc31b7b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0c9bd28a65ab96994331b80cd831bc486df06f2aa8f864eaf06b5464f3b2dae020931ed80d9f232759933b69cfb026bf565c2fd3e8cea1c08b121ab335f8951"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 17:00:14.149728) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 17:00:14.150051) ========= 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=923d835db2ba3686ebe126b700000192-1490830759.961648-1398593539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 17:00:14.203505) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 17:00:14.205910) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 17:00:14.206268) ========= ========= Total master_lag: 0.16 =========