builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1486553466.86 results: success (0) revision: 3a95aa4246653a7863914ffec032897d13359fb0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:06.863185) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:06.863743) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:06.864138) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:06.884381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:06.884877) ========= 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=6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-08 03:31:07-- 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% 212M=0s 2017-02-08 03:31:07 (212 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083181 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:06.982494) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:06.985965) ========= 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=6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019374 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:07.035459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:07.038954) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3a95aa4246653a7863914ffec032897d13359fb0 --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 3a95aa4246653a7863914ffec032897d13359fb0 --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=6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-08 03:31:07,578 truncating revision to first 12 chars 2017-02-08 03:31:07,578 Setting DEBUG logging. 2017-02-08 03:31:07,578 attempt 1/10 2017-02-08 03:31:07,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3a95aa424665?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-08 03:31:08,184 unpacking tar archive at: mozilla-central-3a95aa424665/testing/mozharness/ program finished with exit code 0 elapsedTime=0.881638 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:07.934461) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:07.934921) ========= script_repo_revision: 3a95aa4246653a7863914ffec032897d13359fb0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:07.935306) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:07.935583) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 03:31:07.947039) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-02-08 03:31:07.947429) ========= /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=6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:08 INFO - MultiFileLogger online at 20170208 03:31:08 in /builds/slave/test 03:31:08 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 03:31:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:08 INFO - {'append_to_log': False, 03:31:08 INFO - 'base_work_dir': '/builds/slave/test', 03:31:08 INFO - 'blob_upload_branch': 'Firefox', 03:31:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:08 INFO - 'branch': 'Firefox', 03:31:08 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:08 INFO - 'config_files': ('talos/linux_config.py',), 03:31:08 INFO - 'default_actions': ('clobber', 03:31:08 INFO - 'read-buildbot-config', 03:31:08 INFO - 'download-and-extract', 03:31:08 INFO - 'populate-webroot', 03:31:08 INFO - 'create-virtualenv', 03:31:08 INFO - 'install', 03:31:08 INFO - 'run-tests'), 03:31:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:08 INFO - 'download_minidump_stackwalk': True, 03:31:08 INFO - 'download_symbols': 'ondemand', 03:31:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:08 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:08 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:08 INFO - 'installer_path': 'installer.exe', 03:31:08 INFO - 'log_level': 'info', 03:31:08 INFO - 'log_name': 'talos', 03:31:08 INFO - 'log_to_console': True, 03:31:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:08 INFO - 'opt_config_files': (), 03:31:08 INFO - 'pip_index': False, 03:31:08 INFO - 'sps_profile': False, 03:31:08 INFO - 'sps_profile_interval': 0, 03:31:08 INFO - 'suite': 'dromaeojs', 03:31:08 INFO - 'system_bits': '32', 03:31:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:08 INFO - 'title': 'talos-linux64-ix-050', 03:31:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:08 INFO - 'use_talos_json': True, 03:31:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:08 INFO - 'work_dir': 'build'} 03:31:08 INFO - [mozharness: 2017-02-08 11:31:08.602398Z] Running clobber step. 03:31:08 INFO - Running pre-action listener: _resource_record_pre_action 03:31:08 INFO - Running main action method: clobber 03:31:08 INFO - rmtree: /builds/slave/test/build 03:31:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:09 INFO - Running post-action listener: _resource_record_post_action 03:31:09 INFO - [mozharness: 2017-02-08 11:31:09.686689Z] Finished clobber step (success) 03:31:09 INFO - [mozharness: 2017-02-08 11:31:09.686790Z] Running read-buildbot-config step. 03:31:09 INFO - Running pre-action listener: _resource_record_pre_action 03:31:09 INFO - Running main action method: read_buildbot_config 03:31:09 INFO - Using buildbot properties: 03:31:09 INFO - { 03:31:09 INFO - "project": "", 03:31:09 INFO - "product": "firefox", 03:31:09 INFO - "who": "cbook@mozilla.com", 03:31:09 INFO - "installer_path": "public/build/target.tar.bz2", 03:31:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:31:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:31:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 03:31:09 INFO - "stage_platform": "linux64-pgo", 03:31:09 INFO - "basedir": "/builds/slave/test", 03:31:09 INFO - "buildnumber": 20, 03:31:09 INFO - "platform": "ubuntu64_hw", 03:31:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:31:09 INFO - "slavebuilddir": "test", 03:31:09 INFO - "taskId": "cyJBm8ynR4iUmTf0Atl5Hw", 03:31:09 INFO - "branch": "mozilla-central", 03:31:09 INFO - "script_repo_revision": "production", 03:31:09 INFO - "revision": "3a95aa4246653a7863914ffec032897d13359fb0", 03:31:09 INFO - "slavename": "talos-linux64-ix-050", 03:31:09 INFO - "repo_path": "mozilla-central" 03:31:09 INFO - } 03:31:09 INFO - Finding installer, test and symbols from parent task. 03:31:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cyJBm8ynR4iUmTf0Atl5Hw'}, attempt #1 03:31:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cyJBm8ynR4iUmTf0Atl5Hw'}, attempt #1 03:31:10 INFO - Task dependencies: F7iMQljFSE6hwngBJ9Fh2Q 03:31:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q'}, attempt #1 03:31:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.tar.bz2 03:31:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/test_packages.json 03:31:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.crashreporter-symbols.zip 03:31:11 INFO - Running post-action listener: _resource_record_post_action 03:31:11 INFO - [mozharness: 2017-02-08 11:31:11.120328Z] Finished read-buildbot-config step (success) 03:31:11 INFO - [mozharness: 2017-02-08 11:31:11.120547Z] Running download-and-extract step. 03:31:11 INFO - Running pre-action listener: _resource_record_pre_action 03:31:11 INFO - Running main action method: download_and_extract 03:31:11 INFO - mkdir: /builds/slave/test/build/tests 03:31: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')]} 03:31:11 INFO - trying https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.test_packages.json 03:31:11 INFO - Downloading https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:31:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:31:11 INFO - Downloaded 896 bytes. 03:31:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:31:11 INFO - Using the following test package requirements: 03:31:11 INFO - {u'common': [u'target.common.tests.zip'], 03:31:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:31:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:31:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:31:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:31:11 INFO - u'mozbase': [u'target.common.tests.zip'], 03:31:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:31:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:31:11 INFO - u'web-platform': [u'target.common.tests.zip', 03:31:11 INFO - u'target.web-platform.tests.zip'], 03:31:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:31:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:31:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.common.tests.zip 03:31:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:31:11 INFO - Fetch https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.common.tests.zip into memory 03:31:12 INFO - Expected file size: 42422893 03:31:12 INFO - Obtained file size: 42422893 03:31:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:31:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.common.tests.zip 03:31:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:31:16 INFO - Fetch https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.common.tests.zip into memory 03:31:17 INFO - Expected file size: 42422893 03:31:17 INFO - Obtained file size: 42422893 03:31:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.talos.tests.zip 03:31:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:31:22 INFO - Fetch https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.talos.tests.zip into memory 03:31:23 INFO - Expected file size: 14403454 03:31:23 INFO - Obtained file size: 14403454 03:31: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')]} 03:31:23 INFO - trying https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.tar.bz2 03:31:23 INFO - Downloading https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:31:24 INFO - Downloaded 61691628 bytes. 03:31:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.tar.bz2 03:31:24 INFO - mkdir: /builds/slave/test/properties 03:31:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:24 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:24 INFO - Contents: 03:31:24 INFO - build_url:https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.tar.bz2 03:31:24 INFO - Running post-action listener: _resource_record_post_action 03:31:24 INFO - Running post-action listener: set_extra_try_arguments 03:31:24 INFO - [mozharness: 2017-02-08 11:31:24.855284Z] Finished download-and-extract step (success) 03:31:24 INFO - [mozharness: 2017-02-08 11:31:24.855381Z] Running populate-webroot step. 03:31:24 INFO - Running pre-action listener: _resource_record_pre_action 03:31:24 INFO - Running main action method: populate_webroot 03:31:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:24 INFO - '--tppagecycles', 03:31:24 INFO - '7'], 03:31:24 INFO - 'tests': ['tsvgm']}}, 03:31:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:31:24 INFO - 'talos_options': ['--disable-e10s'], 03:31:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:31:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:31:24 INFO - 'talos_options': ['--disable-e10s'], 03:31:24 INFO - 'tests': ['damp', 'tps']}, 03:31:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:31:24 INFO - 'tests': ['damp', 'tps']}, 03:31:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:24 INFO - 'tests': ['dromaeo_dom']}, 03:31:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:31:24 INFO - 'tests': ['basic_compositor_video']}, 03:31:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:31:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:24 INFO - 'tests': ['a11yr', 03:31:24 INFO - 'ts_paint', 03:31:24 INFO - 'tpaint', 03:31:24 INFO - 'sessionrestore', 03:31:24 INFO - 'sessionrestore_no_auto_restore', 03:31:24 INFO - 'tabpaint']}, 03:31:24 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:24 INFO - 'ts_paint', 03:31:24 INFO - 'tpaint', 03:31:24 INFO - 'sessionrestore', 03:31:24 INFO - 'sessionrestore_no_auto_restore', 03:31:24 INFO - 'tabpaint']}, 03:31:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:24 INFO - 'ts_paint', 03:31:24 INFO - 'tpaint', 03:31:24 INFO - 'sessionrestore', 03:31:24 INFO - 'sessionrestore_no_auto_restore', 03:31:24 INFO - 'tabpaint']}, 03:31:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:24 INFO - 'ts_paint', 03:31:24 INFO - 'tpaint', 03:31:24 INFO - 'sessionrestore', 03:31:24 INFO - 'sessionrestore_no_auto_restore', 03:31:24 INFO - 'tabpaint']}, 03:31:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:24 INFO - 'tests': ['a11yr', 03:31:24 INFO - 'ts_paint', 03:31:24 INFO - 'tpaint', 03:31:24 INFO - 'sessionrestore', 03:31:24 INFO - 'sessionrestore_no_auto_restore', 03:31:24 INFO - 'tabpaint']}, 03:31:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:24 INFO - 'tests': ['a11yr', 03:31:24 INFO - 'ts_paint', 03:31:24 INFO - 'tpaint', 03:31:24 INFO - 'sessionrestore', 03:31:24 INFO - 'sessionrestore_no_auto_restore', 03:31:24 INFO - 'tabpaint']}, 03:31:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:24 INFO - 'tests': ['tsvgx', 03:31:24 INFO - 'tsvgr_opacity', 03:31:24 INFO - 'tart', 03:31:24 INFO - 'tscrollx', 03:31:24 INFO - 'cart', 03:31:24 INFO - 'tsvg_static']}, 03:31:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:24 INFO - 'tsvgr_opacity', 03:31:24 INFO - 'tart', 03:31:24 INFO - 'tscrollx', 03:31:24 INFO - 'cart', 03:31:24 INFO - 'tsvg_static']}, 03:31:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:31:24 INFO - 'talos_options': ['--disable-e10s'], 03:31:24 INFO - 'tests': ['tp5o']}, 03:31:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:31:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:31:24 INFO - 'talos_options': ['--disable-e10s', 03:31:24 INFO - '--xperf_path', 03:31:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:24 INFO - 'tests': ['tp5n']}, 03:31:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:31:24 INFO - 'talos_options': ['--xperf_path', 03:31:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:24 INFO - 'tests': ['tp5n']}}, 03:31:24 INFO - 'talos.zip': {'path': '', 03:31:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:24 INFO - Running post-action listener: _resource_record_post_action 03:31:24 INFO - [mozharness: 2017-02-08 11:31:24.868465Z] Finished populate-webroot step (success) 03:31:24 INFO - [mozharness: 2017-02-08 11:31:24.868558Z] Running create-virtualenv step. 03:31:24 INFO - Running pre-action listener: _resource_record_pre_action 03:31:24 INFO - Running main action method: create_virtualenv 03:31:24 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:24 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 03:31:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:24 INFO - Using real prefix '/usr' 03:31:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:25 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:27 INFO - Installing pip.................done. 03:31:27 INFO - Return code: 0 03:31:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:31:27 INFO - Reading from file tmpfile_stdout 03:31:27 INFO - Output received: 03:31:27 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) 03:31:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31:27 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')]} 03:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:27 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')]} 03:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x145c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb3f0>, '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 0x17cbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc1a0>, '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': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', '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 03:31:27 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 03:31:27 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 03:31:27 INFO - Using env: {'DISPLAY': ':0', 03:31:27 INFO - 'HOME': '/home/cltbld', 03:31:27 INFO - 'LANG': 'en_US.UTF-8', 03:31:27 INFO - 'LANGUAGE': 'en_US:en', 03:31:27 INFO - 'LOGNAME': 'cltbld', 03:31:27 INFO - 'MAIL': '/var/mail/cltbld', 03:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:27 INFO - 'MOZ_NO_REMOTE': '1', 03:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:27 INFO - 'NO_EM_RESTART': '1', 03:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:27 INFO - 'PWD': '/builds/slave/test', 03:31:27 INFO - 'SHELL': '/bin/bash', 03:31:27 INFO - 'SHLVL': '1', 03:31:27 INFO - 'TERM': 'linux', 03:31:27 INFO - 'TMOUT': '86400', 03:31:27 INFO - 'USER': 'cltbld', 03:31:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', 03:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:27 INFO - '_': '/tools/buildbot/bin/python'} 03:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:27 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 03:31:27 INFO - Cleaning up... 03:31:27 INFO - Return code: 0 03:31:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:31:27 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')]} 03:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:27 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')]} 03:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x145c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb3f0>, '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 0x17cbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc1a0>, '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': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', '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 03:31:27 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 03:31:27 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 03:31:27 INFO - Using env: {'DISPLAY': ':0', 03:31:27 INFO - 'HOME': '/home/cltbld', 03:31:27 INFO - 'LANG': 'en_US.UTF-8', 03:31:27 INFO - 'LANGUAGE': 'en_US:en', 03:31:27 INFO - 'LOGNAME': 'cltbld', 03:31:27 INFO - 'MAIL': '/var/mail/cltbld', 03:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:27 INFO - 'MOZ_NO_REMOTE': '1', 03:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:27 INFO - 'NO_EM_RESTART': '1', 03:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:27 INFO - 'PWD': '/builds/slave/test', 03:31:27 INFO - 'SHELL': '/bin/bash', 03:31:27 INFO - 'SHLVL': '1', 03:31:27 INFO - 'TERM': 'linux', 03:31:27 INFO - 'TMOUT': '86400', 03:31:27 INFO - 'USER': 'cltbld', 03:31:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', 03:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:27 INFO - '_': '/tools/buildbot/bin/python'} 03:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:28 INFO - Downloading/unpacking psutil>=3.1.1 03:31:28 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 03:31:28 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 03:31:28 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 03:31:28 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 03:31:28 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 03:31:28 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 03:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:30 INFO - Installing collected packages: psutil 03:31:30 INFO - Running setup.py install for psutil 03:31:30 INFO - building 'psutil._psutil_linux' extension 03:31:30 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 03:31:30 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 03:31:30 INFO - building 'psutil._psutil_posix' extension 03:31:30 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 03:31:30 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 03:31:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:30 INFO - Successfully installed psutil 03:31:30 INFO - Cleaning up... 03:31:30 INFO - Return code: 0 03:31:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:31:30 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')]} 03:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:30 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')]} 03:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:30 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 0x145c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb3f0>, '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 0x17cbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc1a0>, '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': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', '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 03:31:30 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 03:31:30 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 03:31:30 INFO - Using env: {'DISPLAY': ':0', 03:31:30 INFO - 'HOME': '/home/cltbld', 03:31:30 INFO - 'LANG': 'en_US.UTF-8', 03:31:30 INFO - 'LANGUAGE': 'en_US:en', 03:31:30 INFO - 'LOGNAME': 'cltbld', 03:31:30 INFO - 'MAIL': '/var/mail/cltbld', 03:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:30 INFO - 'MOZ_NO_REMOTE': '1', 03:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:30 INFO - 'NO_EM_RESTART': '1', 03:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:30 INFO - 'PWD': '/builds/slave/test', 03:31:30 INFO - 'SHELL': '/bin/bash', 03:31:30 INFO - 'SHLVL': '1', 03:31:30 INFO - 'TERM': 'linux', 03:31:30 INFO - 'TMOUT': '86400', 03:31:30 INFO - 'USER': 'cltbld', 03:31:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', 03:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:30 INFO - '_': '/tools/buildbot/bin/python'} 03:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:31:30 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 03:31:30 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 03:31:30 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 03:31:30 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 03:31:30 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 03:31:30 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 03:31:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:31:33 INFO - Installing collected packages: mozsystemmonitor 03:31:33 INFO - Running setup.py install for mozsystemmonitor 03:31:33 INFO - Successfully installed mozsystemmonitor 03:31:33 INFO - Cleaning up... 03:31:33 INFO - Return code: 0 03:31:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:31:33 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')]} 03:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:33 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')]} 03:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:33 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 0x145c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb3f0>, '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 0x17cbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc1a0>, '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': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', '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 03:31:33 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 03:31:33 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 03:31:33 INFO - Using env: {'DISPLAY': ':0', 03:31:33 INFO - 'HOME': '/home/cltbld', 03:31:33 INFO - 'LANG': 'en_US.UTF-8', 03:31:33 INFO - 'LANGUAGE': 'en_US:en', 03:31:33 INFO - 'LOGNAME': 'cltbld', 03:31:33 INFO - 'MAIL': '/var/mail/cltbld', 03:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:33 INFO - 'MOZ_NO_REMOTE': '1', 03:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:33 INFO - 'NO_EM_RESTART': '1', 03:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:33 INFO - 'PWD': '/builds/slave/test', 03:31:33 INFO - 'SHELL': '/bin/bash', 03:31:33 INFO - 'SHLVL': '1', 03:31:33 INFO - 'TERM': 'linux', 03:31:33 INFO - 'TMOUT': '86400', 03:31:33 INFO - 'USER': 'cltbld', 03:31:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', 03:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:33 INFO - '_': '/tools/buildbot/bin/python'} 03:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:33 INFO - Downloading/unpacking jsonschema==2.5.1 03:31:33 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 03:31:33 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 03:31:33 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 03:31:33 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 03:31:33 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 03:31:33 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 03:31:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:31:35 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 03:31:35 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 03:31:35 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 03:31:35 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 03:31:35 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 03:31:35 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 03:31:35 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:35 INFO - warning: no files found matching '*.txt' 03:31:35 INFO - no previously-included directories found matching 'build' 03:31:35 INFO - no previously-included directories found matching 'dist' 03:31:35 INFO - no previously-included directories found matching '.git*' 03:31:35 INFO - Installing collected packages: jsonschema, functools32 03:31:35 INFO - Running setup.py install for functools32 03:31:35 INFO - warning: no files found matching '*.txt' 03:31:35 INFO - no previously-included directories found matching 'build' 03:31:35 INFO - no previously-included directories found matching 'dist' 03:31:35 INFO - no previously-included directories found matching '.git*' 03:31:35 INFO - Successfully installed jsonschema functools32 03:31:35 INFO - Cleaning up... 03:31:35 INFO - Return code: 0 03:31:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:35 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 0x145c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb3f0>, '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 0x17cbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc1a0>, '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': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', '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 03:31:35 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 03:31:35 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 03:31:35 INFO - Using env: {'DISPLAY': ':0', 03:31:35 INFO - 'HOME': '/home/cltbld', 03:31:35 INFO - 'LANG': 'en_US.UTF-8', 03:31:35 INFO - 'LANGUAGE': 'en_US:en', 03:31:35 INFO - 'LOGNAME': 'cltbld', 03:31:35 INFO - 'MAIL': '/var/mail/cltbld', 03:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:35 INFO - 'MOZ_NO_REMOTE': '1', 03:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:35 INFO - 'NO_EM_RESTART': '1', 03:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:35 INFO - 'PWD': '/builds/slave/test', 03:31:35 INFO - 'SHELL': '/bin/bash', 03:31:35 INFO - 'SHLVL': '1', 03:31:35 INFO - 'TERM': 'linux', 03:31:35 INFO - 'TMOUT': '86400', 03:31:35 INFO - 'USER': 'cltbld', 03:31:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', 03:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:35 INFO - '_': '/tools/buildbot/bin/python'} 03:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:31:36 INFO - Cleaning up... 03:31:36 INFO - Return code: 0 03:31:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:36 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 0x145c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb3f0>, '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 0x17cbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc1a0>, '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': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', '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 03:31:36 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 03:31:36 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 03:31:36 INFO - Using env: {'DISPLAY': ':0', 03:31:36 INFO - 'HOME': '/home/cltbld', 03:31:36 INFO - 'LANG': 'en_US.UTF-8', 03:31:36 INFO - 'LANGUAGE': 'en_US:en', 03:31:36 INFO - 'LOGNAME': 'cltbld', 03:31:36 INFO - 'MAIL': '/var/mail/cltbld', 03:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:36 INFO - 'MOZ_NO_REMOTE': '1', 03:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:36 INFO - 'NO_EM_RESTART': '1', 03:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:36 INFO - 'PWD': '/builds/slave/test', 03:31:36 INFO - 'SHELL': '/bin/bash', 03:31:36 INFO - 'SHLVL': '1', 03:31:36 INFO - 'TERM': 'linux', 03:31:36 INFO - 'TMOUT': '86400', 03:31:36 INFO - 'USER': 'cltbld', 03:31:36 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', 03:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:36 INFO - '_': '/tools/buildbot/bin/python'} 03:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:36 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:36 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 03:31:36 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 03:31:36 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 03:31:36 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 03:31:36 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 03:31:36 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 03:31:38 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:38 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 03:31:38 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 03:31:38 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 03:31:38 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 03:31:38 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 03:31:38 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 03:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:38 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 03:31:38 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 03:31:38 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 03:31:38 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 03:31:38 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 03:31:38 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 03:31:39 INFO - Downloading docopt-0.6.1.tar.gz 03:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:39 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:39 INFO - Running setup.py install for blobuploader 03:31:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:39 INFO - Running setup.py install for requests 03:31:39 INFO - Running setup.py install for docopt 03:31:39 INFO - Successfully installed blobuploader requests docopt 03:31:39 INFO - Cleaning up... 03:31:39 INFO - Return code: 0 03:31:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:39 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')]} 03:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:39 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')]} 03:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:39 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 0x145c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb3f0>, '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 0x17cbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc1a0>, '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': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', '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 03:31:39 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 03:31:39 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 03:31:39 INFO - Using env: {'DISPLAY': ':0', 03:31:39 INFO - 'HOME': '/home/cltbld', 03:31:39 INFO - 'LANG': 'en_US.UTF-8', 03:31:39 INFO - 'LANGUAGE': 'en_US:en', 03:31:39 INFO - 'LOGNAME': 'cltbld', 03:31:39 INFO - 'MAIL': '/var/mail/cltbld', 03:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:39 INFO - 'MOZ_NO_REMOTE': '1', 03:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:39 INFO - 'NO_EM_RESTART': '1', 03:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:39 INFO - 'PWD': '/builds/slave/test', 03:31:39 INFO - 'SHELL': '/bin/bash', 03:31:39 INFO - 'SHLVL': '1', 03:31:39 INFO - 'TERM': 'linux', 03:31:39 INFO - 'TMOUT': '86400', 03:31:39 INFO - 'USER': 'cltbld', 03:31:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', 03:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:39 INFO - '_': '/tools/buildbot/bin/python'} 03:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:40 INFO - Running setup.py (path:/tmp/pip-dv9kW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:40 INFO - Running setup.py (path:/tmp/pip-2aIayd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:40 INFO - Running setup.py (path:/tmp/pip-WMMNQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:40 INFO - Running setup.py (path:/tmp/pip-0XIGeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:40 INFO - Running setup.py (path:/tmp/pip-6lzMTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:40 INFO - Running setup.py (path:/tmp/pip-DnwhgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:40 INFO - Running setup.py (path:/tmp/pip-0c0spS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:40 INFO - Running setup.py (path:/tmp/pip-mHSmyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:40 INFO - Running setup.py (path:/tmp/pip-AIzGKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:40 INFO - Running setup.py (path:/tmp/pip-T01C7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:40 INFO - Running setup.py (path:/tmp/pip-_Qt4kD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:40 INFO - Running setup.py (path:/tmp/pip-3N8GWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:40 INFO - Running setup.py (path:/tmp/pip-8Y8d2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:40 INFO - Running setup.py (path:/tmp/pip-ApqBzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:41 INFO - Running setup.py (path:/tmp/pip-b1uo2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:41 INFO - Running setup.py (path:/tmp/pip-X3BO4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:41 INFO - Running setup.py (path:/tmp/pip-l8JgoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:41 INFO - Running setup.py install for manifestparser 03:31:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:41 INFO - Running setup.py install for mozcrash 03:31:41 INFO - Running setup.py install for mozdebug 03:31:41 INFO - Running setup.py install for mozdevice 03:31:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:41 INFO - Running setup.py install for mozfile 03:31:41 INFO - Running setup.py install for mozhttpd 03:31:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:41 INFO - Running setup.py install for mozinfo 03:31:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:41 INFO - Running setup.py install for mozInstall 03:31:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:42 INFO - Running setup.py install for mozleak 03:31:42 INFO - Running setup.py install for mozlog 03:31:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:42 INFO - Running setup.py install for moznetwork 03:31:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:42 INFO - Running setup.py install for mozprocess 03:31:42 INFO - Running setup.py install for mozprofile 03:31:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:42 INFO - Running setup.py install for mozrunner 03:31:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:42 INFO - Running setup.py install for mozscreenshot 03:31:42 INFO - Running setup.py install for moztest 03:31:42 INFO - Running setup.py install for mozversion 03:31:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:43 INFO - Cleaning up... 03:31:43 INFO - Return code: 0 03:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:43 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')]} 03:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:43 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')]} 03:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:43 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 0x145c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb3f0>, '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 0x17cbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc1a0>, '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': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', '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 03:31:43 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 03:31:43 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 03:31:43 INFO - Using env: {'DISPLAY': ':0', 03:31:43 INFO - 'HOME': '/home/cltbld', 03:31:43 INFO - 'LANG': 'en_US.UTF-8', 03:31:43 INFO - 'LANGUAGE': 'en_US:en', 03:31:43 INFO - 'LOGNAME': 'cltbld', 03:31:43 INFO - 'MAIL': '/var/mail/cltbld', 03:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:43 INFO - 'MOZ_NO_REMOTE': '1', 03:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:43 INFO - 'NO_EM_RESTART': '1', 03:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:43 INFO - 'PWD': '/builds/slave/test', 03:31:43 INFO - 'SHELL': '/bin/bash', 03:31:43 INFO - 'SHLVL': '1', 03:31:43 INFO - 'TERM': 'linux', 03:31:43 INFO - 'TMOUT': '86400', 03:31:43 INFO - 'USER': 'cltbld', 03:31:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', 03:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:43 INFO - '_': '/tools/buildbot/bin/python'} 03:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:43 INFO - Running setup.py (path:/tmp/pip-n1VEst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:43 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)) 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:43 INFO - Running setup.py (path:/tmp/pip-br_JOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:43 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)) 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:43 INFO - Running setup.py (path:/tmp/pip-ii6Elq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:43 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)) 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:43 INFO - Running setup.py (path:/tmp/pip-HA7yXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:43 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)) 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:43 INFO - Running setup.py (path:/tmp/pip-uGwQ4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:43 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)) 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:43 INFO - Running setup.py (path:/tmp/pip-3QUPvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:43 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)) 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:43 INFO - Running setup.py (path:/tmp/pip-nHWNUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:43 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)) 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:43 INFO - Running setup.py (path:/tmp/pip-6hegXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:43 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)) 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:43 INFO - Running setup.py (path:/tmp/pip-9vFPWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:43 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)) 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:43 INFO - Running setup.py (path:/tmp/pip-eyHImH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:44 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)) 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:44 INFO - Running setup.py (path:/tmp/pip-mV1nMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:44 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)) 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:44 INFO - Running setup.py (path:/tmp/pip-4PKgd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:44 INFO - Running setup.py (path:/tmp/pip-Umg9cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:44 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)) 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:44 INFO - Running setup.py (path:/tmp/pip-LsKQpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:44 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)) 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:44 INFO - Running setup.py (path:/tmp/pip-Fg7DmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:44 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)) 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:44 INFO - Running setup.py (path:/tmp/pip-jwDNJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:44 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)) 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:44 INFO - Running setup.py (path:/tmp/pip-PIY07i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:44 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)) 03:31:44 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)) 03:31:44 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)) 03:31:44 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)) 03:31:44 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)) 03:31:44 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)) 03:31:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:44 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 03:31:44 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 03:31:44 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 03:31:44 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 03:31:44 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 03:31:44 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 03:31:46 INFO - Downloading blessings-1.6.tar.gz 03:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:46 INFO - Installing collected packages: blessings 03:31:46 INFO - Running setup.py install for blessings 03:31:46 INFO - Successfully installed blessings 03:31:46 INFO - Cleaning up... 03:31:46 INFO - Return code: 0 03:31:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:47 INFO - Reading from file tmpfile_stdout 03:31:47 INFO - Current package versions: 03:31:47 INFO - argparse == 1.2.1 03:31:47 INFO - blessings == 1.6 03:31:47 INFO - blobuploader == 1.2.4 03:31:47 INFO - docopt == 0.6.1 03:31:47 INFO - functools32 == 3.2.3-2 03:31:47 INFO - jsonschema == 2.5.1 03:31:47 INFO - manifestparser == 1.1 03:31:47 INFO - mozInstall == 1.12 03:31:47 INFO - mozcrash == 1.0 03:31:47 INFO - mozdebug == 0.1 03:31:47 INFO - mozdevice == 0.49 03:31:47 INFO - mozfile == 1.2 03:31:47 INFO - mozhttpd == 0.7 03:31:47 INFO - mozinfo == 0.9 03:31:47 INFO - mozleak == 0.1 03:31:47 INFO - mozlog == 3.4 03:31:47 INFO - moznetwork == 0.27 03:31:47 INFO - mozprocess == 0.24 03:31:47 INFO - mozprofile == 0.28 03:31:47 INFO - mozrunner == 6.13 03:31:47 INFO - mozscreenshot == 0.1 03:31:47 INFO - mozsystemmonitor == 0.3 03:31:47 INFO - moztest == 0.8 03:31:47 INFO - mozversion == 1.4 03:31:47 INFO - psutil == 3.1.1 03:31:47 INFO - requests == 1.2.3 03:31:47 INFO - wsgiref == 0.1.2 03:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:47 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 0x145c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb3f0>, '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 0x17cbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc1a0>, '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': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', '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 03:31:47 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 03:31:47 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 03:31:47 INFO - Using env: {'DISPLAY': ':0', 03:31:47 INFO - 'HOME': '/home/cltbld', 03:31:47 INFO - 'LANG': 'en_US.UTF-8', 03:31:47 INFO - 'LANGUAGE': 'en_US:en', 03:31:47 INFO - 'LOGNAME': 'cltbld', 03:31:47 INFO - 'MAIL': '/var/mail/cltbld', 03:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:47 INFO - 'MOZ_NO_REMOTE': '1', 03:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:47 INFO - 'NO_EM_RESTART': '1', 03:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:47 INFO - 'PWD': '/builds/slave/test', 03:31:47 INFO - 'SHELL': '/bin/bash', 03:31:47 INFO - 'SHLVL': '1', 03:31:47 INFO - 'TERM': 'linux', 03:31:47 INFO - 'TMOUT': '86400', 03:31:47 INFO - 'USER': 'cltbld', 03:31:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', 03:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:47 INFO - '_': '/tools/buildbot/bin/python'} 03:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:47 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)) 03:31:47 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)) 03:31:47 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)) 03:31:47 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)) 03:31:47 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)) 03:31:47 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)) 03:31:47 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)) 03:31:47 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)) 03:31:47 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)) 03:31:47 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)) 03:31:47 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)) 03:31:47 INFO - Cleaning up... 03:31:47 INFO - Return code: 0 03:31:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb3f0>, '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 0x17cbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc1a0>, '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': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', '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 03:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:31:47 INFO - Using env: {'DISPLAY': ':0', 03:31:47 INFO - 'HOME': '/home/cltbld', 03:31:47 INFO - 'LANG': 'en_US.UTF-8', 03:31:47 INFO - 'LANGUAGE': 'en_US:en', 03:31:47 INFO - 'LOGNAME': 'cltbld', 03:31:47 INFO - 'MAIL': '/var/mail/cltbld', 03:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:47 INFO - 'MOZ_NO_REMOTE': '1', 03:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:47 INFO - 'NO_EM_RESTART': '1', 03:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:47 INFO - 'PWD': '/builds/slave/test', 03:31:47 INFO - 'SHELL': '/bin/bash', 03:31:47 INFO - 'SHLVL': '1', 03:31:47 INFO - 'TERM': 'linux', 03:31:47 INFO - 'TMOUT': '86400', 03:31:47 INFO - 'USER': 'cltbld', 03:31:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', 03:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:47 INFO - '_': '/tools/buildbot/bin/python'} 03:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:31:47 INFO - Cleaning up... 03:31:47 INFO - Return code: 0 03:31:47 INFO - Running post-action listener: _resource_record_post_action 03:31:47 INFO - Running post-action listener: _start_resource_monitoring 03:31:47 INFO - Starting resource monitoring. 03:31:47 INFO - [mozharness: 2017-02-08 11:31:47.545171Z] Finished create-virtualenv step (success) 03:31:47 INFO - [mozharness: 2017-02-08 11:31:47.545735Z] Running install step. 03:31:47 INFO - Running pre-action listener: _resource_record_pre_action 03:31:47 INFO - Running main action method: install 03:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:47 INFO - Reading from file tmpfile_stdout 03:31:47 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:47 INFO - Reading from file tmpfile_stdout 03:31:47 INFO - Output received: 03:31:47 INFO - Usage: mozinstall [options] installer 03:31:47 INFO - Options: 03:31:47 INFO - -h, --help show this help message and exit 03:31:47 INFO - -d DEST, --destination=DEST 03:31:47 INFO - Directory to install application into. [default: 03:31:47 INFO - "/builds/slave/test"] 03:31:47 INFO - --app=APP Application being installed. [default: firefox] 03:31:47 INFO - mkdir: /builds/slave/test/build/application 03:31:47 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'] 03:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:32:05 INFO - Reading from file tmpfile_stdout 03:32:05 INFO - Output received: 03:32:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:05 INFO - Running post-action listener: _resource_record_post_action 03:32:05 INFO - [mozharness: 2017-02-08 11:32:05.409069Z] Finished install step (success) 03:32:05 INFO - [mozharness: 2017-02-08 11:32:05.409345Z] Running run-tests step. 03:32:05 INFO - Running pre-action listener: _resource_record_pre_action 03:32:05 INFO - Running main action method: run_tests 03:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:05 INFO - Python 2.7.3 03:32:05 INFO - Return code: 0 03:32:05 INFO - grabbing minidump binary from tooltool 03:32:05 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')]} 03:32:05 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 0x17cb3f0>, '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 0x17cbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:05 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 03:32:05 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 03:32:05 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 03:32:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:05 INFO - Return code: 0 03:32:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:05 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/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:32:05 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/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 03:32:05 INFO - Using env: {'DISPLAY': ':0', 03:32:05 INFO - 'HOME': '/home/cltbld', 03:32:05 INFO - 'LANG': 'en_US.UTF-8', 03:32:05 INFO - 'LANGUAGE': 'en_US:en', 03:32:05 INFO - 'LOGNAME': 'cltbld', 03:32:05 INFO - 'MAIL': '/var/mail/cltbld', 03:32:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:05 INFO - 'MOZ_NO_REMOTE': '1', 03:32:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:05 INFO - 'NO_EM_RESTART': '1', 03:32:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:05 INFO - 'PWD': '/builds/slave/test', 03:32:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:05 INFO - 'SHELL': '/bin/bash', 03:32:05 INFO - 'SHLVL': '1', 03:32:05 INFO - 'TERM': 'linux', 03:32:05 INFO - 'TMOUT': '86400', 03:32:05 INFO - 'USER': 'cltbld', 03:32:05 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086', 03:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:05 INFO - '_': '/tools/buildbot/bin/python'} 03:32:05 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/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:32:05 INFO - mozversion application_buildid: 20170208103009 03:32:05 INFO - mozversion application_changeset: 3a95aa4246653a7863914ffec032897d13359fb0 03:32:05 INFO - mozversion application_display_name: Nightly 03:32:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:05 INFO - mozversion application_name: Firefox 03:32:05 INFO - mozversion application_remotingname: firefox 03:32:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:32:05 INFO - mozversion application_vendor: Mozilla 03:32:05 INFO - mozversion application_version: 54.0a1 03:32:05 INFO - mozversion platform_buildid: 20170208103009 03:32:05 INFO - mozversion platform_changeset: 3a95aa4246653a7863914ffec032897d13359fb0 03:32:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:32:05 INFO - mozversion platform_version: 54.0a1 03:32:05 INFO - using testdate: 1486553525 03:32:05 INFO - actual date: 1486553525 03:32:05 INFO - starting webserver on 'localhost:56471' 03:32:05 INFO - SUITE-START | Running 2 tests 03:32:05 INFO - TEST-START | dromaeo_css 03:32:05 INFO - operating with platform_type : linux_ 03:32:05 INFO - Initialising browser for dromaeo_css test... 03:32:05 INFO - TEST-INFO | started process 3030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpca2DPw/profile http://localhost:56471/getInfo.html) 03:32:08 INFO - PROCESS | 3030 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 03:32:09 INFO - PROCESS | 3030 | __metrics Screen width/height:1600/1200 03:32:09 INFO - PROCESS | 3030 | colorDepth:24 03:32:09 INFO - PROCESS | 3030 | Browser inner width/height: 1024/697 03:32:09 INFO - PROCESS | 3030 | __metrics 03:32:10 INFO - PROCESS | 3030 | 1486553530035 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) 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:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884: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 03:32:10 INFO - PROCESS | 3030 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:32:10 INFO - PROCESS | 3030 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:32:11 INFO - TEST-INFO | 3030: exit 0 03:32:11 INFO - Browser initialized. 03:32:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:11 INFO - TEST-INFO | started process 3113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpca2DPw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:23 INFO - PROCESS | 3113 | RSS: Main: 148824064 03:32:23 INFO - PROCESS | 3113 | 03:35:24 INFO - PROCESS | 3113 | Cycle 1(1): loaded http://localhost:56471/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56471/tests/dromaeo/cssquery-ext.html) 03:35:26 INFO - PROCESS | 3113 | RSS: Main: 299077632 03:35:26 INFO - PROCESS | 3113 | 03:37:13 INFO - PROCESS | 3113 | ************************* 03:37:13 INFO - PROCESS | 3113 | A coding exception was thrown and uncaught in a Task. 03:37:13 INFO - PROCESS | 3113 | 03:37:13 ERROR - PROCESS | 3113 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:37:13 INFO - PROCESS | 3113 | Full stack: 03:37:13 INFO - PROCESS | 3113 | ************************* 03:38:29 INFO - PROCESS | 3113 | Cycle 1(1): loaded http://localhost:56471/tests/dromaeo/cssquery-ext.html (next: http://localhost:56471/tests/dromaeo/cssquery-jquery.html) 03:38:29 INFO - PROCESS | 3113 | RSS: Main: 242565120 03:38:29 INFO - PROCESS | 3113 | 03:41:31 INFO - PROCESS | 3113 | Cycle 1(1): loaded http://localhost:56471/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56471/tests/dromaeo/cssquery-mootools.html) 03:41:32 INFO - PROCESS | 3113 | RSS: Main: 183783424 03:41:32 INFO - PROCESS | 3113 | 03:44:34 INFO - PROCESS | 3113 | Cycle 1(1): loaded http://localhost:56471/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56471/tests/dromaeo/cssquery-prototype.html) 03:44:34 INFO - PROCESS | 3113 | RSS: Main: 183074816 03:44:34 INFO - PROCESS | 3113 | 03:47:37 INFO - PROCESS | 3113 | Cycle 1(1): loaded http://localhost:56471/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56471/tests/dromaeo/cssquery-yui.html) 03:47:38 INFO - PROCESS | 3113 | RSS: Main: 185438208 03:47:38 INFO - PROCESS | 3113 | 03:50:40 INFO - PROCESS | 3113 | Cycle 1(1): loaded http://localhost:56471/tests/dromaeo/cssquery-yui.html (next: http://localhost:56471/tests/dromaeo/cssquery-dojo.html) 03:50:41 INFO - PROCESS | 3113 | RSS: Main: 281534464 03:50:41 INFO - PROCESS | 3113 | 03:50:41 INFO - PROCESS | 3113 | __start_tp_report 03:50:41 INFO - PROCESS | 3113 | _x_x_mozilla_page_load 03:50:41 INFO - PROCESS | 3113 | _x_x_mozilla_page_load_details 03:50:41 INFO - PROCESS | 3113 | |i|pagename|runs| 03:50:41 INFO - PROCESS | 3113 | |0;dojo.html;3137.9843100784497;3161.6047994000737;3189.1389324882284;3209.1977005748563;3221.226905542669;5170.482951704827;5210.583153347732;5298.708571028592;5370.89258214836;5374.516293533586;5286.497782710637;5299.178627312763;5300.125479295921;5319.760610772515;5350.571954243661;4720.929186062212;4723;4817.855464336076;4865.318855360252;4900.6569540132205;4864.100141473838;4890.926636100461;4917.50824917509;4926.0394223126505;4930.7534623268875;4691.906161876777;4718.669693121483;4734.715917044989;4737.810487580493;4886.193778026622;4733.5976442002475;4759.143354196243;4789.688670236424;4828.927566086511;4837.153498137847;4693.78877950493;4720.598749106296;4734.976325118387;4756.881077973078;4763.237881938873;5109.284700141983;5135.35808023997;5251.579873610102;5275.868103297448;5300.231466437345;5638.774449022034;5691.9146212806845;5694.430556944314;5741.138829175616;5796.072628379481;5752.798652047159;5760.855978600526;5776.133579962997;5785.421457854223;5787.450192231731;5235.842924712265;5397.271368365299;5398.946010539884;5399.460053994609;5402.027635025694;5748.568857335633;5777.45114214149;5798.536117110621;5830.154627578977;5884.617499862496;5469.753861076261;5481.972590137104;5519.116941289374;5582.385937546866;5599.692016939108;5701.173329867229;5736.282964629421;5790.10253410722;5795.1886735857015;5799.101139323411;5736.971315143398;5737.225474560964;5739;5741.5119714824705;5753.971230143822;5547.223388725582;5593.46862048113;5599.916001259984;5742.913856292159;5743.655380677089;4418.955810441918;4439.378487011821;4444.622207112367;4475.776211189427;4484.282514797682;3978.781167035783;3979.323515002399;3984.063745019918;4008.118213992975;4014.136960553495;5245.554127899095;5294.602904782079;5417.8103766367985;5429.104197807396;5429.592780541396;5655.123455864347;5681.375048744635;5691.3170419549915;5694.487496125285;5699.886002279931;5371.194320851903;5386.218998245233;5387.111126664056;5389.326334208224;5391.16436952273;4859.101066302675;4866.635002374836;4867.756612169448;4868.196747536616;4903.043906438282;5868.2664666916635;5884.882302353929;5889.293284805851;5893.233879595625;5898.14476900847;5657.12314591239;5736.569757268138;5744.138379243147;5744.454276843693;5747.339056008613;5813.79651712188;5903.557233207613;5905.940940590539;5908.172855800278;5911.852203694942;5522.861928451821;5602.243697101002;5607.831765047055;5613.607047506635;5616.494515493625;5679.460451257124;5682.6306290091015;5686.459786320293;5690.146478028163;5697.686627235542;5432.864178395572;5476.945230547643;5481.835544933659;5529.30883639545;5559.471850174227;5562.415946325739;5619.381867994599;5619.690916999604;5658.03813351723;5671.291088613923;5598.496135347838;5609.158626205938;5616.831495055155;5617.045102332531;5620.325560932714;5351.4648535147735;5443.945560544502;5673.290838645169;5704.458076482728;5711.114777209539;5436.483534064258;5455.072637651688;5467.562594992471;5495.560355171657;5516.3380394351325 03:50:41 INFO - PROCESS | 3113 | |1;ext.html;551.3698937670057;571.2687759667625;581.979630712925;584.5674201091191;587.5152998776011;30004;30629;42318.57681423185;43055;43155.35266970998;40298;43992.3401148983;44015;44131.338029929575;44156.779216103874;7609.162992070867;8767.517786521754;9008.234300084468;9018.819623607556;9028.232600228956;7697.153313135578;10346.637867674634;10571.101456376216;10572.78854422911;10855.565777368935;10591.099756520667;10609.681709548726;10640.893591064068;10668.893311066906;10677.733056673567;10331.638392656296;10337.276390652658;10342.06921377076;10399.168066554734;10415.114715249176;10401.427921464392;10464.581416743322;10473.947630261877;10474.738131546772;10480.58077676892;38281.808590957145;38611.420828687595;38895.61104388948;39044.80477597622;39052;3652.6898260053126;3811.0472381904524;3850.5379354477363;3850.788206648633;3854.4603755474254;26164.73835261642;28091.71908280932;28157.718422815713;28164.295892602644;28248.293792655142;4052.0477687743355;4093.263212621727;4163.292240319153;4312.26691462449;4316.2446571849805;318880.76228946674;320355;320732;321373;321525;53356;53544;53826.461735382145;54061;54215;47885.28172077422;54178.45821541734;54449;54565.454345456834;55592;14427.567172984618;14755.55733328002;14852.10887346741;14867.256637168315;14876.851231487763;9921.206303495703;9989;10469.371837689763;10636.787264254672;10639.840402393971;16890;17247.74128388075;17354.479365619052;17372.82627173712;17425.825741742672;5642;6838.863222735517;6941.791746247621;7031.683574239171;7105.2894710528535;896.2202883491404;910.6767097680361;912.2428384441031;941.449252187478;954.7517645412242;27825.86087069592;28454.288642784097;28491.572626410205;28929.276768080545;29063.418731625672;988.9258305627106;1096.8793432722393;1104.718296834302;1107.9113670906308;1112.1714322829544;14875.628109297139;15612.3755049799;15792.842071579367;15888.523344299689;15903.681926361409;468822;470066;472746;472945;473339;60625.39374606286;61200.99999999911;61239;61269;61273.69363153245;1350.3450826349408;1403.2702994442832;1408.7745960646453;1413.6677880698028;1416.4617445370693;29387.706122938496;30696;30726.231844204074;30993.380132397677;31450.37099258048;49341.50658493369;49903.500964989886;49941.25088123754;50031;50189.49810501848;362307;365146;365362;365617;365751;27101.457970840867;27391.45217095687;27589.862050690423;27779.86110069437;27802.16593502198;37684.43473347957;38065;38125;45964.54035459603;46452.767736161106;38004;38769.418458722575;39207.41188882226;40635.187296253316;41316.96707582335;38417.23165536618;39293.803530982164;40106.19787604173;40176;41209.58790412178;38814.2782725171;39470.2105957885;40278.1944361117;40401.595984039785;40538.79730601328;31797.841010794797;34664.13339666528;34722.47916281207;34810;35278.118047048;26664.333391665365;26749.331266718487;26950.460990780466;27047.594286085332;27433.45133097367 03:50:41 INFO - PROCESS | 3113 | |2;jquery.html;388.20224438778297;416.25905887520224;419.7775179155048;422.8604560495037;440.7069298916221;13598.252096134709;15066.246687665627;19648.21407143714;20238.696419553682;20395.388138355873;18796.812031879675;19076.809231907675;19378.12798424071;19970.500737481532;20495.69256461154;5734.79928202513;5766.365699773021;5872.647641141545;5930;5996.580239383245;3770.340190466671;3906.5312162540536;5811.970940145294;5900.940990590082;5904.852378690545;6161.4146656067605;6366.6180029198395;6390.169277993878;6501.382368674968;6504.284528701839;6346.460550853183;6377.489800815923;6409.647469389181;6434.485241180694;6477.157969463963;5750.568707346965;5757.942420575782;5761.625494342854;5761.740721667535;5767.567432442584;23598.64602030971;24247.757522424727;24261;24475.26574202777;24509.754902451103;3207.182168547029;3215.2765627733806;3219.195201199677;3226.4515032444306;3270.1824543864036;14324.355404006845;14807.33366998477;14821.703565928728;15168.469103581432;15420.922895385564;1886.4906475251605;1904.5905130397032;1991.5618563915916;2026.695995600657;2038.7961203879643;93970;94034;94191.29043547795;96426;97973;11803.645890623295;11953.760924781456;11962.40187990597;12415.255084694947;12416.875831241752;17754.28982840672;17776.55558611045;17778.177691796325;17782.733259001125;17785.822141778415;7438.814029649194;7760.611969401507;7768.106667733283;7815.882761758578;8148.348132149414;7099.2545782693105;7153.105861767279;7277.526960747535;7290.198078211392;7309.561426314332;5236.769359200584;5328.520433161034;5329.626926115135;5349.384820745586;5431.646942948696;2176.5102851858205;2194.3307291276315;2196.3191410662744;2243.8541494802785;2254.8308876834303;467.67496589870393;468.5104066250776;471.27423767398506;842.2209456252941;885.0662551008747;11717.824232636518;12362.44369003397;12379.69050773738;12816;18167.36414225496;978.1490103609905;981.6564202529057;987.0228473810876;995.5918073589794;997.9301448898508;10204.795904081877;10819.51456358789;10859.565617375216;10896.727581810519;10910.563577456971;623743;625530;636659;655562;667844;74594.62702686561;78750;92534.53732731294;94180.52909735407;100869.49565252126;1054.651964851597;1108.3239224073309;1134.2740645986576;1135.4720055174384;1142.9371384573762;17714.822851771834;17751.73372399441;18425;18427.63144737071;18583.81416185875;39945.41582940915;44897.775511122236;44911.77544112258;45323.09353812971;46016.7699161502;58568.414315856295;60435.697821510614;61838.69080654748;62773.37226627858;62820;6153.323134455117;6771.966140169267;8013.799655008672;8382.664693412195;8460.830783384421;11184.496697648789;12375.443105060114;12482.563110291096;12484.313362765135;13480.629842539365;11001.669949901516;11204.215704900578;11219;11233.831492527783;11761.176717629683;10742.677719668422;10952.507137179005;10959;10988.175886808362;11454.656360309204;10846.457677115955;11007.944960275147;11026.173037022096;11159.218854680095;11671.76656466883;8135.593220339078;8329.791755205926;8348.582570871553;8440.198181172778;8675.566221688765;9696.854547181656;10155.492225388849;10423.583056677951;10503.94748026255;10928.836067458835 03:50:41 INFO - PROCESS | 3113 | |3;mootools.html;1452.9200893950829;1453.3096779029959;1453.985460145399;1463.217178809337;1471.3011319623174;8100.351971842253;8552.486850788957;8555.87166192506;8567.357448191387;8572.27135693466;8434.746957591267;8577;8648.437851539646;8650.653973841054;8788.69239576615;2230.342049095521;2265.422317309084;2267.591833469983;2267.6031694453486;2270.4437412833877;2253.9436514087115;2295.162265772989;2303.8272129590264;2304.3087073877855;2307.1117619716447;2257.446925503254;2259.412552736292;2272.261515007629;2279.8632082075046;2282.897269622871;2026.6554685703466;2037.3989673046412;2068.069368784053;2073.2225415469275;2206.922757703481;2169.945751356213;2229.5429436965546;2232.542328822604;2232.720909886264;2233.832462565314;8341.41610087294;8357.414980951336;8420.28427583656;8421.410501264914;8451.45065570736;5037.596992240612;5165.225216217597;5192.1952097424955;5197.454267301954;5232.058229518685;3077.661457239702;3160.8419579020956;3265.4122257993554;3312.834358282076;3326.06870076379;1378.8552202018743;1393.4913756478913;1397.2385050147693;1439.7336492748875;1520.7414739494313;10327.741806454824;10546.36721796687;10985.780284394268;11689.415529223505;11714.882851171464;4363.890902727394;4382.824687012484;4528.841490547815;4536.546345365437;4537.228671125917;9555.474448905237;9560.235181185488;9575.473348965874;9578.233741300679;9586.616535338648;4595.471520775087;4730.101280756645;5054.064997975386;5184.507471790174;5241.397239317527;4731.219348807477;4780.880477988078;4782.689125206851;4784.330193772875;4805.8077676892535;3663.743537952371;3686.8939318204966;3723.162288485069;3754.6808521276;3761.962380376161;1126.414264582429;1127.2954403497813;1131.801934661431;1135.7728454309172;1136.3749937534324;883.6862913665556;947.308464820671;961.423146112327;969.6363863551169;992.3698451483216;5595.38450770415;5789.652620842763;5796.855078623068;5865.944130056546;6079.240094988127;1002.4937406609615;1002.7593377589326;1013.8377859542438;1023.97440063999;1031.8761748590218;4015.437838702584;4039.636432721069;4056.6957478189256;4094;4112.629863312256;10123.797524049478;10373.170146388271;10424.478776061167;10458.790824183474;10482.47587620616;10096.495175241209;10168.135708464863;10239.18086553074;10386.42874641902;10417.322874013165;6968.23349431552;7772.261635144765;7972.880406793903;7984.920150798418;7986;5419.945800542102;5873.618214816023;5894.734736936934;6032.849178770566;6123.969380153071;8943.642254309754;9312.72061838146;9313.580888859882;9333.113354231336;9363.531823408939;9378.531073446436;9522.714318570454;9566.330356874952;9567.61729530811;9624.615015399586;7019.508634395544;7419.406447484296;7552.39580833521;7568.5458872467825;7582.317591416799;7982.8802567960365;8155.673773049011;8262.876056859031;8264.917350826414;8273.214044665747;7123.358897699232;7256.092988376453;7290.599017054113;7317.487775855852;7431;7382.926170738224;7385.291327575145;7411.888821667787;7493.40052795786;7645;6183.443490085914;6234.064890266496;6285.622862628074;6286.088517164894;6287.308396076336;4898.167311556973;4919.901601968012;4964.528369804862;5070.2141168119;5086.3896332440345;4860.343853579863;4937.580305674058;4984.451710311935;5213.40045894727;5281.735913204401 03:50:41 INFO - PROCESS | 3113 | |4;prototype.html;388.75314175498556;392.48192386050414;393.1645253835599;399.61636828644515;402.85899935022746;5163.3029541012;5288.0217159825415;5300.860315032267;5302.666826596304;5336.9733151334285;5011.348524691794;5021.849344519661;5153.1754919212835;5282.445343238962;5295.973520132394;4048.554658987509;4063.2889244382263;4122.299209134454;4149.83400663973;4163.791810409482;4164.479440069991;4169.708120431571;4178.352355384905;4182.163567286555;4216.494020717503;4032.9395059074136;4205.453291072156;4211.789410529476;4216.746995180299;4218.535961044283;4026.3960405939197;4063.6139566741113;4080.89797755057;4169.687273454503;4237.343211802176;3776.282506323817;3788.522476234271;3790.639889210521;3794.7912864792424;3799.67702745267;5129.9230511542355;5188.507091826308;5197.194434862602;5222.232216925036;5241.659292146036;4711.199096153662;4816.158466504779;4846.39420072491;4865.805367785284;4868.561829435333;5552.750126244328;5569.303837020372;5572.60991730579;5573.777048918038;5606.55147588192;4236.173946080516;4239.957600423987;4241.87274381769;4269.146170765828;4272.6154646082;5567.554595632339;5698.318995896179;5732.398098199671;5756.762296106357;5775.451332123442;4305.48334199898;4308.18144552534;4312.784360781949;4313.97843010783;4346.261135606955;4400.92177416535;4420.469543654782;4421.823127074946;4423;4428.734275943454;4757.976210118927;4800.903981920342;4841.467438581753;4849.878753031202;4852.374454557763;5581.46509709833;5586.52514536269;5590.860228494239;5606.635568688022;5609.943900560942;1454.789055586955;1464.992675036618;1479.2529772464836;1481.4962912609765;1483.3325003748357;908.5775114571755;912.2747415804319;957.3107362698846;971.7279161834698;1074.6077681646143;5137.974310128426;5213.191955246943;5369.48989845964;5369.838904832861;5380.3274590676165;5678.744456499468;5712;5735.311762588516;5743.514943229206;5795.1886735857015;5110.207917772751;5299.39057008449;5323.733813309319;5344.812931547377;5353.9196912046355;2922.8976985805393;2931.5960912052337;2948.5282354823125;2972;2989.910302690923;5735.2257445245195;5753.798617048467;5766.163906233573;5778.942210577925;5781.485054001523;5485.396606373296;5618.634788738719;5671.100181439181;5675.120356344773;5682.437329734274;5712.228849105484;5720.227769251181;5725.77096916127;5745.195672605839;5750.88498230033;5253.947460525499;5496.7526461310135;5536.114221724505;5548.278723765885;5559.997601295256;5463.322971743737;5496.642718223303;5549.916751248654;5564.916526252028;5575.553955683617;5595.860103497445;5694.743736531949;5715.114012375823;5721.942780572141;5749.384030266302;4068.105016896278;4178.394132850781;4204.552267140915;4353.390525326394;4386.71486353386;5689.914651280152;5693.8861222774485;5723.542116630576;5726.799562015476;5732.541396688338;5559.805406810742;5563.7774489019985;5585.553155747449;5586.581006424616;5587.664740115606;5450.792429066235;5568.053430916673;5568.693721845338;5572.442755724395;5597.3003374578175;5551.167324901297;5551.833444996657;5571.7492712828835;5578.246936663661;5590.329160500766;5397.59518036141;5489.313835770528;5522.2544956430365;5604.8879022418505;5613.186088017296;5457.508824205841;5480.657238976476;5485.780568777204;5490.478404551562;5503.559715222853 03:50:41 INFO - PROCESS | 3113 | |5;yui.html;717.6698718589448;743.0526079248957;776.8912352270684;833.41244422682;847.1655419411878;13777.448902043907;14901.627459313495;14911.179885106341;15009.399624015039;15030.77453838192;14679.486217982372;14907.32917018734;14956.25218739064;14979.925100374483;15014.774778378332;746.723712226477;758.1205801270527;761.029687148884;771.2326235395789;772.9294926526773;761.1665226576889;762.8512440074188;763.3664058831184;765.5712800831525;766.7508059880533;796.8286818334057;798.5927177139672;801.2228138705475;801.3989507869098;802.6187560908551;791.8812178173263;793.4604468961134;796.5539297993114;798.4530596541359;799.312591171592;584.3484514766047;584.5849446892711;586.0184191479256;586.14130299112;586.4311617730795;15392.692146157015;15601.765973510293;15629.296681649354;16082.678346433122;16277.837221627751;14000.439982400692;14437.855621443861;14450.132992020512;14464.493742718954;14511.492097776632;11905;11905.28568285897;11917.463714132884;12264.448099835528;12359;3564.180238545149;3582.8208589570677;3594.730395220369;3653.853845846163;3654.524911761454;72788.27211727868;73005.63497182533;73216;74146.62926685387;75721.62139189323;10522.894771052344;11068;11095.889041109647;11226.438678066064;11395.202335836411;20280.08739606721;20539.691904621443;20547.58904821925;20557.897210513853;20616.278430254868;7058.400035996998;7183.5330703504105;7260.636968151572;7381.261873812576;7467.439942004263;3774.2640185163627;3887.5723670396233;3917.6474117329576;3975.2447035063824;3987.063040185554;3531.1172206948263;3653.451982202691;3708.2027364116843;3714.591394946554;3740.738148329591;568.9886202276014;573.9282589676291;574.4800955135609;582.452494655023;582.9708514574339;703.2756261051126;711.9537230080028;734.6473692627569;750;750.440921513465;9632.518374081268;9814;10006.299559030944;10132.138768204784;10371.066604005675;715.3168723868692;727.956085257898;738.5900825042046;740.1820987808502;750.7297372945735;4764.904701905943;4943.950560494421;5032.496750324938;5032.823851165192;5043.899122017539;70231.2976870235;73610.63194683992;74499.25500745031;74772.25227747762;77169.22830771733;66596.33403665999;66630.19040608019;67546;68653.65673171703;69388.65305673439;50525.74737126364;53050.469495305326;60661.56437930214;61700.38299617036;61704;9245.815083698153;9620.470874101991;9716.222702183666;9735.464549449565;9736.951315243661;35311.64688353187;35691;37799.24401512009;39721;41111;43745.56254437415;50421;50445.24332134947;53292.73353633207;55457.1681424787;12613.49546018149;12801.679958001125;12839.679008024874;13015.804762928754;13269.46922123143;13200.867991319963;13411.731765364442;13564.118332308368;13588.116772409761;13751.449942002208;12805.551805686757;12924.338642814575;12934.482620695444;13015;13596.86403135956;14231.288435578386;14248.430062797786;14395.784063239269;14767.92616036913;15041.323140458488;12628.936855315664;12758.808617870554;12794.232346059267;13310.866891330963;13340.599782006555;10054.245931555017;10122.8481572775;10265.281430299807;10482.21383396233;10689.412082335235;10096.878149038619;10102.545385457819;10220.488975551341;10224.846627300447;10227.28409011362 03:50:41 INFO - PROCESS | 3113 | __end_tp_report 03:50:41 INFO - PROCESS | 3113 | __start_cc_report 03:50:41 INFO - PROCESS | 3113 | _x_x_mozilla_cycle_collect,1533 03:50:41 INFO - PROCESS | 3113 | __end_cc_report 03:50:41 INFO - PROCESS | 3113 | __startTimestamp1486554641238__endTimestamp 03:50:41 INFO - PROCESS | 3113 | 03:50:41 INFO - PROCESS | 3113 | ------- Summary: start ------- 03:50:41 INFO - PROCESS | 3113 | Number of tests: 6 03:50:41 INFO - PROCESS | 3113 | 03:50:41 INFO - PROCESS | 3113 | [#0] dojo.html Cycles:165 Average:5292.22 Median:5476.95 stddev:587.28 (10.7%) stddev-sans-first:564.24 03:50:41 INFO - PROCESS | 3113 | Values: 3138.0 3161.6 3189.1 3209.2 3221.2 5170.5 5210.6 5298.7 5370.9 5374.5 5286.5 5299.2 5300.1 5319.8 5350.6 4720.9 4723.0 4817.9 4865.3 4900.7 4864.1 4890.9 4917.5 4926.0 4930.8 4691.9 4718.7 4734.7 4737.8 4886.2 4733.6 4759.1 4789.7 4828.9 4837.2 4693.8 4720.6 4735.0 4756.9 4763.2 5109.3 5135.4 5251.6 5275.9 5300.2 5638.8 5691.9 5694.4 5741.1 5796.1 5752.8 5760.9 5776.1 5785.4 5787.5 5235.8 5397.3 5398.9 5399.5 5402.0 5748.6 5777.5 5798.5 5830.2 5884.6 5469.8 5482.0 5519.1 5582.4 5599.7 5701.2 5736.3 5790.1 5795.2 5799.1 5737.0 5737.2 5739.0 5741.5 5754.0 5547.2 5593.5 5599.9 5742.9 5743.7 4419.0 4439.4 4444.6 4475.8 4484.3 3978.8 3979.3 3984.1 4008.1 4014.1 5245.6 5294.6 5417.8 5429.1 5429.6 5655.1 5681.4 5691.3 5694.5 5699.9 5371.2 5386.2 5387.1 5389.3 5391.2 4859.1 4866.6 4867.8 4868.2 4903.0 5868.3 5884.9 5889.3 5893.2 5898.1 5657.1 5736.6 5744.1 5744.5 5747.3 5813.8 5903.6 5905.9 5908.2 5911.9 5522.9 5602.2 5607.8 5613.6 5616.5 5679.5 5682.6 5686.5 5690.1 5697.7 5432.9 5476.9 5481.8 5529.3 5559.5 5562.4 5619.4 5619.7 5658.0 5671.3 5598.5 5609.2 5616.8 5617.0 5620.3 5351.5 5443.9 5673.3 5704.5 5711.1 5436.5 5455.1 5467.6 5495.6 5516.3 03:50:41 INFO - PROCESS | 3113 | 03:50:41 INFO - PROCESS | 3113 | [#1] ext.html Cycles:180 Average:54393.60 Median:38034.50 stddev:103255.81 (271.5%) stddev-sans-first:103466.33 03:50:41 INFO - PROCESS | 3113 | Values: 551.4 571.3 582.0 584.6 587.5 30004.0 30629.0 42318.6 43055.0 43155.4 40298.0 43992.3 44015.0 44131.3 44156.8 7609.2 8767.5 9008.2 9018.8 9028.2 7697.2 10346.6 10571.1 10572.8 10855.6 10591.1 10609.7 10640.9 10668.9 10677.7 10331.6 10337.3 10342.1 10399.2 10415.1 10401.4 10464.6 10473.9 10474.7 10480.6 38281.8 38611.4 38895.6 39044.8 39052.0 3652.7 3811.0 3850.5 3850.8 3854.5 26164.7 28091.7 28157.7 28164.3 28248.3 4052.0 4093.3 4163.3 4312.3 4316.2 318880.8 320355.0 320732.0 321373.0 321525.0 53356.0 53544.0 53826.5 54061.0 54215.0 47885.3 54178.5 54449.0 54565.5 55592.0 14427.6 14755.6 14852.1 14867.3 14876.9 9921.2 9989.0 10469.4 10636.8 10639.8 16890.0 17247.7 17354.5 17372.8 17425.8 5642.0 6838.9 6941.8 7031.7 7105.3 896.2 910.7 912.2 941.4 954.8 27825.9 28454.3 28491.6 28929.3 29063.4 988.9 1096.9 1104.7 1107.9 1112.2 14875.6 15612.4 15792.8 15888.5 15903.7 468822.0 470066.0 472746.0 472945.0 473339.0 60625.4 61201.0 61239.0 61269.0 61273.7 1350.3 1403.3 1408.8 1413.7 1416.5 29387.7 30696.0 30726.2 30993.4 31450.4 49341.5 49903.5 49941.3 50031.0 50189.5 362307.0 365146.0 365362.0 365617.0 365751.0 27101.5 27391.5 27589.9 27779.9 27802.2 37684.4 38065.0 38125.0 45964.5 46452.8 38004.0 38769.4 39207.4 40635.2 41317.0 38417.2 39293.8 40106.2 40176.0 41209.6 38814.3 39470.2 40278.2 40401.6 40538.8 31797.8 34664.1 34722.5 34810.0 35278.1 26664.3 26749.3 26950.5 27047.6 27433.5 03:50:41 INFO - PROCESS | 3113 | 03:50:41 INFO - PROCESS | 3113 | [#2] jquery.html Cycles:180 Average:33670.60 Median:2079.27 stddev:105421.97 (5070.1%) stddev-sans-first:105688.08 03:50:41 INFO - PROCESS | 3113 | Values: 388.2 416.3 419.8 422.9 440.7 13598.3 15066.2 19648.2 20238.7 20395.4 18796.8 19076.8 19378.1 19970.5 20495.7 5734.8 5766.4 5872.6 5930.0 5996.6 3770.3 3906.5 5812.0 5900.9 5904.9 6161.4 6366.6 6390.2 6501.4 6504.3 6346.5 6377.5 6409.6 6434.5 6477.2 5750.6 5757.9 5761.6 5761.7 5767.6 23598.6 24247.8 24261.0 24475.3 24509.8 3207.2 3215.3 3219.2 3226.5 3270.2 14324.4 14807.3 14821.7 15168.5 15420.9 1886.5 1904.6 1991.6 2026.7 2038.8 93970.0 94034.0 94191.3 96426.0 97973.0 11803.6 11953.8 11962.4 12415.3 12416.9 17754.3 17776.6 17778.2 17782.7 17785.8 7438.8 7760.6 7768.1 7815.9 8148.3 7099.3 7153.1 7277.5 7290.2 7309.6 5236.8 5328.5 5329.6 5349.4 5431.6 2176.5 2194.3 2196.3 2243.9 2254.8 467.7 468.5 471.3 842.2 885.1 11717.8 12362.4 12379.7 12816.0 18167.4 978.1 981.7 987.0 995.6 997.9 10204.8 10819.5 10859.6 10896.7 10910.6 623743.0 625530.0 636659.0 655562.0 667844.0 74594.6 78750.0 92534.5 94180.5 100869.5 1054.7 1108.3 1134.3 1135.5 1142.9 17714.8 17751.7 18425.0 18427.6 18583.8 39945.4 44897.8 44911.8 45323.1 46016.8 58568.4 60435.7 61838.7 62773.4 62820.0 6153.3 6772.0 8013.8 8382.7 8460.8 11184.5 12375.4 12482.6 12484.3 13480.6 11001.7 11204.2 11219.0 11233.8 11761.2 10742.7 10952.5 10959.0 10988.2 11454.7 10846.5 11007.9 11026.2 11159.2 11671.8 8135.6 8329.8 8348.6 8440.2 8675.6 9696.9 10155.5 10423.6 10503.9 10928.8 03:50:41 INFO - PROCESS | 3113 | 03:50:41 INFO - PROCESS | 3113 | [#3] mootools.html Cycles:180 Average:5531.01 Median:4951.05 stddev:3059.40 (61.8%) stddev-sans-first:3052.63 03:50:41 INFO - PROCESS | 3113 | Values: 1452.9 1453.3 1454.0 1463.2 1471.3 8100.4 8552.5 8555.9 8567.4 8572.3 8434.7 8577.0 8648.4 8650.7 8788.7 2230.3 2265.4 2267.6 2267.6 2270.4 2253.9 2295.2 2303.8 2304.3 2307.1 2257.4 2259.4 2272.3 2279.9 2282.9 2026.7 2037.4 2068.1 2073.2 2206.9 2169.9 2229.5 2232.5 2232.7 2233.8 8341.4 8357.4 8420.3 8421.4 8451.5 5037.6 5165.2 5192.2 5197.5 5232.1 3077.7 3160.8 3265.4 3312.8 3326.1 1378.9 1393.5 1397.2 1439.7 1520.7 10327.7 10546.4 10985.8 11689.4 11714.9 4363.9 4382.8 4528.8 4536.5 4537.2 9555.5 9560.2 9575.5 9578.2 9586.6 4595.5 4730.1 5054.1 5184.5 5241.4 4731.2 4780.9 4782.7 4784.3 4805.8 3663.7 3686.9 3723.2 3754.7 3762.0 1126.4 1127.3 1131.8 1135.8 1136.4 883.7 947.3 961.4 969.6 992.4 5595.4 5789.7 5796.9 5865.9 6079.2 1002.5 1002.8 1013.8 1024.0 1031.9 4015.4 4039.6 4056.7 4094.0 4112.6 10123.8 10373.2 10424.5 10458.8 10482.5 10096.5 10168.1 10239.2 10386.4 10417.3 6968.2 7772.3 7972.9 7984.9 7986.0 5419.9 5873.6 5894.7 6032.8 6124.0 8943.6 9312.7 9313.6 9333.1 9363.5 9378.5 9522.7 9566.3 9567.6 9624.6 7019.5 7419.4 7552.4 7568.5 7582.3 7982.9 8155.7 8262.9 8264.9 8273.2 7123.4 7256.1 7290.6 7317.5 7431.0 7382.9 7385.3 7411.9 7493.4 7645.0 6183.4 6234.1 6285.6 6286.1 6287.3 4898.2 4919.9 4964.5 5070.2 5086.4 4860.3 4937.6 4984.5 5213.4 5281.7 03:50:41 INFO - PROCESS | 3113 | 03:50:41 INFO - PROCESS | 3113 | [#4] prototype.html Cycles:180 Average:4696.95 Median:5330.35 stddev:1335.27 (25.1%) stddev-sans-first:1299.27 03:50:41 INFO - PROCESS | 3113 | Values: 388.8 392.5 393.2 399.6 402.9 5163.3 5288.0 5300.9 5302.7 5337.0 5011.3 5021.8 5153.2 5282.4 5296.0 4048.6 4063.3 4122.3 4149.8 4163.8 4164.5 4169.7 4178.4 4182.2 4216.5 4032.9 4205.5 4211.8 4216.7 4218.5 4026.4 4063.6 4080.9 4169.7 4237.3 3776.3 3788.5 3790.6 3794.8 3799.7 5129.9 5188.5 5197.2 5222.2 5241.7 4711.2 4816.2 4846.4 4865.8 4868.6 5552.8 5569.3 5572.6 5573.8 5606.6 4236.2 4240.0 4241.9 4269.1 4272.6 5567.6 5698.3 5732.4 5756.8 5775.5 4305.5 4308.2 4312.8 4314.0 4346.3 4400.9 4420.5 4421.8 4423.0 4428.7 4758.0 4800.9 4841.5 4849.9 4852.4 5581.5 5586.5 5590.9 5606.6 5609.9 1454.8 1465.0 1479.3 1481.5 1483.3 908.6 912.3 957.3 971.7 1074.6 5138.0 5213.2 5369.5 5369.8 5380.3 5678.7 5712.0 5735.3 5743.5 5795.2 5110.2 5299.4 5323.7 5344.8 5353.9 2922.9 2931.6 2948.5 2972.0 2989.9 5735.2 5753.8 5766.2 5778.9 5781.5 5485.4 5618.6 5671.1 5675.1 5682.4 5712.2 5720.2 5725.8 5745.2 5750.9 5253.9 5496.8 5536.1 5548.3 5560.0 5463.3 5496.6 5549.9 5564.9 5575.6 5595.9 5694.7 5715.1 5721.9 5749.4 4068.1 4178.4 4204.6 4353.4 4386.7 5689.9 5693.9 5723.5 5726.8 5732.5 5559.8 5563.8 5585.6 5586.6 5587.7 5450.8 5568.1 5568.7 5572.4 5597.3 5551.2 5551.8 5571.7 5578.2 5590.3 5397.6 5489.3 5522.3 5604.9 5613.2 5457.5 5480.7 5485.8 5490.5 5503.6 03:50:41 INFO - PROCESS | 3113 | 03:50:41 INFO - PROCESS | 3113 | [#5] yui.html Cycles:180 Average:16727.50 Median:3981.15 stddev:21023.05 (528.1%) stddev-sans-first:21047.65 03:50:41 INFO - PROCESS | 3113 | Values: 717.7 743.1 776.9 833.4 847.2 13777.4 14901.6 14911.2 15009.4 15030.8 14679.5 14907.3 14956.3 14979.9 15014.8 746.7 758.1 761.0 771.2 772.9 761.2 762.9 763.4 765.6 766.8 796.8 798.6 801.2 801.4 802.6 791.9 793.5 796.6 798.5 799.3 584.3 584.6 586.0 586.1 586.4 15392.7 15601.8 15629.3 16082.7 16277.8 14000.4 14437.9 14450.1 14464.5 14511.5 11905.0 11905.3 11917.5 12264.4 12359.0 3564.2 3582.8 3594.7 3653.9 3654.5 72788.3 73005.6 73216.0 74146.6 75721.6 10522.9 11068.0 11095.9 11226.4 11395.2 20280.1 20539.7 20547.6 20557.9 20616.3 7058.4 7183.5 7260.6 7381.3 7467.4 3774.3 3887.6 3917.6 3975.2 3987.1 3531.1 3653.5 3708.2 3714.6 3740.7 569.0 573.9 574.5 582.5 583.0 703.3 712.0 734.6 750.0 750.4 9632.5 9814.0 10006.3 10132.1 10371.1 715.3 728.0 738.6 740.2 750.7 4764.9 4944.0 5032.5 5032.8 5043.9 70231.3 73610.6 74499.3 74772.3 77169.2 66596.3 66630.2 67546.0 68653.7 69388.7 50525.7 53050.5 60661.6 61700.4 61704.0 9245.8 9620.5 9716.2 9735.5 9737.0 35311.6 35691.0 37799.2 39721.0 41111.0 43745.6 50421.0 50445.2 53292.7 55457.2 12613.5 12801.7 12839.7 13015.8 13269.5 13200.9 13411.7 13564.1 13588.1 13751.4 12805.6 12924.3 12934.5 13015.0 13596.9 14231.3 14248.4 14395.8 14767.9 15041.3 12628.9 12758.8 12794.2 13310.9 13340.6 10054.2 10122.8 10265.3 10482.2 10689.4 10096.9 10102.5 10220.5 10224.8 10227.3 03:50:41 INFO - PROCESS | 3113 | -------- Summary: end -------- 03:50:41 INFO - PROCESS | 3113 | 03:50:42 INFO - TEST-INFO | 3113: exit 0 03:50:42 INFO - TEST-OK | dromaeo_css | took 1116349ms 03:50:42 INFO - TEST-START | kraken 03:50:42 INFO - operating with platform_type : linux_ 03:50:42 INFO - Initialising browser for kraken test... 03:50:42 INFO - TEST-INFO | started process 3412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEnbKO6/profile http://localhost:56471/getInfo.html) 03:50:45 INFO - PROCESS | 3412 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 03:50:45 INFO - PROCESS | 3412 | __metrics Screen width/height:1600/1200 03:50:45 INFO - PROCESS | 3412 | colorDepth:24 03:50:45 INFO - PROCESS | 3412 | Browser inner width/height: 1024/697 03:50:45 INFO - PROCESS | 3412 | __metrics 03:50:46 INFO - PROCESS | 3412 | 1486554646421 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) 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:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884: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 03:50:46 INFO - PROCESS | 3412 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:50:46 INFO - PROCESS | 3412 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:50:47 INFO - TEST-INFO | 3412: exit 0 03:50:47 INFO - Browser initialized. 03:50:47 INFO - Running cycle 1/1 for kraken test... 03:50:47 INFO - TEST-INFO | started process 3497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEnbKO6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:59 INFO - PROCESS | 3497 | RSS: Main: 151511040 03:50:59 INFO - PROCESS | 3497 | 03:51:02 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56471/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:02 INFO - PROCESS | 3497 | RSS: Main: 204382208 03:51:02 INFO - PROCESS | 3497 | 03:51:05 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56471/tests/kraken/driver.html?testName=audio-dft) 03:51:06 INFO - PROCESS | 3497 | RSS: Main: 183459840 03:51:06 INFO - PROCESS | 3497 | 03:51:09 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56471/tests/kraken/driver.html?testName=audio-fft) 03:51:09 INFO - PROCESS | 3497 | RSS: Main: 265068544 03:51:09 INFO - PROCESS | 3497 | 03:51:11 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56471/tests/kraken/driver.html?testName=audio-oscillator) 03:51:12 INFO - PROCESS | 3497 | RSS: Main: 176631808 03:51:12 INFO - PROCESS | 3497 | 03:51:14 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56471/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:15 INFO - PROCESS | 3497 | RSS: Main: 180445184 03:51:15 INFO - PROCESS | 3497 | 03:51:18 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56471/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:18 INFO - PROCESS | 3497 | RSS: Main: 220192768 03:51:18 INFO - PROCESS | 3497 | 03:51:22 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56471/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:22 INFO - PROCESS | 3497 | RSS: Main: 218963968 03:51:22 INFO - PROCESS | 3497 | 03:51:25 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56471/tests/kraken/driver.html?testName=json-parse-financial) 03:51:26 INFO - PROCESS | 3497 | RSS: Main: 217751552 03:51:26 INFO - PROCESS | 3497 | 03:51:27 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56471/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:28 INFO - PROCESS | 3497 | RSS: Main: 180355072 03:51:28 INFO - PROCESS | 3497 | 03:51:30 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56471/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:30 INFO - PROCESS | 3497 | RSS: Main: 187531264 03:51:30 INFO - PROCESS | 3497 | 03:51:32 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56471/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:33 INFO - PROCESS | 3497 | RSS: Main: 196182016 03:51:33 INFO - PROCESS | 3497 | 03:51:35 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:36 INFO - PROCESS | 3497 | RSS: Main: 205869056 03:51:36 INFO - PROCESS | 3497 | 03:51:39 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:40 INFO - PROCESS | 3497 | RSS: Main: 202682368 03:51:40 INFO - PROCESS | 3497 | 03:51:41 INFO - PROCESS | 3497 | Cycle 1(1): loaded http://localhost:56471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56471/tests/kraken/driver.html?testName=ai-astar) 03:51:42 INFO - PROCESS | 3497 | RSS: Main: 254423040 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | __start_tp_report 03:51:42 INFO - PROCESS | 3497 | _x_x_mozilla_page_load 03:51:42 INFO - PROCESS | 3497 | _x_x_mozilla_page_load_details 03:51:42 INFO - PROCESS | 3497 | |i|pagename|runs| 03:51:42 INFO - PROCESS | 3497 | |0;ai-astar;105;113;111;111;112;111;113;112;111;112 03:51:42 INFO - PROCESS | 3497 | |1;audio-beat-detection;160;126;121;160;128;129;119;120;144;120 03:51:42 INFO - PROCESS | 3497 | |2;audio-dft;162;161;164;162;161;162;162;163;162;161 03:51:42 INFO - PROCESS | 3497 | |3;audio-fft;76;85;77;109;77;77;76;77;98;77 03:51:42 INFO - PROCESS | 3497 | |4;audio-oscillator;84;82;110;83;82;83;103;83;82;108 03:51:42 INFO - PROCESS | 3497 | |5;imaging-gaussian-blur;117;118;119;117;119;117;118;119;118;117 03:51:42 INFO - PROCESS | 3497 | |6;imaging-darkroom;148;148;147;148;147;148;148;148;147;147 03:51:42 INFO - PROCESS | 3497 | |7;imaging-desaturate;95;95;96;96;96;96;96;95;95;95 03:51:42 INFO - PROCESS | 3497 | |8;json-parse-financial;55;62;54;53;55;53;54;55;54;57 03:51:42 INFO - PROCESS | 3497 | |9;json-stringify-tinderbox;65;66;65;64;65;65;64;64;65;64 03:51:42 INFO - PROCESS | 3497 | |10;stanford-crypto-aes;84;85;84;83;84;83;82;83;87;85 03:51:42 INFO - PROCESS | 3497 | |11;stanford-crypto-ccm;138;134;137;129;129;126;132;135;169;139 03:51:42 INFO - PROCESS | 3497 | |12;stanford-crypto-pbkdf2;178;168;168;169;169;170;167;168;169;169 03:51:42 INFO - PROCESS | 3497 | |13;stanford-crypto-sha256-iterative;63;64;63;64;63;66;63;62;63;67 03:51:42 INFO - PROCESS | 3497 | __end_tp_report 03:51:42 INFO - PROCESS | 3497 | __start_cc_report 03:51:42 INFO - PROCESS | 3497 | _x_x_mozilla_cycle_collect,1665 03:51:42 INFO - PROCESS | 3497 | __end_cc_report 03:51:42 INFO - PROCESS | 3497 | __startTimestamp1486554702044__endTimestamp 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | ------- Summary: start ------- 03:51:42 INFO - PROCESS | 3497 | Number of tests: 14 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.28 (2.0%) stddev-sans-first:0.83 03:51:42 INFO - PROCESS | 3497 | Values: 105.0 113.0 111.0 111.0 112.0 111.0 113.0 112.0 111.0 112.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:128.50 stddev:16.15 (12.6%) stddev-sans-first:13.77 03:51:42 INFO - PROCESS | 3497 | Values: 160.0 126.0 121.0 160.0 128.0 129.0 119.0 120.0 144.0 120.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 03:51:42 INFO - PROCESS | 3497 | Values: 162.0 161.0 164.0 162.0 161.0 162.0 162.0 163.0 162.0 161.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:11.46 (14.9%) stddev-sans-first:11.88 03:51:42 INFO - PROCESS | 3497 | Values: 76.0 85.0 77.0 109.0 77.0 77.0 76.0 77.0 98.0 77.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:82.50 stddev:11.87 (14.4%) stddev-sans-first:12.39 03:51:42 INFO - PROCESS | 3497 | Values: 84.0 82.0 110.0 83.0 82.0 83.0 103.0 83.0 82.0 108.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.87 03:51:42 INFO - PROCESS | 3497 | Values: 117.0 118.0 119.0 117.0 119.0 117.0 118.0 119.0 118.0 117.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 03:51:42 INFO - PROCESS | 3497 | Values: 148.0 148.0 147.0 148.0 147.0 148.0 148.0 148.0 147.0 147.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:51:42 INFO - PROCESS | 3497 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:2.66 (4.8%) stddev-sans-first:2.82 03:51:42 INFO - PROCESS | 3497 | Values: 55.0 62.0 54.0 53.0 55.0 53.0 54.0 55.0 54.0 57.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 03:51:42 INFO - PROCESS | 3497 | Values: 65.0 66.0 65.0 64.0 65.0 65.0 64.0 64.0 65.0 64.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:1.41 (1.7%) stddev-sans-first:1.50 03:51:42 INFO - PROCESS | 3497 | Values: 84.0 85.0 84.0 83.0 84.0 83.0 82.0 83.0 87.0 85.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:136.00 stddev:12.09 (8.9%) stddev-sans-first:12.82 03:51:42 INFO - PROCESS | 3497 | Values: 138.0 134.0 137.0 129.0 129.0 126.0 132.0 135.0 169.0 139.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:169.00 stddev:3.10 (1.8%) stddev-sans-first:0.88 03:51:42 INFO - PROCESS | 3497 | Values: 178.0 168.0 168.0 169.0 169.0 170.0 167.0 168.0 169.0 169.0 03:51:42 INFO - PROCESS | 3497 | 03:51:42 INFO - PROCESS | 3497 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:1.55 (2.4%) stddev-sans-first:1.62 03:51:42 INFO - PROCESS | 3497 | Values: 63.0 64.0 63.0 64.0 63.0 66.0 63.0 62.0 63.0 67.0 03:51:42 INFO - PROCESS | 3497 | -------- Summary: end -------- 03:51:42 INFO - PROCESS | 3497 | 03:51:43 INFO - TEST-INFO | 3497: exit 0 03:51:43 INFO - TEST-OK | kraken | took 61157ms 03:51:43 INFO - SUITE-END | took 1177s 03:51:43 INFO - Completed test suite (00:19:37) 03:51:43 INFO - javascript benchmark 03:51:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7092.1313928992995, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.9843100784497, 3161.6047994000737, 3189.1389324882284, 3209.1977005748563, 3221.226905542669, 5170.482951704827, 5210.583153347732, 5298.708571028592, 5370.89258214836, 5374.516293533586, 5286.497782710637, 5299.178627312763, 5300.125479295921, 5319.760610772515, 5350.571954243661, 4720.929186062212, 4723.0, 4817.855464336076, 4865.318855360252, 4900.6569540132205, 4864.100141473838, 4890.926636100461, 4917.50824917509, 4926.0394223126505, 4930.7534623268875, 4691.906161876777, 4718.669693121483, 4734.715917044989, 4737.810487580493, 4886.193778026622, 4733.5976442002475, 4759.143354196243, 4789.688670236424, 4828.927566086511, 4837.153498137847, 4693.78877950493, 4720.598749106296, 4734.976325118387, 4756.881077973078, 4763.237881938873, 5109.284700141983, 5135.35808023997, 5251.579873610102, 5275.868103297448, 5300.231466437345, 5638.774449022034, 5691.9146212806845, 5694.430556944314, 5741.138829175616, 5796.072628379481, 5752.798652047159, 5760.855978600526, 5776.133579962997, 5785.421457854223, 5787.450192231731, 5235.842924712265, 5397.271368365299, 5398.946010539884, 5399.460053994609, 5402.027635025694, 5748.568857335633, 5777.45114214149, 5798.536117110621, 5830.154627578977, 5884.617499862496, 5469.753861076261, 5481.972590137104, 5519.116941289374, 5582.385937546866, 5599.692016939108, 5701.173329867229, 5736.282964629421, 5790.10253410722, 5795.1886735857015, 5799.101139323411, 5736.971315143398, 5737.225474560964, 5739.0, 5741.5119714824705, 5753.971230143822, 5547.223388725582, 5593.46862048113, 5599.916001259984, 5742.913856292159, 5743.655380677089, 4418.955810441918, 4439.378487011821, 4444.622207112367, 4475.776211189427, 4484.282514797682, 3978.781167035783, 3979.323515002399, 3984.063745019918, 4008.118213992975, 4014.136960553495, 5245.554127899095, 5294.602904782079, 5417.8103766367985, 5429.104197807396, 5429.592780541396, 5655.123455864347, 5681.375048744635, 5691.3170419549915, 5694.487496125285, 5699.886002279931, 5371.194320851903, 5386.218998245233, 5387.111126664056, 5389.326334208224, 5391.16436952273, 4859.101066302675, 4866.635002374836, 4867.756612169448, 4868.196747536616, 4903.043906438282, 5868.2664666916635, 5884.882302353929, 5889.293284805851, 5893.233879595625, 5898.14476900847, 5657.12314591239, 5736.569757268138, 5744.138379243147, 5744.454276843693, 5747.339056008613, 5813.79651712188, 5903.557233207613, 5905.940940590539, 5908.172855800278, 5911.852203694942, 5522.861928451821, 5602.243697101002, 5607.831765047055, 5613.607047506635, 5616.494515493625, 5679.460451257124, 5682.6306290091015, 5686.459786320293, 5690.146478028163, 5697.686627235542, 5432.864178395572, 5476.945230547643, 5481.835544933659, 5529.30883639545, 5559.471850174227, 5562.415946325739, 5619.381867994599, 5619.690916999604, 5658.03813351723, 5671.291088613923, 5598.496135347838, 5609.158626205938, 5616.831495055155, 5617.045102332531, 5620.325560932714, 5351.4648535147735, 5443.945560544502, 5673.290838645169, 5704.458076482728, 5711.114777209539, 5436.483534064258, 5455.072637651688, 5467.562594992471, 5495.560355171657, 5516.3380394351325], "value": 5254.309989388876, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.3698937670057, 571.2687759667625, 581.979630712925, 584.5674201091191, 587.5152998776011, 30004.0, 30629.0, 42318.57681423185, 43055.0, 43155.35266970998, 40298.0, 43992.3401148983, 44015.0, 44131.338029929575, 44156.779216103874, 7609.162992070867, 8767.517786521754, 9008.234300084468, 9018.819623607556, 9028.232600228956, 7697.153313135578, 10346.637867674634, 10571.101456376216, 10572.78854422911, 10855.565777368935, 10591.099756520667, 10609.681709548726, 10640.893591064068, 10668.893311066906, 10677.733056673567, 10331.638392656296, 10337.276390652658, 10342.06921377076, 10399.168066554734, 10415.114715249176, 10401.427921464392, 10464.581416743322, 10473.947630261877, 10474.738131546772, 10480.58077676892, 38281.808590957145, 38611.420828687595, 38895.61104388948, 39044.80477597622, 39052.0, 3652.6898260053126, 3811.0472381904524, 3850.5379354477363, 3850.788206648633, 3854.4603755474254, 26164.73835261642, 28091.71908280932, 28157.718422815713, 28164.295892602644, 28248.293792655142, 4052.0477687743355, 4093.263212621727, 4163.292240319153, 4312.26691462449, 4316.2446571849805, 318880.76228946674, 320355.0, 320732.0, 321373.0, 321525.0, 53356.0, 53544.0, 53826.461735382145, 54061.0, 54215.0, 47885.28172077422, 54178.45821541734, 54449.0, 54565.454345456834, 55592.0, 14427.567172984618, 14755.55733328002, 14852.10887346741, 14867.256637168315, 14876.851231487763, 9921.206303495703, 9989.0, 10469.371837689763, 10636.787264254672, 10639.840402393971, 16890.0, 17247.74128388075, 17354.479365619052, 17372.82627173712, 17425.825741742672, 5642.0, 6838.863222735517, 6941.791746247621, 7031.683574239171, 7105.2894710528535, 896.2202883491404, 910.6767097680361, 912.2428384441031, 941.449252187478, 954.7517645412242, 27825.86087069592, 28454.288642784097, 28491.572626410205, 28929.276768080545, 29063.418731625672, 988.9258305627106, 1096.8793432722393, 1104.718296834302, 1107.9113670906308, 1112.1714322829544, 14875.628109297139, 15612.3755049799, 15792.842071579367, 15888.523344299689, 15903.681926361409, 468822.0, 470066.0, 472746.0, 472945.0, 473339.0, 60625.39374606286, 61200.99999999911, 61239.0, 61269.0, 61273.69363153245, 1350.3450826349408, 1403.2702994442832, 1408.7745960646453, 1413.6677880698028, 1416.4617445370693, 29387.706122938496, 30696.0, 30726.231844204074, 30993.380132397677, 31450.37099258048, 49341.50658493369, 49903.500964989886, 49941.25088123754, 50031.0, 50189.49810501848, 362307.0, 365146.0, 365362.0, 365617.0, 365751.0, 27101.457970840867, 27391.45217095687, 27589.862050690423, 27779.86110069437, 27802.16593502198, 37684.43473347957, 38065.0, 38125.0, 45964.54035459603, 46452.767736161106, 38004.0, 38769.418458722575, 39207.41188882226, 40635.187296253316, 41316.96707582335, 38417.23165536618, 39293.803530982164, 40106.19787604173, 40176.0, 41209.58790412178, 38814.2782725171, 39470.2105957885, 40278.1944361117, 40401.595984039785, 40538.79730601328, 31797.841010794797, 34664.13339666528, 34722.47916281207, 34810.0, 35278.118047048, 26664.333391665365, 26749.331266718487, 26950.460990780466, 27047.594286085332, 27433.45133097367], "value": 19254.12679242998, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.20224438778297, 416.25905887520224, 419.7775179155048, 422.8604560495037, 440.7069298916221, 13598.252096134709, 15066.246687665627, 19648.21407143714, 20238.696419553682, 20395.388138355873, 18796.812031879675, 19076.809231907675, 19378.12798424071, 19970.500737481532, 20495.69256461154, 5734.79928202513, 5766.365699773021, 5872.647641141545, 5930.0, 5996.580239383245, 3770.340190466671, 3906.5312162540536, 5811.970940145294, 5900.940990590082, 5904.852378690545, 6161.4146656067605, 6366.6180029198395, 6390.169277993878, 6501.382368674968, 6504.284528701839, 6346.460550853183, 6377.489800815923, 6409.647469389181, 6434.485241180694, 6477.157969463963, 5750.568707346965, 5757.942420575782, 5761.625494342854, 5761.740721667535, 5767.567432442584, 23598.64602030971, 24247.757522424727, 24261.0, 24475.26574202777, 24509.754902451103, 3207.182168547029, 3215.2765627733806, 3219.195201199677, 3226.4515032444306, 3270.1824543864036, 14324.355404006845, 14807.33366998477, 14821.703565928728, 15168.469103581432, 15420.922895385564, 1886.4906475251605, 1904.5905130397032, 1991.5618563915916, 2026.695995600657, 2038.7961203879643, 93970.0, 94034.0, 94191.29043547795, 96426.0, 97973.0, 11803.645890623295, 11953.760924781456, 11962.40187990597, 12415.255084694947, 12416.875831241752, 17754.28982840672, 17776.55558611045, 17778.177691796325, 17782.733259001125, 17785.822141778415, 7438.814029649194, 7760.611969401507, 7768.106667733283, 7815.882761758578, 8148.348132149414, 7099.2545782693105, 7153.105861767279, 7277.526960747535, 7290.198078211392, 7309.561426314332, 5236.769359200584, 5328.520433161034, 5329.626926115135, 5349.384820745586, 5431.646942948696, 2176.5102851858205, 2194.3307291276315, 2196.3191410662744, 2243.8541494802785, 2254.8308876834303, 467.67496589870393, 468.5104066250776, 471.27423767398506, 842.2209456252941, 885.0662551008747, 11717.824232636518, 12362.44369003397, 12379.69050773738, 12816.0, 18167.36414225496, 978.1490103609905, 981.6564202529057, 987.0228473810876, 995.5918073589794, 997.9301448898508, 10204.795904081877, 10819.51456358789, 10859.565617375216, 10896.727581810519, 10910.563577456971, 623743.0, 625530.0, 636659.0, 655562.0, 667844.0, 74594.62702686561, 78750.0, 92534.53732731294, 94180.52909735407, 100869.49565252126, 1054.651964851597, 1108.3239224073309, 1134.2740645986576, 1135.4720055174384, 1142.9371384573762, 17714.822851771834, 17751.73372399441, 18425.0, 18427.63144737071, 18583.81416185875, 39945.41582940915, 44897.775511122236, 44911.77544112258, 45323.09353812971, 46016.7699161502, 58568.414315856295, 60435.697821510614, 61838.69080654748, 62773.37226627858, 62820.0, 6153.323134455117, 6771.966140169267, 8013.799655008672, 8382.664693412195, 8460.830783384421, 11184.496697648789, 12375.443105060114, 12482.563110291096, 12484.313362765135, 13480.629842539365, 11001.669949901516, 11204.215704900578, 11219.0, 11233.831492527783, 11761.176717629683, 10742.677719668422, 10952.507137179005, 10959.0, 10988.175886808362, 11454.656360309204, 10846.457677115955, 11007.944960275147, 11026.173037022096, 11159.218854680095, 11671.76656466883, 8135.593220339078, 8329.791755205926, 8348.582570871553, 8440.198181172778, 8675.566221688765, 9696.854547181656, 10155.492225388849, 10423.583056677951, 10503.94748026255, 10928.836067458835], "value": 9381.267577935354, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.9200893950829, 1453.3096779029959, 1453.985460145399, 1463.217178809337, 1471.3011319623174, 8100.351971842253, 8552.486850788957, 8555.87166192506, 8567.357448191387, 8572.27135693466, 8434.746957591267, 8577.0, 8648.437851539646, 8650.653973841054, 8788.69239576615, 2230.342049095521, 2265.422317309084, 2267.591833469983, 2267.6031694453486, 2270.4437412833877, 2253.9436514087115, 2295.162265772989, 2303.8272129590264, 2304.3087073877855, 2307.1117619716447, 2257.446925503254, 2259.412552736292, 2272.261515007629, 2279.8632082075046, 2282.897269622871, 2026.6554685703466, 2037.3989673046412, 2068.069368784053, 2073.2225415469275, 2206.922757703481, 2169.945751356213, 2229.5429436965546, 2232.542328822604, 2232.720909886264, 2233.832462565314, 8341.41610087294, 8357.414980951336, 8420.28427583656, 8421.410501264914, 8451.45065570736, 5037.596992240612, 5165.225216217597, 5192.1952097424955, 5197.454267301954, 5232.058229518685, 3077.661457239702, 3160.8419579020956, 3265.4122257993554, 3312.834358282076, 3326.06870076379, 1378.8552202018743, 1393.4913756478913, 1397.2385050147693, 1439.7336492748875, 1520.7414739494313, 10327.741806454824, 10546.36721796687, 10985.780284394268, 11689.415529223505, 11714.882851171464, 4363.890902727394, 4382.824687012484, 4528.841490547815, 4536.546345365437, 4537.228671125917, 9555.474448905237, 9560.235181185488, 9575.473348965874, 9578.233741300679, 9586.616535338648, 4595.471520775087, 4730.101280756645, 5054.064997975386, 5184.507471790174, 5241.397239317527, 4731.219348807477, 4780.880477988078, 4782.689125206851, 4784.330193772875, 4805.8077676892535, 3663.743537952371, 3686.8939318204966, 3723.162288485069, 3754.6808521276, 3761.962380376161, 1126.414264582429, 1127.2954403497813, 1131.801934661431, 1135.7728454309172, 1136.3749937534324, 883.6862913665556, 947.308464820671, 961.423146112327, 969.6363863551169, 992.3698451483216, 5595.38450770415, 5789.652620842763, 5796.855078623068, 5865.944130056546, 6079.240094988127, 1002.4937406609615, 1002.7593377589326, 1013.8377859542438, 1023.97440063999, 1031.8761748590218, 4015.437838702584, 4039.636432721069, 4056.6957478189256, 4094.0, 4112.629863312256, 10123.797524049478, 10373.170146388271, 10424.478776061167, 10458.790824183474, 10482.47587620616, 10096.495175241209, 10168.135708464863, 10239.18086553074, 10386.42874641902, 10417.322874013165, 6968.23349431552, 7772.261635144765, 7972.880406793903, 7984.920150798418, 7986.0, 5419.945800542102, 5873.618214816023, 5894.734736936934, 6032.849178770566, 6123.969380153071, 8943.642254309754, 9312.72061838146, 9313.580888859882, 9333.113354231336, 9363.531823408939, 9378.531073446436, 9522.714318570454, 9566.330356874952, 9567.61729530811, 9624.615015399586, 7019.508634395544, 7419.406447484296, 7552.39580833521, 7568.5458872467825, 7582.317591416799, 7982.8802567960365, 8155.673773049011, 8262.876056859031, 8264.917350826414, 8273.214044665747, 7123.358897699232, 7256.092988376453, 7290.599017054113, 7317.487775855852, 7431.0, 7382.926170738224, 7385.291327575145, 7411.888821667787, 7493.40052795786, 7645.0, 6183.443490085914, 6234.064890266496, 6285.622862628074, 6286.088517164894, 6287.308396076336, 4898.167311556973, 4919.901601968012, 4964.528369804862, 5070.2141168119, 5086.3896332440345, 4860.343853579863, 4937.580305674058, 4984.451710311935, 5213.40045894727, 5281.735913204401], "value": 4479.360625441815, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.75314175498556, 392.48192386050414, 393.1645253835599, 399.61636828644515, 402.85899935022746, 5163.3029541012, 5288.0217159825415, 5300.860315032267, 5302.666826596304, 5336.9733151334285, 5011.348524691794, 5021.849344519661, 5153.1754919212835, 5282.445343238962, 5295.973520132394, 4048.554658987509, 4063.2889244382263, 4122.299209134454, 4149.83400663973, 4163.791810409482, 4164.479440069991, 4169.708120431571, 4178.352355384905, 4182.163567286555, 4216.494020717503, 4032.9395059074136, 4205.453291072156, 4211.789410529476, 4216.746995180299, 4218.535961044283, 4026.3960405939197, 4063.6139566741113, 4080.89797755057, 4169.687273454503, 4237.343211802176, 3776.282506323817, 3788.522476234271, 3790.639889210521, 3794.7912864792424, 3799.67702745267, 5129.9230511542355, 5188.507091826308, 5197.194434862602, 5222.232216925036, 5241.659292146036, 4711.199096153662, 4816.158466504779, 4846.39420072491, 4865.805367785284, 4868.561829435333, 5552.750126244328, 5569.303837020372, 5572.60991730579, 5573.777048918038, 5606.55147588192, 4236.173946080516, 4239.957600423987, 4241.87274381769, 4269.146170765828, 4272.6154646082, 5567.554595632339, 5698.318995896179, 5732.398098199671, 5756.762296106357, 5775.451332123442, 4305.48334199898, 4308.18144552534, 4312.784360781949, 4313.97843010783, 4346.261135606955, 4400.92177416535, 4420.469543654782, 4421.823127074946, 4423.0, 4428.734275943454, 4757.976210118927, 4800.903981920342, 4841.467438581753, 4849.878753031202, 4852.374454557763, 5581.46509709833, 5586.52514536269, 5590.860228494239, 5606.635568688022, 5609.943900560942, 1454.789055586955, 1464.992675036618, 1479.2529772464836, 1481.4962912609765, 1483.3325003748357, 908.5775114571755, 912.2747415804319, 957.3107362698846, 971.7279161834698, 1074.6077681646143, 5137.974310128426, 5213.191955246943, 5369.48989845964, 5369.838904832861, 5380.3274590676165, 5678.744456499468, 5712.0, 5735.311762588516, 5743.514943229206, 5795.1886735857015, 5110.207917772751, 5299.39057008449, 5323.733813309319, 5344.812931547377, 5353.9196912046355, 2922.8976985805393, 2931.5960912052337, 2948.5282354823125, 2972.0, 2989.910302690923, 5735.2257445245195, 5753.798617048467, 5766.163906233573, 5778.942210577925, 5781.485054001523, 5485.396606373296, 5618.634788738719, 5671.100181439181, 5675.120356344773, 5682.437329734274, 5712.228849105484, 5720.227769251181, 5725.77096916127, 5745.195672605839, 5750.88498230033, 5253.947460525499, 5496.7526461310135, 5536.114221724505, 5548.278723765885, 5559.997601295256, 5463.322971743737, 5496.642718223303, 5549.916751248654, 5564.916526252028, 5575.553955683617, 5595.860103497445, 5694.743736531949, 5715.114012375823, 5721.942780572141, 5749.384030266302, 4068.105016896278, 4178.394132850781, 4204.552267140915, 4353.390525326394, 4386.71486353386, 5689.914651280152, 5693.8861222774485, 5723.542116630576, 5726.799562015476, 5732.541396688338, 5559.805406810742, 5563.7774489019985, 5585.553155747449, 5586.581006424616, 5587.664740115606, 5450.792429066235, 5568.053430916673, 5568.693721845338, 5572.442755724395, 5597.3003374578175, 5551.167324901297, 5551.833444996657, 5571.7492712828835, 5578.246936663661, 5590.329160500766, 5397.59518036141, 5489.313835770528, 5522.2544956430365, 5604.8879022418505, 5613.186088017296, 5457.508824205841, 5480.657238976476, 5485.780568777204, 5490.478404551562, 5503.559715222853], "value": 4287.575658914858, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.6698718589448, 743.0526079248957, 776.8912352270684, 833.41244422682, 847.1655419411878, 13777.448902043907, 14901.627459313495, 14911.179885106341, 15009.399624015039, 15030.77453838192, 14679.486217982372, 14907.32917018734, 14956.25218739064, 14979.925100374483, 15014.774778378332, 746.723712226477, 758.1205801270527, 761.029687148884, 771.2326235395789, 772.9294926526773, 761.1665226576889, 762.8512440074188, 763.3664058831184, 765.5712800831525, 766.7508059880533, 796.8286818334057, 798.5927177139672, 801.2228138705475, 801.3989507869098, 802.6187560908551, 791.8812178173263, 793.4604468961134, 796.5539297993114, 798.4530596541359, 799.312591171592, 584.3484514766047, 584.5849446892711, 586.0184191479256, 586.14130299112, 586.4311617730795, 15392.692146157015, 15601.765973510293, 15629.296681649354, 16082.678346433122, 16277.837221627751, 14000.439982400692, 14437.855621443861, 14450.132992020512, 14464.493742718954, 14511.492097776632, 11905.0, 11905.28568285897, 11917.463714132884, 12264.448099835528, 12359.0, 3564.180238545149, 3582.8208589570677, 3594.730395220369, 3653.853845846163, 3654.524911761454, 72788.27211727868, 73005.63497182533, 73216.0, 74146.62926685387, 75721.62139189323, 10522.894771052344, 11068.0, 11095.889041109647, 11226.438678066064, 11395.202335836411, 20280.08739606721, 20539.691904621443, 20547.58904821925, 20557.897210513853, 20616.278430254868, 7058.400035996998, 7183.5330703504105, 7260.636968151572, 7381.261873812576, 7467.439942004263, 3774.2640185163627, 3887.5723670396233, 3917.6474117329576, 3975.2447035063824, 3987.063040185554, 3531.1172206948263, 3653.451982202691, 3708.2027364116843, 3714.591394946554, 3740.738148329591, 568.9886202276014, 573.9282589676291, 574.4800955135609, 582.452494655023, 582.9708514574339, 703.2756261051126, 711.9537230080028, 734.6473692627569, 750.0, 750.440921513465, 9632.518374081268, 9814.0, 10006.299559030944, 10132.138768204784, 10371.066604005675, 715.3168723868692, 727.956085257898, 738.5900825042046, 740.1820987808502, 750.7297372945735, 4764.904701905943, 4943.950560494421, 5032.496750324938, 5032.823851165192, 5043.899122017539, 70231.2976870235, 73610.63194683992, 74499.25500745031, 74772.25227747762, 77169.22830771733, 66596.33403665999, 66630.19040608019, 67546.0, 68653.65673171703, 69388.65305673439, 50525.74737126364, 53050.469495305326, 60661.56437930214, 61700.38299617036, 61704.0, 9245.815083698153, 9620.470874101991, 9716.222702183666, 9735.464549449565, 9736.951315243661, 35311.64688353187, 35691.0, 37799.24401512009, 39721.0, 41111.0, 43745.56254437415, 50421.0, 50445.24332134947, 53292.73353633207, 55457.1681424787, 12613.49546018149, 12801.679958001125, 12839.679008024874, 13015.804762928754, 13269.46922123143, 13200.867991319963, 13411.731765364442, 13564.118332308368, 13588.116772409761, 13751.449942002208, 12805.551805686757, 12924.338642814575, 12934.482620695444, 13015.0, 13596.86403135956, 14231.288435578386, 14248.430062797786, 14395.784063239269, 14767.92616036913, 15041.323140458488, 12628.936855315664, 12758.808617870554, 12794.232346059267, 13310.866891330963, 13340.599782006555, 10054.245931555017, 10122.8481572775, 10265.281430299807, 10482.21383396233, 10689.412082335235, 10096.878149038619, 10102.545385457819, 10220.488975551341, 10224.846627300447, 10227.28409011362], "value": 6980.511290503888, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 111.0, 111.0, 112.0, 111.0, 113.0, 112.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 126.0, 121.0, 160.0, 128.0, 129.0, 119.0, 120.0, 144.0, 120.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 162.0, 161.0, 162.0, 162.0, 163.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 85.0, 77.0, 109.0, 77.0, 77.0, 76.0, 77.0, 98.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 110.0, 83.0, 82.0, 83.0, 103.0, 83.0, 82.0, 108.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 119.0, 117.0, 119.0, 117.0, 118.0, 119.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 62.0, 54.0, 53.0, 55.0, 53.0, 54.0, 55.0, 54.0, 57.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 83.0, 84.0, 83.0, 82.0, 83.0, 87.0, 85.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 134.0, 137.0, 129.0, 129.0, 126.0, 132.0, 135.0, 169.0, 139.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 168.0, 168.0, 169.0, 169.0, 170.0, 167.0, 168.0, 169.0, 169.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 64.0, 63.0, 66.0, 63.0, 62.0, 63.0, 67.0], "value": 63.8, "unit": "score"}]}]} 03:51:43 INFO - Return code: 0 03:51:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:51:43 ERROR - # TBPL SUCCESS # 03:51:43 INFO - Running post-action listener: _resource_record_post_action 03:51:43 INFO - [mozharness: 2017-02-08 11:51:43.352582Z] Finished run-tests step (success) 03:51:43 INFO - Running post-run listener: _resource_record_post_run 03:51:43 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 404320256; Read time: 0; Write time: 250988 03:51:43 INFO - TinderboxPrint: CPU usage
13.1% 03:51:43 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:51:43 INFO - TinderboxPrint: I/O write bytes / time
404,320,256 / 250,988 03:51:43 INFO - TinderboxPrint: CPU idle
8,290.7 (86.9%) 03:51:43 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 03:51:43 INFO - TinderboxPrint: Swap in / out
0 / 0 03:51:43 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107442176; Read time: 0; Write time: 92340 03:51:43 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 296878080; Read time: 0; Write time: 158648 03:51:43 INFO - Running post-run listener: _upload_blobber_files 03:51:43 INFO - Blob upload gear active. 03:51:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:43 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 03:51:43 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'] 03:51:43 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 03:51:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:51:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:45 INFO - (blobuploader) - INFO - Done attempting. 03:51:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:51:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:51:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:46 INFO - (blobuploader) - INFO - Done attempting. 03:51:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:51:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:51:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:49 INFO - (blobuploader) - INFO - Done attempting. 03:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:51:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:51:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:50 INFO - (blobuploader) - INFO - Done attempting. 03:51:50 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:50 INFO - Return code: 0 03:51:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:50 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4146e983388ab0bff570ad63c7cd364a3f6824ca88c5eab03d03d1528647d34854b2fb0d26a0529ccc7c5a4664bc377e51f9c7e3d921e93854f1eceae9bb3580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fa37feba787dcf8e364d7158bd994c700b826ad82c1b74a31b9fea2df2c17c447259b6f1afe92abbbe69339bd0df0f0e967851fc3fa0d594cab4da76a46cc1d", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/346a8fa135532b977f53dd516e4845f6332ff5c093fbcf33d8b52a0e1009de5ac3203064b4b36fa5e7fcce5d7f962a07f7018853b922f0306b230428d7ce3810", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd6c8a629ea72012de1c40583db3351116f6c5bb27e507382af31de5c0ccd6652d696ffdfb93f787126a5327a2ca99f110bc32f494645e624f53dd8a0c4f1c92"} 03:51:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:50 INFO - Contents: 03:51:50 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4146e983388ab0bff570ad63c7cd364a3f6824ca88c5eab03d03d1528647d34854b2fb0d26a0529ccc7c5a4664bc377e51f9c7e3d921e93854f1eceae9bb3580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fa37feba787dcf8e364d7158bd994c700b826ad82c1b74a31b9fea2df2c17c447259b6f1afe92abbbe69339bd0df0f0e967851fc3fa0d594cab4da76a46cc1d", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/346a8fa135532b977f53dd516e4845f6332ff5c093fbcf33d8b52a0e1009de5ac3203064b4b36fa5e7fcce5d7f962a07f7018853b922f0306b230428d7ce3810", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd6c8a629ea72012de1c40583db3351116f6c5bb27e507382af31de5c0ccd6652d696ffdfb93f787126a5327a2ca99f110bc32f494645e624f53dd8a0c4f1c92"} 03:51:50 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:50 INFO - Copying logs to upload dir... 03:51:50 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.888857 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-02-08 03:51:49.841328) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 03:51:49.844991) ========= 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=6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4146e983388ab0bff570ad63c7cd364a3f6824ca88c5eab03d03d1528647d34854b2fb0d26a0529ccc7c5a4664bc377e51f9c7e3d921e93854f1eceae9bb3580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fa37feba787dcf8e364d7158bd994c700b826ad82c1b74a31b9fea2df2c17c447259b6f1afe92abbbe69339bd0df0f0e967851fc3fa0d594cab4da76a46cc1d", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/346a8fa135532b977f53dd516e4845f6332ff5c093fbcf33d8b52a0e1009de5ac3203064b4b36fa5e7fcce5d7f962a07f7018853b922f0306b230428d7ce3810", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd6c8a629ea72012de1c40583db3351116f6c5bb27e507382af31de5c0ccd6652d696ffdfb93f787126a5327a2ca99f110bc32f494645e624f53dd8a0c4f1c92"} build_url:https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/F7iMQljFSE6hwngBJ9Fh2Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4146e983388ab0bff570ad63c7cd364a3f6824ca88c5eab03d03d1528647d34854b2fb0d26a0529ccc7c5a4664bc377e51f9c7e3d921e93854f1eceae9bb3580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fa37feba787dcf8e364d7158bd994c700b826ad82c1b74a31b9fea2df2c17c447259b6f1afe92abbbe69339bd0df0f0e967851fc3fa0d594cab4da76a46cc1d", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/346a8fa135532b977f53dd516e4845f6332ff5c093fbcf33d8b52a0e1009de5ac3203064b4b36fa5e7fcce5d7f962a07f7018853b922f0306b230428d7ce3810", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd6c8a629ea72012de1c40583db3351116f6c5bb27e507382af31de5c0ccd6652d696ffdfb93f787126a5327a2ca99f110bc32f494645e624f53dd8a0c4f1c92"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 03:51:49.869731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 03:51:49.870053) ========= 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=6dbc10da6d83fee962c624be000001a8-1486553466.590094-452826086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 03:51:49.953695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 03:51:49.954015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 03:51:49.954303) ========= ========= Total master_lag: 0.16 =========