builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1491755901.8 results: success (0) revision: c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:21.799345) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:21.799790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:21.800065) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:21.815732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:21.816016) ========= 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=df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-09 09:38:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.5M=0s 2017-04-09 09:38:22 (40.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116413 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:21.946182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:21.946520) ========= 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=df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018172 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:21.995833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:21.996176) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba --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 c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba --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=df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-09 09:38:22,315 truncating revision to first 12 chars 2017-04-09 09:38:22,315 Setting DEBUG logging. 2017-04-09 09:38:22,315 attempt 1/10 2017-04-09 09:38:22,315 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c6dd79ff61be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-09 09:38:22,788 unpacking tar archive at: mozilla-central-c6dd79ff61be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.772535 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:22.782095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:22.782410) ========= script_repo_revision: c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:22.782769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:22.783032) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 09:38:22.791335) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-04-09 09:38:22.791640) ========= /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=df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:38:23 INFO - MultiFileLogger online at 20170409 09:38:23 in /builds/slave/test 09:38:23 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 09:38:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:38:23 INFO - {'append_to_log': False, 09:38:23 INFO - 'base_work_dir': '/builds/slave/test', 09:38:23 INFO - 'blob_upload_branch': 'Firefox', 09:38:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:38:23 INFO - 'branch': 'Firefox', 09:38:23 INFO - 'buildbot_json_path': 'buildprops.json', 09:38:23 INFO - 'config_files': ('talos/linux_config.py',), 09:38:23 INFO - 'default_actions': ('clobber', 09:38:23 INFO - 'read-buildbot-config', 09:38:23 INFO - 'download-and-extract', 09:38:23 INFO - 'populate-webroot', 09:38:23 INFO - 'create-virtualenv', 09:38:23 INFO - 'install', 09:38:23 INFO - 'run-tests'), 09:38:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:38:23 INFO - 'download_minidump_stackwalk': True, 09:38:23 INFO - 'download_symbols': 'ondemand', 09:38:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:38:23 INFO - 'tooltool.py': '/tools/tooltool.py', 09:38:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:38:23 INFO - '/tools/misc-python/virtualenv.py')}, 09:38:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:38:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:38:23 INFO - 'gecko_profile': False, 09:38:23 INFO - 'gecko_profile_interval': 0, 09:38:23 INFO - 'installer_path': 'installer.exe', 09:38:23 INFO - 'log_level': 'info', 09:38:23 INFO - 'log_name': 'talos', 09:38:23 INFO - 'log_to_console': True, 09:38:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:38:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:38:23 INFO - 'opt_config_files': (), 09:38:23 INFO - 'pip_index': False, 09:38:23 INFO - 'suite': 'dromaeojs', 09:38:23 INFO - 'system_bits': '32', 09:38:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:38:23 INFO - 'title': 'talos-linux64-ix-021', 09:38:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:38:23 INFO - 'use_talos_json': True, 09:38:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:38:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:38:23 INFO - 'work_dir': 'build'} 09:38:23 INFO - [mozharness: 2017-04-09 16:38:23.206978Z] Running clobber step. 09:38:23 INFO - Running pre-action listener: _resource_record_pre_action 09:38:23 INFO - Running main action method: clobber 09:38:23 INFO - rmtree: /builds/slave/test/build 09:38:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:38:24 INFO - Running post-action listener: _resource_record_post_action 09:38:24 INFO - [mozharness: 2017-04-09 16:38:24.388200Z] Finished clobber step (success) 09:38:24 INFO - [mozharness: 2017-04-09 16:38:24.388300Z] Running read-buildbot-config step. 09:38:24 INFO - Running pre-action listener: _resource_record_pre_action 09:38:24 INFO - Running main action method: read_buildbot_config 09:38:24 INFO - Using buildbot properties: 09:38:24 INFO - { 09:38:24 INFO - "project": "", 09:38:24 INFO - "product": "firefox", 09:38:24 INFO - "who": "ffxbld@noreply.mozilla.org", 09:38:24 INFO - "installer_path": "public/build/target.tar.bz2", 09:38:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:38:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:38:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 09:38:24 INFO - "stage_platform": "linux64-pgo", 09:38:24 INFO - "basedir": "/builds/slave/test", 09:38:24 INFO - "buildnumber": 123, 09:38:24 INFO - "platform": "ubuntu64_hw", 09:38:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:38:24 INFO - "slavebuilddir": "test", 09:38:24 INFO - "taskId": "F2949A2eSB2MFU7DCoZElw", 09:38:24 INFO - "branch": "mozilla-central", 09:38:24 INFO - "script_repo_revision": "production", 09:38:24 INFO - "revision": "c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba", 09:38:24 INFO - "slavename": "talos-linux64-ix-021", 09:38:24 INFO - "repo_path": "mozilla-central" 09:38:24 INFO - } 09:38:24 INFO - Finding installer, test and symbols from parent task. 09:38:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F2949A2eSB2MFU7DCoZElw'}, attempt #1 09:38:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F2949A2eSB2MFU7DCoZElw'}, attempt #1 09:38:25 INFO - Task dependencies: Owjaf1i2T5e8qb5tE98_Bg 09:38:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg'}, attempt #1 09:38:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.tar.bz2 09:38:25 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/test_packages.json 09:38:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.crashreporter-symbols.zip 09:38:25 INFO - Running post-action listener: _resource_record_post_action 09:38:25 INFO - [mozharness: 2017-04-09 16:38:25.743926Z] Finished read-buildbot-config step (success) 09:38:25 INFO - [mozharness: 2017-04-09 16:38:25.744143Z] Running download-and-extract step. 09:38:25 INFO - Running pre-action listener: _resource_record_pre_action 09:38:25 INFO - Running main action method: download_and_extract 09:38:25 INFO - mkdir: /builds/slave/test/build/tests 09:38:25 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')]} 09:38:25 INFO - trying https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.test_packages.json 09:38:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:38:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:38:26 INFO - Downloaded 986 bytes. 09:38:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:38:26 INFO - Using the following test package requirements: 09:38:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:38:26 INFO - u'common': [u'target.common.tests.zip'], 09:38:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:38:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:38:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:38:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:38:26 INFO - u'mozbase': [u'target.common.tests.zip'], 09:38:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:38:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:38:26 INFO - u'web-platform': [u'target.common.tests.zip', 09:38:26 INFO - u'target.web-platform.tests.zip'], 09:38:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:38:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:38:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.common.tests.zip 09:38:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:38:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.common.tests.zip into memory 09:38:27 INFO - Expected file size: 60367361 09:38:27 INFO - Obtained file size: 60367361 09:38:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:38:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.common.tests.zip 09:38:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:38:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.common.tests.zip into memory 09:38:38 INFO - Expected file size: 60367361 09:38:38 INFO - Obtained file size: 60367361 09:38:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.talos.tests.zip 09:38:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:38:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.talos.tests.zip into memory 09:38:50 INFO - Expected file size: 14404129 09:38:50 INFO - Obtained file size: 14404129 09:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:50 INFO - trying https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.tar.bz2 09:38:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:38:51 INFO - Downloaded 63245961 bytes. 09:38:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.tar.bz2 09:38:51 INFO - mkdir: /builds/slave/test/properties 09:38:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:38:51 INFO - Writing to file /builds/slave/test/properties/build_url 09:38:51 INFO - Contents: 09:38:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.tar.bz2 09:38:51 INFO - Running post-action listener: _resource_record_post_action 09:38:51 INFO - Running post-action listener: set_extra_try_arguments 09:38:51 INFO - [mozharness: 2017-04-09 16:38:51.823064Z] Finished download-and-extract step (success) 09:38:51 INFO - [mozharness: 2017-04-09 16:38:51.823160Z] Running populate-webroot step. 09:38:51 INFO - Running pre-action listener: _resource_record_pre_action 09:38:51 INFO - Running main action method: populate_webroot 09:38:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:38:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:38:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:38:51 INFO - '--tppagecycles', 09:38:51 INFO - '7'], 09:38:51 INFO - 'tests': ['tsvgm']}}, 09:38:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:38:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:38:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:38:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:38:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:38:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:38:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:38:51 INFO - 'talos_options': ['--disable-e10s'], 09:38:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:38:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:38:51 INFO - 'talos_options': ['--disable-e10s'], 09:38:51 INFO - 'tests': ['damp', 'tps']}, 09:38:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:38:51 INFO - 'tests': ['damp', 'tps']}, 09:38:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:38:51 INFO - 'tests': ['dromaeo_dom']}, 09:38:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:38:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:38:51 INFO - 'tests': ['basic_compositor_video']}, 09:38:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:38:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:38:51 INFO - 'tests': ['a11yr', 09:38:51 INFO - 'ts_paint', 09:38:51 INFO - 'tpaint', 09:38:51 INFO - 'sessionrestore', 09:38:51 INFO - 'sessionrestore_no_auto_restore', 09:38:51 INFO - 'tabpaint']}, 09:38:51 INFO - 'other-e10s': {'tests': ['a11yr', 09:38:51 INFO - 'ts_paint', 09:38:51 INFO - 'tpaint', 09:38:51 INFO - 'sessionrestore', 09:38:51 INFO - 'sessionrestore_no_auto_restore', 09:38:51 INFO - 'tabpaint']}, 09:38:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:38:51 INFO - 'ts_paint', 09:38:51 INFO - 'tpaint', 09:38:51 INFO - 'sessionrestore', 09:38:51 INFO - 'sessionrestore_no_auto_restore', 09:38:51 INFO - 'tabpaint']}, 09:38:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:38:51 INFO - 'ts_paint', 09:38:51 INFO - 'tpaint', 09:38:51 INFO - 'sessionrestore', 09:38:51 INFO - 'sessionrestore_no_auto_restore', 09:38:51 INFO - 'tabpaint']}, 09:38:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:38:51 INFO - 'tests': ['a11yr', 09:38:51 INFO - 'ts_paint', 09:38:51 INFO - 'tpaint', 09:38:51 INFO - 'sessionrestore', 09:38:51 INFO - 'sessionrestore_no_auto_restore', 09:38:51 INFO - 'tabpaint']}, 09:38:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:38:51 INFO - 'tests': ['a11yr', 09:38:51 INFO - 'ts_paint', 09:38:51 INFO - 'tpaint', 09:38:51 INFO - 'sessionrestore', 09:38:51 INFO - 'sessionrestore_no_auto_restore', 09:38:51 INFO - 'tabpaint']}, 09:38:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:38:51 INFO - 'tests': ['tsvgx', 09:38:51 INFO - 'tsvgr_opacity', 09:38:51 INFO - 'tart', 09:38:51 INFO - 'tscrollx', 09:38:51 INFO - 'cart', 09:38:51 INFO - 'tsvg_static']}, 09:38:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:38:51 INFO - 'tsvgr_opacity', 09:38:51 INFO - 'tart', 09:38:51 INFO - 'tscrollx', 09:38:51 INFO - 'cart', 09:38:51 INFO - 'tsvg_static']}, 09:38:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:38:51 INFO - 'talos_options': ['--disable-e10s'], 09:38:51 INFO - 'tests': ['tp5o']}, 09:38:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:38:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:38:51 INFO - 'talos_options': ['--disable-e10s', 09:38:51 INFO - '--xperf_path', 09:38:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:51 INFO - 'tests': ['tp5n']}, 09:38:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:38:51 INFO - 'talos_options': ['--xperf_path', 09:38:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:51 INFO - 'tests': ['tp5n']}}, 09:38:51 INFO - 'talos.zip': {'path': '', 09:38:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:38:51 INFO - Running post-action listener: _resource_record_post_action 09:38:51 INFO - [mozharness: 2017-04-09 16:38:51.836244Z] Finished populate-webroot step (success) 09:38:51 INFO - [mozharness: 2017-04-09 16:38:51.836334Z] Running create-virtualenv step. 09:38:51 INFO - Running pre-action listener: _resource_record_pre_action 09:38:51 INFO - Running main action method: create_virtualenv 09:38:51 INFO - Creating virtualenv /builds/slave/test/build/venv 09:38:51 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 09:38:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:38:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:38:51 INFO - Using real prefix '/usr' 09:38:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:38:52 INFO - Installing distribute.............................................................................................................................................................................................done. 09:38:54 INFO - Installing pip.................done. 09:38:54 INFO - Return code: 0 09:38:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:38:54 INFO - Reading from file tmpfile_stdout 09:38:54 INFO - Output received: 09:38:54 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) 09:38:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:54 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 0x17131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ae400>, '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 0x19af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af840>, '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': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', '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 09:38:54 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 09:38:54 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 09:38:54 INFO - Using env: {'DISPLAY': ':0', 09:38:54 INFO - 'HOME': '/home/cltbld', 09:38:54 INFO - 'LANG': 'en_US.UTF-8', 09:38:54 INFO - 'LANGUAGE': 'en_US:en', 09:38:54 INFO - 'LOGNAME': 'cltbld', 09:38:54 INFO - 'MAIL': '/var/mail/cltbld', 09:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:54 INFO - 'MOZ_NO_REMOTE': '1', 09:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:54 INFO - 'NO_EM_RESTART': '1', 09:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:54 INFO - 'PWD': '/builds/slave/test', 09:38:54 INFO - 'SHELL': '/bin/bash', 09:38:54 INFO - 'SHLVL': '1', 09:38:54 INFO - 'TERM': 'linux', 09:38:54 INFO - 'TMOUT': '86400', 09:38:54 INFO - 'USER': 'cltbld', 09:38:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', 09:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:54 INFO - '_': '/tools/buildbot/bin/python'} 09:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:54 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 09:38:54 INFO - Cleaning up... 09:38:54 INFO - Return code: 0 09:38:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:54 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 0x17131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ae400>, '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 0x19af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af840>, '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': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', '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 09:38:54 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 09:38:54 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 09:38:54 INFO - Using env: {'DISPLAY': ':0', 09:38:54 INFO - 'HOME': '/home/cltbld', 09:38:54 INFO - 'LANG': 'en_US.UTF-8', 09:38:54 INFO - 'LANGUAGE': 'en_US:en', 09:38:54 INFO - 'LOGNAME': 'cltbld', 09:38:54 INFO - 'MAIL': '/var/mail/cltbld', 09:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:54 INFO - 'MOZ_NO_REMOTE': '1', 09:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:54 INFO - 'NO_EM_RESTART': '1', 09:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:54 INFO - 'PWD': '/builds/slave/test', 09:38:54 INFO - 'SHELL': '/bin/bash', 09:38:54 INFO - 'SHLVL': '1', 09:38:54 INFO - 'TERM': 'linux', 09:38:54 INFO - 'TMOUT': '86400', 09:38:54 INFO - 'USER': 'cltbld', 09:38:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', 09:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:54 INFO - '_': '/tools/buildbot/bin/python'} 09:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:55 INFO - Downloading/unpacking psutil>=3.1.1 09:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:38:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:38:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:38:57 INFO - Installing collected packages: psutil 09:38:57 INFO - Running setup.py install for psutil 09:38:57 INFO - building 'psutil._psutil_linux' extension 09:38:57 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 09:38:57 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 09:38:57 INFO - building 'psutil._psutil_posix' extension 09:38:57 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 09:38:57 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 09:38:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:38:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:38:57 INFO - Successfully installed psutil 09:38:57 INFO - Cleaning up... 09:38:57 INFO - Return code: 0 09:38:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ae400>, '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 0x19af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af840>, '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': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', '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 09:38:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:38:57 INFO - Using env: {'DISPLAY': ':0', 09:38:57 INFO - 'HOME': '/home/cltbld', 09:38:57 INFO - 'LANG': 'en_US.UTF-8', 09:38:57 INFO - 'LANGUAGE': 'en_US:en', 09:38:57 INFO - 'LOGNAME': 'cltbld', 09:38:57 INFO - 'MAIL': '/var/mail/cltbld', 09:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:57 INFO - 'MOZ_NO_REMOTE': '1', 09:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:57 INFO - 'NO_EM_RESTART': '1', 09:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:57 INFO - 'PWD': '/builds/slave/test', 09:38:57 INFO - 'SHELL': '/bin/bash', 09:38:57 INFO - 'SHLVL': '1', 09:38:57 INFO - 'TERM': 'linux', 09:38:57 INFO - 'TMOUT': '86400', 09:38:57 INFO - 'USER': 'cltbld', 09:38:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', 09:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:57 INFO - '_': '/tools/buildbot/bin/python'} 09:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:38:57 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 09:38:57 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 09:38:57 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 09:38:57 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 09:38:57 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 09:38:57 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 09:38:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:39:00 INFO - Installing collected packages: mozsystemmonitor 09:39:00 INFO - Running setup.py install for mozsystemmonitor 09:39:00 INFO - Successfully installed mozsystemmonitor 09:39:00 INFO - Cleaning up... 09:39:00 INFO - Return code: 0 09:39:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ae400>, '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 0x19af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af840>, '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': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', '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 09:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:39:00 INFO - Using env: {'DISPLAY': ':0', 09:39:00 INFO - 'HOME': '/home/cltbld', 09:39:00 INFO - 'LANG': 'en_US.UTF-8', 09:39:00 INFO - 'LANGUAGE': 'en_US:en', 09:39:00 INFO - 'LOGNAME': 'cltbld', 09:39:00 INFO - 'MAIL': '/var/mail/cltbld', 09:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:00 INFO - 'MOZ_NO_REMOTE': '1', 09:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:00 INFO - 'NO_EM_RESTART': '1', 09:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:00 INFO - 'PWD': '/builds/slave/test', 09:39:00 INFO - 'SHELL': '/bin/bash', 09:39:00 INFO - 'SHLVL': '1', 09:39:00 INFO - 'TERM': 'linux', 09:39:00 INFO - 'TMOUT': '86400', 09:39:00 INFO - 'USER': 'cltbld', 09:39:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', 09:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:00 INFO - '_': '/tools/buildbot/bin/python'} 09:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:00 INFO - Downloading/unpacking jsonschema==2.5.1 09:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:39:02 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 09:39:02 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 09:39:02 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 09:39:02 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 09:39:02 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 09:39:02 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 09:39:02 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:02 INFO - warning: no files found matching '*.txt' 09:39:02 INFO - no previously-included directories found matching 'build' 09:39:02 INFO - no previously-included directories found matching 'dist' 09:39:02 INFO - no previously-included directories found matching '.git*' 09:39:02 INFO - Installing collected packages: jsonschema, functools32 09:39:02 INFO - Running setup.py install for functools32 09:39:02 INFO - warning: no files found matching '*.txt' 09:39:02 INFO - no previously-included directories found matching 'build' 09:39:02 INFO - no previously-included directories found matching 'dist' 09:39:02 INFO - no previously-included directories found matching '.git*' 09:39:02 INFO - Successfully installed jsonschema functools32 09:39:02 INFO - Cleaning up... 09:39:02 INFO - Return code: 0 09:39:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:39:02 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')]} 09:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:02 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')]} 09:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:02 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 0x17131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ae400>, '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 0x19af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af840>, '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': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', '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 09:39:02 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 09:39:02 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 09:39:02 INFO - Using env: {'DISPLAY': ':0', 09:39:02 INFO - 'HOME': '/home/cltbld', 09:39:02 INFO - 'LANG': 'en_US.UTF-8', 09:39:02 INFO - 'LANGUAGE': 'en_US:en', 09:39:02 INFO - 'LOGNAME': 'cltbld', 09:39:02 INFO - 'MAIL': '/var/mail/cltbld', 09:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:02 INFO - 'MOZ_NO_REMOTE': '1', 09:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:02 INFO - 'NO_EM_RESTART': '1', 09:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:02 INFO - 'PWD': '/builds/slave/test', 09:39:02 INFO - 'SHELL': '/bin/bash', 09:39:02 INFO - 'SHLVL': '1', 09:39:02 INFO - 'TERM': 'linux', 09:39:02 INFO - 'TMOUT': '86400', 09:39:02 INFO - 'USER': 'cltbld', 09:39:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', 09:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:02 INFO - '_': '/tools/buildbot/bin/python'} 09:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:39:03 INFO - Cleaning up... 09:39:03 INFO - Return code: 0 09:39:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:39:03 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')]} 09:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:03 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')]} 09:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:03 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 0x17131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ae400>, '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 0x19af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af840>, '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': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', '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 09:39:03 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 09:39:03 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 09:39:03 INFO - Using env: {'DISPLAY': ':0', 09:39:03 INFO - 'HOME': '/home/cltbld', 09:39:03 INFO - 'LANG': 'en_US.UTF-8', 09:39:03 INFO - 'LANGUAGE': 'en_US:en', 09:39:03 INFO - 'LOGNAME': 'cltbld', 09:39:03 INFO - 'MAIL': '/var/mail/cltbld', 09:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:03 INFO - 'MOZ_NO_REMOTE': '1', 09:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:03 INFO - 'NO_EM_RESTART': '1', 09:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:03 INFO - 'PWD': '/builds/slave/test', 09:39:03 INFO - 'SHELL': '/bin/bash', 09:39:03 INFO - 'SHLVL': '1', 09:39:03 INFO - 'TERM': 'linux', 09:39:03 INFO - 'TMOUT': '86400', 09:39:03 INFO - 'USER': 'cltbld', 09:39:03 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', 09:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:03 INFO - '_': '/tools/buildbot/bin/python'} 09:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:03 INFO - Downloading/unpacking blobuploader==1.2.4 09:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:05 INFO - Downloading blobuploader-1.2.4.tar.gz 09:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:39:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:39:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 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 09:39:06 INFO - Downloading docopt-0.6.1.tar.gz 09:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:39:06 INFO - Installing collected packages: blobuploader, requests, docopt 09:39:06 INFO - Running setup.py install for blobuploader 09:39:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:39:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:39:06 INFO - Running setup.py install for requests 09:39:06 INFO - Running setup.py install for docopt 09:39:06 INFO - Successfully installed blobuploader requests docopt 09:39:06 INFO - Cleaning up... 09:39:06 INFO - Return code: 0 09:39:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:06 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')]} 09:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:06 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')]} 09:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:06 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 0x17131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ae400>, '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 0x19af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af840>, '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': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', '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 09:39:06 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 09:39:06 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 09:39:06 INFO - Using env: {'DISPLAY': ':0', 09:39:06 INFO - 'HOME': '/home/cltbld', 09:39:06 INFO - 'LANG': 'en_US.UTF-8', 09:39:06 INFO - 'LANGUAGE': 'en_US:en', 09:39:06 INFO - 'LOGNAME': 'cltbld', 09:39:06 INFO - 'MAIL': '/var/mail/cltbld', 09:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:06 INFO - 'MOZ_NO_REMOTE': '1', 09:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:06 INFO - 'NO_EM_RESTART': '1', 09:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:06 INFO - 'PWD': '/builds/slave/test', 09:39:06 INFO - 'SHELL': '/bin/bash', 09:39:06 INFO - 'SHLVL': '1', 09:39:06 INFO - 'TERM': 'linux', 09:39:06 INFO - 'TMOUT': '86400', 09:39:06 INFO - 'USER': 'cltbld', 09:39:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', 09:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:06 INFO - '_': '/tools/buildbot/bin/python'} 09:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:07 INFO - Running setup.py (path:/tmp/pip-2eveFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:07 INFO - Running setup.py (path:/tmp/pip-gOzAhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:07 INFO - Running setup.py (path:/tmp/pip-K_JBiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:07 INFO - Running setup.py (path:/tmp/pip-jQXiTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:07 INFO - Running setup.py (path:/tmp/pip-e3hKV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:07 INFO - Running setup.py (path:/tmp/pip-Zn7h5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:07 INFO - Running setup.py (path:/tmp/pip-3l1SOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:07 INFO - Running setup.py (path:/tmp/pip-Uqlpwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:07 INFO - Running setup.py (path:/tmp/pip-0EBrAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:07 INFO - Running setup.py (path:/tmp/pip-heJSvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:07 INFO - Running setup.py (path:/tmp/pip-jgMsi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:07 INFO - Running setup.py (path:/tmp/pip-hngoWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:07 INFO - Running setup.py (path:/tmp/pip-uChIjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:08 INFO - Running setup.py (path:/tmp/pip-qnbkm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:08 INFO - Running setup.py (path:/tmp/pip-PaxZZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:08 INFO - Running setup.py (path:/tmp/pip-V7sZBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:08 INFO - Running setup.py (path:/tmp/pip-RA1JhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:39:08 INFO - Running setup.py install for manifestparser 09:39:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:39:08 INFO - Running setup.py install for mozcrash 09:39:08 INFO - Running setup.py install for mozdebug 09:39:08 INFO - Running setup.py install for mozdevice 09:39:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:39:08 INFO - Running setup.py install for mozfile 09:39:08 INFO - Running setup.py install for mozhttpd 09:39:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:39:08 INFO - Running setup.py install for mozinfo 09:39:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:39:08 INFO - Running setup.py install for mozInstall 09:39:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:39:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:39:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:39:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:39:09 INFO - Running setup.py install for mozleak 09:39:09 INFO - Running setup.py install for mozlog 09:39:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:39:09 INFO - Running setup.py install for moznetwork 09:39:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:39:09 INFO - Running setup.py install for mozprocess 09:39:09 INFO - Running setup.py install for mozprofile 09:39:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:39:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:39:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:39:09 INFO - Running setup.py install for mozrunner 09:39:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:39:09 INFO - Running setup.py install for mozscreenshot 09:39:09 INFO - Running setup.py install for moztest 09:39:09 INFO - Running setup.py install for mozversion 09:39:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:39:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:39:10 INFO - Cleaning up... 09:39:10 INFO - Return code: 0 09:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:10 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 0x17131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ae400>, '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 0x19af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af840>, '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': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', '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 09:39:10 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 09:39:10 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 09:39:10 INFO - Using env: {'DISPLAY': ':0', 09:39:10 INFO - 'HOME': '/home/cltbld', 09:39:10 INFO - 'LANG': 'en_US.UTF-8', 09:39:10 INFO - 'LANGUAGE': 'en_US:en', 09:39:10 INFO - 'LOGNAME': 'cltbld', 09:39:10 INFO - 'MAIL': '/var/mail/cltbld', 09:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:10 INFO - 'MOZ_NO_REMOTE': '1', 09:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:10 INFO - 'NO_EM_RESTART': '1', 09:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:10 INFO - 'PWD': '/builds/slave/test', 09:39:10 INFO - 'SHELL': '/bin/bash', 09:39:10 INFO - 'SHLVL': '1', 09:39:10 INFO - 'TERM': 'linux', 09:39:10 INFO - 'TMOUT': '86400', 09:39:10 INFO - 'USER': 'cltbld', 09:39:10 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', 09:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:10 INFO - '_': '/tools/buildbot/bin/python'} 09:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:10 INFO - Running setup.py (path:/tmp/pip-4Bb_xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:10 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)) 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:10 INFO - Running setup.py (path:/tmp/pip-wj8eLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:10 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)) 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:10 INFO - Running setup.py (path:/tmp/pip-ChO6m4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:10 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)) 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:10 INFO - Running setup.py (path:/tmp/pip-0J2njo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:10 INFO - Running setup.py (path:/tmp/pip-Lc7X8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:10 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)) 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:10 INFO - Running setup.py (path:/tmp/pip-YL3d9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:10 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)) 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:10 INFO - Running setup.py (path:/tmp/pip-8DEetV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:10 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)) 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:10 INFO - Running setup.py (path:/tmp/pip-6ySKbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:10 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)) 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:10 INFO - Running setup.py (path:/tmp/pip-DiOoqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:10 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)) 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:11 INFO - Running setup.py (path:/tmp/pip-w_1J7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:11 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)) 09:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:11 INFO - Running setup.py (path:/tmp/pip-TJGoF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:11 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)) 09:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:11 INFO - Running setup.py (path:/tmp/pip-255VLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:11 INFO - Running setup.py (path:/tmp/pip-JFCCJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:11 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)) 09:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:11 INFO - Running setup.py (path:/tmp/pip-fN8ul3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:11 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)) 09:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:11 INFO - Running setup.py (path:/tmp/pip-0_aYHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:11 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)) 09:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:11 INFO - Running setup.py (path:/tmp/pip-sEwsh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:11 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)) 09:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:11 INFO - Running setup.py (path:/tmp/pip-WR2_gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:11 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)) 09:39:11 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)) 09:39:11 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)) 09:39:11 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)) 09:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:39:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:39:11 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 09:39:11 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 09:39:11 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 09:39:11 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 09:39:11 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 09:39:11 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 09:39:13 INFO - Downloading blessings-1.6.tar.gz 09:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:39:13 INFO - Installing collected packages: blessings 09:39:13 INFO - Running setup.py install for blessings 09:39:13 INFO - Successfully installed blessings 09:39:13 INFO - Cleaning up... 09:39:13 INFO - Return code: 0 09:39:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:14 INFO - Reading from file tmpfile_stdout 09:39:14 INFO - Current package versions: 09:39:14 INFO - argparse == 1.2.1 09:39:14 INFO - blessings == 1.6 09:39:14 INFO - blobuploader == 1.2.4 09:39:14 INFO - docopt == 0.6.1 09:39:14 INFO - functools32 == 3.2.3-2 09:39:14 INFO - jsonschema == 2.5.1 09:39:14 INFO - manifestparser == 1.1 09:39:14 INFO - mozInstall == 1.12 09:39:14 INFO - mozcrash == 1.0 09:39:14 INFO - mozdebug == 0.1 09:39:14 INFO - mozdevice == 0.50 09:39:14 INFO - mozfile == 1.2 09:39:14 INFO - mozhttpd == 0.7 09:39:14 INFO - mozinfo == 0.9 09:39:14 INFO - mozleak == 0.1 09:39:14 INFO - mozlog == 3.4 09:39:14 INFO - moznetwork == 0.27 09:39:14 INFO - mozprocess == 0.25 09:39:14 INFO - mozprofile == 0.28 09:39:14 INFO - mozrunner == 6.13 09:39:14 INFO - mozscreenshot == 0.1 09:39:14 INFO - mozsystemmonitor == 0.3 09:39:14 INFO - moztest == 0.8 09:39:14 INFO - mozversion == 1.4 09:39:14 INFO - psutil == 3.1.1 09:39:14 INFO - requests == 1.2.3 09:39:14 INFO - wsgiref == 0.1.2 09:39:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:14 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 0x17131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ae400>, '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 0x19af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af840>, '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': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', '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 09:39:14 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 09:39:14 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 09:39:14 INFO - Using env: {'DISPLAY': ':0', 09:39:14 INFO - 'HOME': '/home/cltbld', 09:39:14 INFO - 'LANG': 'en_US.UTF-8', 09:39:14 INFO - 'LANGUAGE': 'en_US:en', 09:39:14 INFO - 'LOGNAME': 'cltbld', 09:39:14 INFO - 'MAIL': '/var/mail/cltbld', 09:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:14 INFO - 'MOZ_NO_REMOTE': '1', 09:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:14 INFO - 'NO_EM_RESTART': '1', 09:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:14 INFO - 'PWD': '/builds/slave/test', 09:39:14 INFO - 'SHELL': '/bin/bash', 09:39:14 INFO - 'SHLVL': '1', 09:39:14 INFO - 'TERM': 'linux', 09:39:14 INFO - 'TMOUT': '86400', 09:39:14 INFO - 'USER': 'cltbld', 09:39:14 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', 09:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:14 INFO - '_': '/tools/buildbot/bin/python'} 09:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 INFO - Cleaning up... 09:39:14 INFO - Return code: 0 09:39:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:14 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 0x17131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ae400>, '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 0x19af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af840>, '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': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', '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 09:39:14 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 09:39:14 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 09:39:14 INFO - Using env: {'DISPLAY': ':0', 09:39:14 INFO - 'HOME': '/home/cltbld', 09:39:14 INFO - 'LANG': 'en_US.UTF-8', 09:39:14 INFO - 'LANGUAGE': 'en_US:en', 09:39:14 INFO - 'LOGNAME': 'cltbld', 09:39:14 INFO - 'MAIL': '/var/mail/cltbld', 09:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:14 INFO - 'MOZ_NO_REMOTE': '1', 09:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:14 INFO - 'NO_EM_RESTART': '1', 09:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:14 INFO - 'PWD': '/builds/slave/test', 09:39:14 INFO - 'SHELL': '/bin/bash', 09:39:14 INFO - 'SHLVL': '1', 09:39:14 INFO - 'TERM': 'linux', 09:39:14 INFO - 'TMOUT': '86400', 09:39:14 INFO - 'USER': 'cltbld', 09:39:14 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', 09:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:14 INFO - '_': '/tools/buildbot/bin/python'} 09:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:39:14 INFO - Cleaning up... 09:39:14 INFO - Return code: 0 09:39:14 INFO - Running post-action listener: _resource_record_post_action 09:39:14 INFO - Running post-action listener: _start_resource_monitoring 09:39:14 INFO - Starting resource monitoring. 09:39:14 INFO - [mozharness: 2017-04-09 16:39:14.565564Z] Finished create-virtualenv step (success) 09:39:14 INFO - [mozharness: 2017-04-09 16:39:14.566076Z] Running install step. 09:39:14 INFO - Running pre-action listener: _resource_record_pre_action 09:39:14 INFO - Running main action method: install 09:39:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:14 INFO - Reading from file tmpfile_stdout 09:39:14 INFO - Detecting whether we're running mozinstall >=1.0... 09:39:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:39:14 INFO - Reading from file tmpfile_stdout 09:39:14 INFO - Output received: 09:39:14 INFO - Usage: mozinstall [options] installer 09:39:14 INFO - Options: 09:39:14 INFO - -h, --help show this help message and exit 09:39:14 INFO - -d DEST, --destination=DEST 09:39:14 INFO - Directory to install application into. [default: 09:39:14 INFO - "/builds/slave/test"] 09:39:14 INFO - --app=APP Application being installed. [default: firefox] 09:39:14 INFO - mkdir: /builds/slave/test/build/application 09:39:14 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'] 09:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:39:30 INFO - Reading from file tmpfile_stdout 09:39:30 INFO - Output received: 09:39:30 INFO - /builds/slave/test/build/application/firefox/firefox 09:39:30 INFO - Running post-action listener: _resource_record_post_action 09:39:30 INFO - [mozharness: 2017-04-09 16:39:30.905696Z] Finished install step (success) 09:39:30 INFO - [mozharness: 2017-04-09 16:39:30.905846Z] Running run-tests step. 09:39:30 INFO - Running pre-action listener: _resource_record_pre_action 09:39:30 INFO - Running main action method: run_tests 09:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:39:30 INFO - Python 2.7.3 09:39:30 INFO - Return code: 0 09:39:30 INFO - grabbing minidump binary from tooltool 09:39: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')]} 09:39:30 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 0x19ae400>, '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 0x19af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19af840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:39:30 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 09:39:30 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 09:39:30 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 09:39:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:39:30 INFO - Return code: 0 09:39:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:39:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:39:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:39:30 INFO - ENV: RUST_BACKTRACE is now 1 09:39:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:39:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:39:30 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/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 09:39:30 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/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 09:39:30 INFO - Using env: {'DISPLAY': ':0', 09:39:30 INFO - 'HOME': '/home/cltbld', 09:39:30 INFO - 'LANG': 'en_US.UTF-8', 09:39:30 INFO - 'LANGUAGE': 'en_US:en', 09:39:30 INFO - 'LOGNAME': 'cltbld', 09:39:30 INFO - 'MAIL': '/var/mail/cltbld', 09:39:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:39:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:30 INFO - 'MOZ_NO_REMOTE': '1', 09:39:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:30 INFO - 'NO_EM_RESTART': '1', 09:39:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:30 INFO - 'PWD': '/builds/slave/test', 09:39:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:39:30 INFO - 'RUST_BACKTRACE': '1', 09:39:30 INFO - 'SHELL': '/bin/bash', 09:39:30 INFO - 'SHLVL': '1', 09:39:30 INFO - 'TERM': 'linux', 09:39:30 INFO - 'TMOUT': '86400', 09:39:30 INFO - 'USER': 'cltbld', 09:39:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710', 09:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:30 INFO - '_': '/tools/buildbot/bin/python'} 09:39:30 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/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 09:39:31 INFO - mozversion application_buildid: 20170409154642 09:39:31 INFO - mozversion application_changeset: c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba 09:39:31 INFO - mozversion application_display_name: Nightly 09:39:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:39:31 INFO - mozversion application_name: Firefox 09:39:31 INFO - mozversion application_remotingname: firefox 09:39:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:39:31 INFO - mozversion application_vendor: Mozilla 09:39:31 INFO - mozversion application_version: 55.0a1 09:39:31 INFO - mozversion platform_buildid: 20170409154642 09:39:31 INFO - mozversion platform_changeset: c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba 09:39:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:39:31 INFO - mozversion platform_version: 55.0a1 09:39:31 INFO - using testdate: 1491755971 09:39:31 INFO - actual date: 1491755971 09:39:31 INFO - starting webserver on 'localhost:32796' 09:39:31 INFO - SUITE-START | Running 2 tests 09:39:31 INFO - TEST-START | dromaeo_css 09:39:31 INFO - operating with platform_type : linux_ 09:39:31 INFO - Initialising browser for dromaeo_css test... 09:39:31 INFO - TEST-INFO | started process 11497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfqtTP2/profile http://localhost:32796/getInfo.html) 09:39:35 INFO - PID 11497 | __metrics Screen width/height:1600/1200 09:39:35 INFO - PID 11497 | colorDepth:24 09:39:35 INFO - PID 11497 | Browser inner width/height: 1024/697 09:39:35 INFO - PID 11497 | __metrics 09:39:36 INFO - PID 11497 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:39:36 INFO - PID 11497 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:39:38 INFO - TEST-INFO | 11497: exit 0 09:39:38 INFO - Browser initialized. 09:39:38 INFO - Running cycle 1/1 for dromaeo_css test... 09:39:38 INFO - TEST-INFO | started process 11595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfqtTP2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:50 INFO - PID 11595 | RSS: Main: 149864448 09:39:50 INFO - PID 11595 | 09:42:52 INFO - PID 11595 | Cycle 1(1): loaded http://localhost:32796/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32796/tests/dromaeo/cssquery-ext.html) 09:42:54 INFO - PID 11595 | RSS: Main: 310247424 09:42:54 INFO - PID 11595 | 09:44:39 INFO - PID 11595 | ************************* 09:44:39 INFO - PID 11595 | A coding exception was thrown and uncaught in a Task. 09:44:39 INFO - PID 11595 | 09:44:39 ERROR - PID 11595 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:44:39 INFO - PID 11595 | Full stack: 09:44:39 INFO - PID 11595 | ************************* 09:44:39 INFO - PID 11595 | ************************* 09:44:39 INFO - PID 11595 | A coding exception was thrown and uncaught in a Task. 09:44:39 INFO - PID 11595 | 09:44:39 ERROR - PID 11595 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:44:39 INFO - PID 11595 | Full stack: 09:44:39 INFO - PID 11595 | ************************* 09:44:39 INFO - PID 11595 | ************************* 09:44:39 INFO - PID 11595 | A coding exception was thrown and uncaught in a Task. 09:44:39 INFO - PID 11595 | 09:44:39 ERROR - PID 11595 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:44:39 INFO - PID 11595 | Full stack: 09:44:39 INFO - PID 11595 | ************************* 09:44:39 INFO - PID 11595 | ************************* 09:44:39 INFO - PID 11595 | A coding exception was thrown and uncaught in a Task. 09:44:39 INFO - PID 11595 | 09:44:39 ERROR - PID 11595 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:44:39 INFO - PID 11595 | Full stack: 09:44:39 INFO - PID 11595 | ************************* 09:45:56 INFO - PID 11595 | Cycle 1(1): loaded http://localhost:32796/tests/dromaeo/cssquery-ext.html (next: http://localhost:32796/tests/dromaeo/cssquery-jquery.html) 09:45:57 INFO - PID 11595 | RSS: Main: 214683648 09:45:57 INFO - PID 11595 | 09:48:59 INFO - PID 11595 | Cycle 1(1): loaded http://localhost:32796/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32796/tests/dromaeo/cssquery-mootools.html) 09:48:59 INFO - PID 11595 | RSS: Main: 177954816 09:48:59 INFO - PID 11595 | 09:52:01 INFO - PID 11595 | Cycle 1(1): loaded http://localhost:32796/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32796/tests/dromaeo/cssquery-prototype.html) 09:52:02 INFO - PID 11595 | RSS: Main: 176340992 09:52:02 INFO - PID 11595 | 09:55:04 INFO - PID 11595 | Cycle 1(1): loaded http://localhost:32796/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32796/tests/dromaeo/cssquery-yui.html) 09:55:05 INFO - PID 11595 | RSS: Main: 184991744 09:55:05 INFO - PID 11595 | 09:58:07 INFO - PID 11595 | Cycle 1(1): loaded http://localhost:32796/tests/dromaeo/cssquery-yui.html (next: http://localhost:32796/tests/dromaeo/cssquery-dojo.html) 09:58:07 INFO - PID 11595 | RSS: Main: 272228352 09:58:07 INFO - PID 11595 | 09:58:07 INFO - PID 11595 | __start_tp_report 09:58:07 INFO - PID 11595 | _x_x_mozilla_page_load 09:58:07 INFO - PID 11595 | _x_x_mozilla_page_load_details 09:58:07 INFO - PID 11595 | |i|pagename|runs| 09:58:07 INFO - PID 11595 | |0;dojo.html;3341.949870751939;3364.1421437533427;3378.1892345837005;3382.2051817822794;3415.8975230743085;5543.77824887004;5701.116326969326;5807.477327040566;5883.264591926009;5899.557533185012;5834.795782147626;5836.124581312805;5849.239598852154;5913.970430147854;5923.85190370241;5036.597072234213;5047.596192304625;5103.489651034894;5205.765740541685;5237.188235823453;5208.895822083556;5240.318758561381;5274.973625131888;5278.076336641092;5337.572994160458;4985.152524070917;5036.093503169428;5131.102057139986;5193.9740301298625;5194.194899790538;5058.924116138261;5071.858831762824;5135.922961155586;5166.483351664841;5200.635955483118;4997.275395067695;5092.9745351273;5107.565856902168;5134.4095429025765;5135.666181698178;5526.944730552683;5608.298962629671;5622.269105016363;5786.88426231473;5788.450097240798;6148.815535533941;6242.719077641517;6255.843603909939;6287.748490060392;6301.810945671591;6291.874162516724;6300.30696623371;6344;6372.776952806676;6378.553501254914;5608.10270356741;5808.273965754281;5875.030619947661;5876.471117599436;5877.206577112035;6242.719077641426;6383.872322553616;6433.38882806142;6480;6484.773032943825;5993.280806303272;6061.333253342217;6073.939260607426;6128.1726966858905;6162.815115546541;6200.844978875564;6266.122742816009;6280.089387038854;6299.685015749286;6300.873982520324;6231.345708700521;6235.220597425322;6242.063690446378;6248.875022499525;6252.343503932022;6032.607880487842;6096.7081148910665;6117.431594453911;6189;6259.499240060784;4802.327674125625;4807.110684523374;4809.0862736080035;4823.686460380064;4843.854684359404;4255.76593287366;4256.489221293465;4262.573742625775;4286.978565107154;4298.26929421999;5601.271834661468;5686.14707793826;5821.27234095738;5850.648961062265;5851.180834683148;6285.968570157212;6321.557490975588;6340.714667839959;6342.080398342307;6345;5891.46976772084;5901.881962360729;5903.911441328383;5905.557083218776;5908.497777688859;5198.92201616976;5271.894562108813;5363.19552067193;5402.459754024566;5424.918626220609;6509.218893732687;6642.302558231316;6645.169353830771;6647.102641143384;6648.700808463631;6308.684565771785;6354.7140378684;6380.042993551005;6386.201724784402;6389.2971773105855;6143.849652621547;6602.966985165043;6641.966790166019;6643.634600097041;6649.168853893263;6013.218281623361;6090.269167699727;6099.672983688876;6125.23545181825;6191.783287584913;6262.2172228471445;6288.434040936338;6296.968515157395;6297.338779428094;6302.464290535356;5837.241158649348;5860.765569377178;5916.526677865846;6121.3878612140215;6121.908171377522;6013.248343957005;6107.977837958849;6108.144859719731;6128.411459112376;6139.3553676863285;6119.204503414706;6141.056449558148;6154.723037463235;6167.475764560063;6172.938270617416;6168.9691551541955;6199.070139479114;6199.876002479835;6205.410486003822;6205.844853878509;5742.19609254713;5828.154917537018;5988.37122102173;5991.054848950721;5997.460228579449 09:58:07 INFO - PID 11595 | |1;ext.html;731.1591669579982;797.2107613462671;815.4943934760449;1094.2723089145718;1104.0560320925604;30077.548836767437;38119.42820857686;38754;38815;38851.61148388515;40662.39006414906;41003.79498102505;41004.384934225935;41040.17919641605;41065.58934410655;6169.568130230886;6314.810555683337;8077.636506357228;8231.95884020579;8235.341172706168;8035.276825085741;8226.218509241613;8228.917710822874;8231.83536329273;8238.299744521722;8111.634976426046;8178.918210817875;8188.877166842472;8189.262966333029;8201.630926608317;8127.187281271885;8139.104698483162;8158.918410815934;8176.141505141994;8185.754427367158;8114.148014458515;8191.221833925827;8193.50838949665;8203.753887383387;8237.711680091168;37784.622153778386;37842;37975.240495189944;37975.24049519022;38011.61988380108;3479.704225140866;3502.6322236165092;3516.507688923553;3520.1903562180587;3522.049046757387;29863;29953.251168720955;29991.700082999327;29997.850010750026;30016.8499157505;3956.920861582781;3964.484616999772;3976.483057202574;3981.163955569334;3985.980070099631;180151;180738;181109;181328.09335953367;181903;47858.28212576814;48220.517794822306;48296.75851620719;48349.51650483521;48433.273500897514;49574.75212623914;49668.75165624221;49691;49978.50021499739;50032;15306.387744490095;15346.309416076303;15403.845961540464;15429;15446.304916278794;10713.410762407986;10876.836847447295;12159.574414895436;12588.81116783249;12600.4329805159;13570.796438053438;13575.66060848467;13651.453941842215;13818.101823381448;13826.101303415246;5160.483951604884;5194.68831870089;5240.187770895517;5258;5298.97350513245;1062.7661914378825;1100.785346857355;1109.3842917181041;1110.306058713304;1122.147168152194;25726.74273257281;25736.227913162635;25751.227463176136;25778.871105644354;26043.609345859826;1156.4160099149876;1170.789257933563;1186.9109816763605;1201.5581302436935;1204.3857632607433;13077.280749558866;13620.727585448236;13758.729809581508;13848.584542463743;13883.722325553432;240816;242643;243010;243082;244152;51664.48335516597;51772;51840.74079629578;51948.48051519512;52035;1450.7751298548953;1473.8820894328428;1488.3525666334963;1492.417956996772;1520.4906356370739;23352.18267360634;24565.263042108767;24667.25998220056;24935.75064249407;24940.12709555157;37656.623433765315;48083.519164807905;49014.75492622514;49032.26451603157;49118.26322605092;153953;154112;154144;154163.22918385337;154212;28336.716632834232;28701.56947645745;31523.21191970219;31757.364852702354;31934.52098218575;40058.599414006654;40282.19435611213;40352;40564.79717601393;40629.59370406258;30178.84910575521;30384.634473174498;30889.382212355176;31278.37443251168;31462.842685787342;29957.700422996364;30034.84982575073;30877;31210.68789312078;31469.37061258716;34734.826325868205;35292.64707352893;35600.46599300961;35622.465663014555;35689.8956619992;29006;29308.560371594016;29477.85261073681;29906.70093299126;30707.2323191922;22924.885375573016;24581.63127553124;24598.50802983966;24827.255182344557;24925.875370623755 09:58:07 INFO - PID 11595 | |2;jquery.html;444.4932776634637;448.2603703888585;454.1212753322321;465.3066930273892;473.3113320119229;16755.83244167558;17280.395186168487;21226.89386553067;21924.671129933064;22559.436014099654;22348.553028939412;22445;22581.435464113405;22740.090396384167;22906;5806.274215723024;6062.636241825505;6070.757169713206;6076.422739839731;6077.270727512682;3716.4053751399783;5896.115582662592;6080.14877917092;6092.847678808021;6188.690565471731;3784.6593806557403;5827.446392592697;6044.9697751511185;6047.516198704093;6049.395060493937;6018.615718384796;6020;6044.455998960093;6052.606580572271;6083.8174854754425;5432.293801805779;5450.209719590677;5451.2640793493165;5453.863653408657;5455.509004189602;25698.48603027929;26367;26443.603345949825;26471.073512426974;26648.467030659278;2183.530540933691;2209.701690271825;2210.9447263818374;2213.701150344715;2214.745304290011;16548.669026619402;17222.397216097503;17367.565810854703;17383.217755201047;17469.825301746947;2277.9316620501413;2327.453048533593;2345.061975209913;2351.1895840202947;2359;109950.45024774825;115101.42449287784;116219;116289.41855290669;116769.41615291954;11598.536058557733;12030.759384812254;12075.758484830254;12084.335361555199;12190.329531875655;16701.164941752864;16741.49775506737;16748.58128546796;16764.664706705797;16786.916065419595;8401.36989725773;8790.472571645721;8825.955870220609;8937.73186804397;9020.548972551345;8239.052508961426;8332.083620767258;8347.081820999685;8558.657653693906;8619.827603447897;7682.7311044113185;7706.422018348534;7764.883526747103;7791.532508049535;7831.849119966427;2177.9237726679808;2250.5386395788823;2265.2524666860227;2288.7940085392393;2372.2883135059415;860.694453469022;890.7416849113814;973.3673112476805;1025.3489034463169;1040.2977989856815;20033.398998030083;21166.78833211679;21281;21393.78606213949;21510.677339839916;1077.8221593436995;1088.1077516436446;1090.607381342716;1094.5348227003492;1099.769048499824;11118.722031949104;11528.59649912249;11545;11600.245984011011;11651.475683594259;566761;568831;571832;573920;576298;105254;108728.4563577177;109712.45143774389;113186.43406782913;113254;1162.604714397109;1222.3032871263472;1237.5421094195206;1251.2367455851922;1258.4903114238748;16739.414120505724;16918.492445226664;17312.567185820455;17431.128443577516;18217.817821822144;48623.75688121678;49282.26076608782;49915.00169996507;50165.74917125391;50515.49484505108;64109;65321.673391632736;66438.66780666065;66770.66614666895;68187;9186.127317904788;9247.306452015991;9299.30255230874;9412.858807117762;9600.231981441328;14634.853651463349;15294.388224470897;15425.84574154289;15566.198084344927;15641.608959776097;13169.670758231121;13341.332933353488;13349.933250333686;13496.392662330416;13608.591742247749;11923.642290731292;12085.879141208827;12149.392530373269;12190.6952326189;12527.749445011232;13062.80405793933;13132.540361087316;13157.144785588906;13222.008349373644;13245.602631921058;9185.311101667536;9358.578863951003;9370.906290937004;9747.366421182884;9804.754881128029;13033.934830325788;13544.525941591997;13573.932130339284;13722.108062976275;13855.722885542435 09:58:07 INFO - PID 11595 | |3;mootools.html;1321.1412581821814;1385.840628327742;1410.6967002094548;1413.5759272218336;1419.9858001419996;11012.834807477884;11476.196666233367;11491.367974761406;11493;11498.482568284417;11159.218854680155;11330.263532870358;11682.47428865701;11685.941570292158;11690.590829320976;2398.2445529658144;2428.2836563213896;2430.3924018995253;2432.7567243275707;2437.9512409751796;1984.4046785964226;2337.7895989360954;2397.4845408237225;2444.291155564884;2447.6940382452194;2036.6843139313355;2364.243442098529;2439.7072351317865;2443.7556244375596;2448.5470188015183;2305;2321.0367697405554;2329.6505524171425;2330.1029103795076;2401.4836810085917;2307.7576854430213;2336.5794157051723;2342.320726989171;2347.97652023481;2356.882155892216;11085.889141108566;11323.320600763898;11324;11324.886751132466;11331.773364532663;6302.653354065525;6498.02529620556;6503;6504;6509.707063182168;3794.9620503794886;3958.3270843956598;4073.2871747444374;4076.286649836267;4131.834726610932;1378.5657517881934;1385.591250581081;1409.3164815064788;1431.7852322151657;1488.642725745824;16814.411495597597;16914;16928.153592320457;16941.57646058846;16971.915140424342;5108.770105345268;5111.080005598954;5298.496642818926;5345.251664766935;5391.35303763543;12343.6914077147;12350.505979760708;12351.25892446438;12400.13199076056;12401.689957751129;6147.477464415575;6166.660833654192;6174.938250617436;6180.381961803783;6183.072539119168;5765.4522820332;5856.092305692539;6011.609245399035;6069.878602428015;6101.389861013863;4142.212979533939;4150.91698166035;4226.76752778594;4228.450301460791;4233.470816147981;1023.9129673977795;1050.7163065972145;1174.395186478964;1181.2144923625865;1216.5559570756786;852.2457625001917;874.4884242717955;886.1006078829993;900.4102312985005;917.1378903830378;6598.8350291243105;6604.900926486107;6627.1716035495565;6649.368310010638;6879.862402751917;642.0818229931243;648.6918713610997;653.3531803514486;664.9002649602598;766.7967988483057;4056.7971601419813;4245.299525578307;4260.616544511009;4270.466191726035;4293.184294983943;13914.930425347808;14578.854211457961;14616;14616.26918654063;14674.339654715563;14159.78760318596;14237.644058898402;14305.28473576317;14315.642108947359;14359.497417590333;10519.263651544472;10543.630972916064;10567;10584.629537966288;10697.090747286567;6449;6547.869042619026;6577.473802095725;6598.60408375499;6803.523753337219;12329.383530823243;12697.746045079231;12832.101752877583;12952.41714122848;13009.739805204032;12942.611721648365;13105.475780969036;13124.606261812161;13351.933240333736;13363.198208107544;8554.786130346542;8766.60550275252;8771.07903670131;8774.210321071134;8775.166359195866;10126.645567405105;10133.746656333651;10138.49307534635;10232.846507302247;10259.487025648838;6863.382295593221;8288.792780180544;8374;8401;8457.112003239572;7857.214278572097;8000.119986801564;8006;8069.878951815845;8107.4324797263625;8042.9597852010365;8200.05699344583;8268.007839059352;8281.83436331282;8282.254597086292;5904.61619994699;6028;6064.939350606437;6067.332593414632;6307.400796924285;5671.234383358194;5687.578105473632;5722.74247658848;5783.884322313615;5893.2044174035955 09:58:07 INFO - PID 11595 | |4;prototype.html;421.8755467137194;428.7448967864121;432.1853306517214;432.26730691477957;433.8892435365465;5586.972065139668;5755.640187523117;5778.768849246036;5791.07342825148;5799.971000144993;5723.54211663066;5783.82648520544;5785.16115163301;5793;5798.217240672508;4257.2549803784295;4323.956760432387;4326;4337.7180483268485;4356.324769660708;4359.934600980988;4363.716358436692;4375.015621485172;4382.408374869384;4387.319965405367;4334.479862416514;4345.478542574895;4359.629431498311;4359.956400435986;4363.0619416825375;4165.937510937353;4282.764447955361;4308.719933204332;4311;4347.152305300468;3786.148116673754;3787.0721673190246;3792.715546334036;3794.677452416548;3817.5991520890184;5580.91628625571;5594;5599.300087489064;5601.187827764951;5607.158926161109;4975;5066.265391518209;5098.668586541863;5120.513551212629;5131.846044618667;6029.849253768647;6030.306514750816;6049.580167932818;6056.5457590680435;6072.605280656788;4221.831126754957;4255.234057869582;4260.829566817354;4261.680373971964;4295.6778241632;5989.765526615623;6152.169457123276;6205.3484384139465;6295.779647712354;6350.809475715736;4295.613394794421;4356.411884395629;4365.716228445204;4386.846460373871;4401.955980440219;4430.756308403004;4448.55514448559;4452.554744525586;4456.242438785414;4459.063596644676;4922.704637721748;5010.2735103409805;5089.694618322913;5097.890286924973;5098.878246785701;6004;6043.244594425697;6074.240719910012;6086.604370715978;6112.449879510866;1535;1556.47079992803;1557.462675376993;1567.6786258816915;1567.7569976653638;967.8016006718606;1021.4892553723139;1022.7085280694967;1042.9165666746642;1060.5969731502134;5831.941680583224;5874.295084589877;5875.970620146872;5899.4985426239255;5912.374097123326;6202.937970620236;6205.348438413992;6220.315765265817;6224.253089629274;6229.7293920692;5638.802641907596;5844.1818145459665;5889.293284805851;5914.58597898143;5920.615160014585;3294.3081952789703;3310.8841190558214;3312.337532493511;3314.6022477302877;3315.9834200829323;6343.492520598341;6492.6690028544035;6525.151730275129;6555.967220163869;6593.142891424084;6408.231012278557;6416;6418.101465794793;6421.839454013687;6446.4520515756685;6262.3111457738705;6517.641529715816;6521.315261897527;6539.2479864815205;6543.214814222324;6174.753009879554;6248.8752024636005;6249.25008998923;6254.8123556293385;6262.34245404226;6204.5967012144065;6219.813405597839;6247.875042499034;6252.562320637512;6253.530985176039;5768.961586914228;6155.507559395327;6479.157709497735;6508.8047358579315;6524.445422139172;4417.933730994102;4440.2229609817505;4444.444444444444;4450.443694538183;4461.219286624892;6176.81469555914;6285.528585356208;6295.748170073146;6295.937040629535;6296.496280297657;6060.545459090674;6085.04472093143;6101.938980610137;6102.908456373247;6130.295016073031;5961.970190149022;6038.184845046038;6065.848353791191;6129.977107554586;6130.172426722335;5998.790042348672;6002.129691194839;6021.909671354845;6045.879082418415;6050.878982420415;6043.912095822794;6084.087386892002;6110.755569777337;6119.663418512025;6127.29536103336;5810.244668193108;5876.324222714443;5918.674472903859;5929.258842644669;5995.940040599538 09:58:07 INFO - PID 11595 | |5;yui.html;776.1384862802284;864.8313578852122;886.1050339157451;892.2014796756903;898.8651702244663;13792.310384480774;17175.65648687027;17198.226079826407;17818.64362712745;17887.910560447195;16465.753013704805;16708.248128834202;17178.484645460623;17297.567560810956;17479.213435395406;988.3871999360407;1022.4938655365568;1024.2062401638716;1024.8718910136233;1025.8358662613982;725.365305357812;744.359850528545;987.3384832162433;1016.5832008876362;1020.494855046753;1066.109798318405;1068.1188019883589;1068.3536460441399;1068.5298468673798;1070.261519551507;1058.0319008107572;1059.0521483272466;1059.0627294844041;1059.1685526861454;1063.478895341285;767.1369709077288;774.6359211170741;774.9806254843618;777.1451403456153;780.4224873593556;15270.31283592241;15438.150901700403;15585.844141558553;16921.238544265536;17170.742438863428;17239.138043097795;17429.651406971916;17640.735388969177;17684.46946591604;17896.731549026776;14355.138691678532;14596.87045814381;14722;14862.405503779835;14894.478693245792;3387.796732196076;3406.931861362784;3411.096059544223;3412.9488057679155;3418.3505134024454;82397.58801205955;82682;83603.5819820897;84265.57867210686;84903.57548212219;12949.54676586315;12995.610131696065;13066.216027038408;13086;13123.081384303006;18829.90585047066;20771.792282077287;20798.480037999172;24862;24975.62536561953;8618.741437756877;8836.381453298207;8913.866292005625;8935.017148113702;9276.814463710689;4704.129735998851;4731.550502702238;4754.904901901942;4783.880402989884;4791.5687588117235;4399.25212713833;4537.410136682276;4553.635709143261;4567.520410356931;4571.6799824012;939.6852054561662;966.5457235099492;983.6114734679761;983.8327484327682;985.8767654043245;720.6072690383753;723.6779633063342;731.5464412064448;734.3170851108414;766.6320166320197;11531.76936461266;12635.620931372074;12659.430325635369;12818.61544153677;12826.80759788604;709.2765379313072;718.1992078832064;724.1057294241607;726.8546290741873;730.2478447199393;5489.2589500417735;5498.972505137449;5620.353659329147;5833.591648584558;5864.882702345929;81332;81416;81579.59210203911;82258;86357.56821215854;71522.64238678878;73151.26848731445;74209.25790742024;76902.23097768951;77565.61217193877;63562;64961.02558461627;65564;65673.67163164154;65842;12269.815952760537;13191.67020824487;13476.46094156262;13578.728425431633;13593.45626174942;31232.21919452032;32058.83970580132;32873.342533149684;33271.50092748659;33849;52504;53166;53946.19080713871;53963.46036539584;54191.72904135454;16592.336306547604;17063.829361706223;17067.573310667332;17109.657806843545;17236.82763172352;17189.31242750276;17995.640087198444;18419;18507.53731156678;18880.150393232063;15000.774988374966;16873.662526749642;16878;16946.745798812783;17796.733049004535;17463.825361746727;17650.91174544119;17753.289868405118;17875;17907.10464476797;16677.749833752747;16808.915955420143;17041.318347266468;17060.91469542694;17139.228734707216;11924.821127682919;11950.820737689115;12174.634760957186;12214.816777748518;12550.121491495873;12849.614511564669;13326.86673133295;13358.866411335763;13408.061435699798;13414.932925335312 09:58:07 INFO - PID 11595 | __end_tp_report 09:58:07 INFO - PID 11595 | __start_cc_report 09:58:07 INFO - PID 11595 | _x_x_mozilla_cycle_collect,1489 09:58:07 INFO - PID 11595 | __end_cc_report 09:58:07 INFO - PID 11595 | __startTimestamp1491757087489__endTimestamp 09:58:07 INFO - PID 11595 | 09:58:07 INFO - PID 11595 | ------- Summary: start ------- 09:58:07 INFO - PID 11595 | Number of tests: 6 09:58:07 INFO - PID 11595 | 09:58:07 INFO - PID 11595 | [#0] dojo.html Cycles:165 Average:5775.45 Median:5993.28 stddev:693.47 (11.6%) stddev-sans-first:668.80 09:58:07 INFO - PID 11595 | Values: 3341.9 3364.1 3378.2 3382.2 3415.9 5543.8 5701.1 5807.5 5883.3 5899.6 5834.8 5836.1 5849.2 5914.0 5923.9 5036.6 5047.6 5103.5 5205.8 5237.2 5208.9 5240.3 5275.0 5278.1 5337.6 4985.2 5036.1 5131.1 5194.0 5194.2 5058.9 5071.9 5135.9 5166.5 5200.6 4997.3 5093.0 5107.6 5134.4 5135.7 5526.9 5608.3 5622.3 5786.9 5788.5 6148.8 6242.7 6255.8 6287.7 6301.8 6291.9 6300.3 6344.0 6372.8 6378.6 5608.1 5808.3 5875.0 5876.5 5877.2 6242.7 6383.9 6433.4 6480.0 6484.8 5993.3 6061.3 6073.9 6128.2 6162.8 6200.8 6266.1 6280.1 6299.7 6300.9 6231.3 6235.2 6242.1 6248.9 6252.3 6032.6 6096.7 6117.4 6189.0 6259.5 4802.3 4807.1 4809.1 4823.7 4843.9 4255.8 4256.5 4262.6 4287.0 4298.3 5601.3 5686.1 5821.3 5850.6 5851.2 6286.0 6321.6 6340.7 6342.1 6345.0 5891.5 5901.9 5903.9 5905.6 5908.5 5198.9 5271.9 5363.2 5402.5 5424.9 6509.2 6642.3 6645.2 6647.1 6648.7 6308.7 6354.7 6380.0 6386.2 6389.3 6143.8 6603.0 6642.0 6643.6 6649.2 6013.2 6090.3 6099.7 6125.2 6191.8 6262.2 6288.4 6297.0 6297.3 6302.5 5837.2 5860.8 5916.5 6121.4 6121.9 6013.2 6108.0 6108.1 6128.4 6139.4 6119.2 6141.1 6154.7 6167.5 6172.9 6169.0 6199.1 6199.9 6205.4 6205.8 5742.2 5828.2 5988.4 5991.1 5997.5 09:58:07 INFO - PID 11595 | 09:58:07 INFO - PID 11595 | [#1] ext.html Cycles:180 Average:36229.00 Median:31640.29 stddev:50929.43 (161.0%) stddev-sans-first:51002.55 09:58:07 INFO - PID 11595 | Values: 731.2 797.2 815.5 1094.3 1104.1 30077.5 38119.4 38754.0 38815.0 38851.6 40662.4 41003.8 41004.4 41040.2 41065.6 6169.6 6314.8 8077.6 8232.0 8235.3 8035.3 8226.2 8228.9 8231.8 8238.3 8111.6 8178.9 8188.9 8189.3 8201.6 8127.2 8139.1 8158.9 8176.1 8185.8 8114.1 8191.2 8193.5 8203.8 8237.7 37784.6 37842.0 37975.2 37975.2 38011.6 3479.7 3502.6 3516.5 3520.2 3522.0 29863.0 29953.3 29991.7 29997.9 30016.8 3956.9 3964.5 3976.5 3981.2 3986.0 180151.0 180738.0 181109.0 181328.1 181903.0 47858.3 48220.5 48296.8 48349.5 48433.3 49574.8 49668.8 49691.0 49978.5 50032.0 15306.4 15346.3 15403.8 15429.0 15446.3 10713.4 10876.8 12159.6 12588.8 12600.4 13570.8 13575.7 13651.5 13818.1 13826.1 5160.5 5194.7 5240.2 5258.0 5299.0 1062.8 1100.8 1109.4 1110.3 1122.1 25726.7 25736.2 25751.2 25778.9 26043.6 1156.4 1170.8 1186.9 1201.6 1204.4 13077.3 13620.7 13758.7 13848.6 13883.7 240816.0 242643.0 243010.0 243082.0 244152.0 51664.5 51772.0 51840.7 51948.5 52035.0 1450.8 1473.9 1488.4 1492.4 1520.5 23352.2 24565.3 24667.3 24935.8 24940.1 37656.6 48083.5 49014.8 49032.3 49118.3 153953.0 154112.0 154144.0 154163.2 154212.0 28336.7 28701.6 31523.2 31757.4 31934.5 40058.6 40282.2 40352.0 40564.8 40629.6 30178.8 30384.6 30889.4 31278.4 31462.8 29957.7 30034.8 30877.0 31210.7 31469.4 34734.8 35292.6 35600.5 35622.5 35689.9 29006.0 29308.6 29477.9 29906.7 30707.2 22924.9 24581.6 24598.5 24827.3 24925.9 09:58:07 INFO - PID 11595 | 09:58:07 INFO - PID 11595 | [#2] jquery.html Cycles:180 Average:34100.04 Median:22570.44 stddev:94788.37 (420.0%) stddev-sans-first:95020.59 09:58:07 INFO - PID 11595 | Values: 444.5 448.3 454.1 465.3 473.3 16755.8 17280.4 21226.9 21924.7 22559.4 22348.6 22445.0 22581.4 22740.1 22906.0 5806.3 6062.6 6070.8 6076.4 6077.3 3716.4 5896.1 6080.1 6092.8 6188.7 3784.7 5827.4 6045.0 6047.5 6049.4 6018.6 6020.0 6044.5 6052.6 6083.8 5432.3 5450.2 5451.3 5453.9 5455.5 25698.5 26367.0 26443.6 26471.1 26648.5 2183.5 2209.7 2210.9 2213.7 2214.7 16548.7 17222.4 17367.6 17383.2 17469.8 2277.9 2327.5 2345.1 2351.2 2359.0 109950.5 115101.4 116219.0 116289.4 116769.4 11598.5 12030.8 12075.8 12084.3 12190.3 16701.2 16741.5 16748.6 16764.7 16786.9 8401.4 8790.5 8826.0 8937.7 9020.5 8239.1 8332.1 8347.1 8558.7 8619.8 7682.7 7706.4 7764.9 7791.5 7831.8 2177.9 2250.5 2265.3 2288.8 2372.3 860.7 890.7 973.4 1025.3 1040.3 20033.4 21166.8 21281.0 21393.8 21510.7 1077.8 1088.1 1090.6 1094.5 1099.8 11118.7 11528.6 11545.0 11600.2 11651.5 566761.0 568831.0 571832.0 573920.0 576298.0 105254.0 108728.5 109712.5 113186.4 113254.0 1162.6 1222.3 1237.5 1251.2 1258.5 16739.4 16918.5 17312.6 17431.1 18217.8 48623.8 49282.3 49915.0 50165.7 50515.5 64109.0 65321.7 66438.7 66770.7 68187.0 9186.1 9247.3 9299.3 9412.9 9600.2 14634.9 15294.4 15425.8 15566.2 15641.6 13169.7 13341.3 13349.9 13496.4 13608.6 11923.6 12085.9 12149.4 12190.7 12527.7 13062.8 13132.5 13157.1 13222.0 13245.6 9185.3 9358.6 9370.9 9747.4 9804.8 13033.9 13544.5 13573.9 13722.1 13855.7 09:58:07 INFO - PID 11595 | 09:58:07 INFO - PID 11595 | [#3] mootools.html Cycles:180 Average:6960.83 Median:2441.73 stddev:4454.69 (182.4%) stddev-sans-first:4447.03 09:58:07 INFO - PID 11595 | Values: 1321.1 1385.8 1410.7 1413.6 1420.0 11012.8 11476.2 11491.4 11493.0 11498.5 11159.2 11330.3 11682.5 11685.9 11690.6 2398.2 2428.3 2430.4 2432.8 2438.0 1984.4 2337.8 2397.5 2444.3 2447.7 2036.7 2364.2 2439.7 2443.8 2448.5 2305.0 2321.0 2329.7 2330.1 2401.5 2307.8 2336.6 2342.3 2348.0 2356.9 11085.9 11323.3 11324.0 11324.9 11331.8 6302.7 6498.0 6503.0 6504.0 6509.7 3795.0 3958.3 4073.3 4076.3 4131.8 1378.6 1385.6 1409.3 1431.8 1488.6 16814.4 16914.0 16928.2 16941.6 16971.9 5108.8 5111.1 5298.5 5345.3 5391.4 12343.7 12350.5 12351.3 12400.1 12401.7 6147.5 6166.7 6174.9 6180.4 6183.1 5765.5 5856.1 6011.6 6069.9 6101.4 4142.2 4150.9 4226.8 4228.5 4233.5 1023.9 1050.7 1174.4 1181.2 1216.6 852.2 874.5 886.1 900.4 917.1 6598.8 6604.9 6627.2 6649.4 6879.9 642.1 648.7 653.4 664.9 766.8 4056.8 4245.3 4260.6 4270.5 4293.2 13914.9 14578.9 14616.0 14616.3 14674.3 14159.8 14237.6 14305.3 14315.6 14359.5 10519.3 10543.6 10567.0 10584.6 10697.1 6449.0 6547.9 6577.5 6598.6 6803.5 12329.4 12697.7 12832.1 12952.4 13009.7 12942.6 13105.5 13124.6 13351.9 13363.2 8554.8 8766.6 8771.1 8774.2 8775.2 10126.6 10133.7 10138.5 10232.8 10259.5 6863.4 8288.8 8374.0 8401.0 8457.1 7857.2 8000.1 8006.0 8069.9 8107.4 8043.0 8200.1 8268.0 8281.8 8282.3 5904.6 6028.0 6064.9 6067.3 6307.4 5671.2 5687.6 5722.7 5783.9 5893.2 09:58:07 INFO - PID 11595 | 09:58:07 INFO - PID 11595 | [#4] prototype.html Cycles:180 Average:5085.10 Median:5805.11 stddev:1517.85 (26.1%) stddev-sans-first:1481.21 09:58:07 INFO - PID 11595 | Values: 421.9 428.7 432.2 432.3 433.9 5587.0 5755.6 5778.8 5791.1 5800.0 5723.5 5783.8 5785.2 5793.0 5798.2 4257.3 4324.0 4326.0 4337.7 4356.3 4359.9 4363.7 4375.0 4382.4 4387.3 4334.5 4345.5 4359.6 4360.0 4363.1 4165.9 4282.8 4308.7 4311.0 4347.2 3786.1 3787.1 3792.7 3794.7 3817.6 5580.9 5594.0 5599.3 5601.2 5607.2 4975.0 5066.3 5098.7 5120.5 5131.8 6029.8 6030.3 6049.6 6056.5 6072.6 4221.8 4255.2 4260.8 4261.7 4295.7 5989.8 6152.2 6205.3 6295.8 6350.8 4295.6 4356.4 4365.7 4386.8 4402.0 4430.8 4448.6 4452.6 4456.2 4459.1 4922.7 5010.3 5089.7 5097.9 5098.9 6004.0 6043.2 6074.2 6086.6 6112.4 1535.0 1556.5 1557.5 1567.7 1567.8 967.8 1021.5 1022.7 1042.9 1060.6 5831.9 5874.3 5876.0 5899.5 5912.4 6202.9 6205.3 6220.3 6224.3 6229.7 5638.8 5844.2 5889.3 5914.6 5920.6 3294.3 3310.9 3312.3 3314.6 3316.0 6343.5 6492.7 6525.2 6556.0 6593.1 6408.2 6416.0 6418.1 6421.8 6446.5 6262.3 6517.6 6521.3 6539.2 6543.2 6174.8 6248.9 6249.3 6254.8 6262.3 6204.6 6219.8 6247.9 6252.6 6253.5 5769.0 6155.5 6479.2 6508.8 6524.4 4417.9 4440.2 4444.4 4450.4 4461.2 6176.8 6285.5 6295.7 6295.9 6296.5 6060.5 6085.0 6101.9 6102.9 6130.3 5962.0 6038.2 6065.8 6130.0 6130.2 5998.8 6002.1 6021.9 6045.9 6050.9 6043.9 6084.1 6110.8 6119.7 6127.3 5810.2 5876.3 5918.7 5929.3 5995.9 09:58:07 INFO - PID 11595 | 09:58:07 INFO - PID 11595 | [#5] yui.html Cycles:180 Average:18958.58 Median:18855.03 stddev:23025.11 (122.1%) stddev-sans-first:23049.21 09:58:07 INFO - PID 11595 | Values: 776.1 864.8 886.1 892.2 898.9 13792.3 17175.7 17198.2 17818.6 17887.9 16465.8 16708.2 17178.5 17297.6 17479.2 988.4 1022.5 1024.2 1024.9 1025.8 725.4 744.4 987.3 1016.6 1020.5 1066.1 1068.1 1068.4 1068.5 1070.3 1058.0 1059.1 1059.1 1059.2 1063.5 767.1 774.6 775.0 777.1 780.4 15270.3 15438.2 15585.8 16921.2 17170.7 17239.1 17429.7 17640.7 17684.5 17896.7 14355.1 14596.9 14722.0 14862.4 14894.5 3387.8 3406.9 3411.1 3412.9 3418.4 82397.6 82682.0 83603.6 84265.6 84903.6 12949.5 12995.6 13066.2 13086.0 13123.1 18829.9 20771.8 20798.5 24862.0 24975.6 8618.7 8836.4 8913.9 8935.0 9276.8 4704.1 4731.6 4754.9 4783.9 4791.6 4399.3 4537.4 4553.6 4567.5 4571.7 939.7 966.5 983.6 983.8 985.9 720.6 723.7 731.5 734.3 766.6 11531.8 12635.6 12659.4 12818.6 12826.8 709.3 718.2 724.1 726.9 730.2 5489.3 5499.0 5620.4 5833.6 5864.9 81332.0 81416.0 81579.6 82258.0 86357.6 71522.6 73151.3 74209.3 76902.2 77565.6 63562.0 64961.0 65564.0 65673.7 65842.0 12269.8 13191.7 13476.5 13578.7 13593.5 31232.2 32058.8 32873.3 33271.5 33849.0 52504.0 53166.0 53946.2 53963.5 54191.7 16592.3 17063.8 17067.6 17109.7 17236.8 17189.3 17995.6 18419.0 18507.5 18880.2 15000.8 16873.7 16878.0 16946.7 17796.7 17463.8 17650.9 17753.3 17875.0 17907.1 16677.7 16808.9 17041.3 17060.9 17139.2 11924.8 11950.8 12174.6 12214.8 12550.1 12849.6 13326.9 13358.9 13408.1 13414.9 09:58:07 INFO - PID 11595 | -------- Summary: end -------- 09:58:07 INFO - PID 11595 | 09:58:08 INFO - TEST-INFO | 11595: exit 0 09:58:08 INFO - TEST-OK | dromaeo_css | took 1117146ms 09:58:08 INFO - TEST-START | kraken 09:58:08 INFO - operating with platform_type : linux_ 09:58:08 INFO - Initialising browser for kraken test... 09:58:08 INFO - TEST-INFO | started process 11917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUBiOyF/profile http://localhost:32796/getInfo.html) 09:58:12 INFO - PID 11917 | __metrics Screen width/height:1600/1200 09:58:12 INFO - PID 11917 | colorDepth:24 09:58:12 INFO - PID 11917 | Browser inner width/height: 1024/697 09:58:12 INFO - PID 11917 | __metrics 09:58:14 INFO - PID 11917 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:58:14 INFO - PID 11917 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:58:15 INFO - TEST-INFO | 11917: exit 0 09:58:15 INFO - Browser initialized. 09:58:15 INFO - Running cycle 1/1 for kraken test... 09:58:15 INFO - TEST-INFO | started process 12012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUBiOyF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:27 INFO - PID 12012 | RSS: Main: 150089728 09:58:27 INFO - PID 12012 | 09:58:29 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32796/tests/kraken/driver.html?testName=audio-beat-detection) 09:58:30 INFO - PID 12012 | RSS: Main: 205103104 09:58:30 INFO - PID 12012 | 09:58:33 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32796/tests/kraken/driver.html?testName=audio-dft) 09:58:33 INFO - PID 12012 | RSS: Main: 184381440 09:58:33 INFO - PID 12012 | 09:58:36 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32796/tests/kraken/driver.html?testName=audio-fft) 09:58:37 INFO - PID 12012 | RSS: Main: 266485760 09:58:37 INFO - PID 12012 | 09:58:39 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32796/tests/kraken/driver.html?testName=audio-oscillator) 09:58:40 INFO - PID 12012 | RSS: Main: 176644096 09:58:40 INFO - PID 12012 | 09:58:42 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32796/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:58:42 INFO - PID 12012 | RSS: Main: 180830208 09:58:42 INFO - PID 12012 | 09:58:45 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32796/tests/kraken/driver.html?testName=imaging-darkroom) 09:58:46 INFO - PID 12012 | RSS: Main: 220057600 09:58:46 INFO - PID 12012 | 09:58:49 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32796/tests/kraken/driver.html?testName=imaging-desaturate) 09:58:50 INFO - PID 12012 | RSS: Main: 231895040 09:58:50 INFO - PID 12012 | 09:58:53 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32796/tests/kraken/driver.html?testName=json-parse-financial) 09:58:53 INFO - PID 12012 | RSS: Main: 241561600 09:58:53 INFO - PID 12012 | 09:58:55 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32796/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:58:55 INFO - PID 12012 | RSS: Main: 182247424 09:58:55 INFO - PID 12012 | 09:58:57 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32796/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:58:58 INFO - PID 12012 | RSS: Main: 188542976 09:58:58 INFO - PID 12012 | 09:59:00 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32796/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:59:00 INFO - PID 12012 | RSS: Main: 198795264 09:59:00 INFO - PID 12012 | 09:59:03 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32796/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:59:04 INFO - PID 12012 | RSS: Main: 207171584 09:59:04 INFO - PID 12012 | 09:59:07 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32796/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:59:07 INFO - PID 12012 | RSS: Main: 204607488 09:59:07 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | Cycle 1(1): loaded http://localhost:32796/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32796/tests/kraken/driver.html?testName=ai-astar) 09:59:09 INFO - PID 12012 | RSS: Main: 273625088 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | __start_tp_report 09:59:09 INFO - PID 12012 | _x_x_mozilla_page_load 09:59:09 INFO - PID 12012 | _x_x_mozilla_page_load_details 09:59:09 INFO - PID 12012 | |i|pagename|runs| 09:59:09 INFO - PID 12012 | |0;ai-astar;107;110;111;110;111;112;111;109;110;110 09:59:09 INFO - PID 12012 | |1;audio-beat-detection;148;126;122;164;119;122;119;122;138;118 09:59:09 INFO - PID 12012 | |2;audio-dft;164;163;163;163;163;163;164;163;163;163 09:59:09 INFO - PID 12012 | |3;audio-fft;73;74;75;109;76;75;75;74;91;75 09:59:09 INFO - PID 12012 | |4;audio-oscillator;82;82;105;83;83;84;97;84;82;105 09:59:09 INFO - PID 12012 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;114;114;114 09:59:09 INFO - PID 12012 | |6;imaging-darkroom;149;149;149;150;149;150;149;149;148;150 09:59:09 INFO - PID 12012 | |7;imaging-desaturate;94;95;95;94;94;95;96;95;95;94 09:59:09 INFO - PID 12012 | |8;json-parse-financial;48;47;46;46;47;48;48;48;48;48 09:59:09 INFO - PID 12012 | |9;json-stringify-tinderbox;59;55;55;55;55;55;56;55;55;55 09:59:09 INFO - PID 12012 | |10;stanford-crypto-aes;84;93;84;84;85;83;83;90;84;83 09:59:09 INFO - PID 12012 | |11;stanford-crypto-ccm;135;134;139;130;128;128;135;134;196;131 09:59:09 INFO - PID 12012 | |12;stanford-crypto-pbkdf2;183;184;188;187;186;185;186;189;187;194 09:59:09 INFO - PID 12012 | |13;stanford-crypto-sha256-iterative;67;67;68;66;65;65;65;67;65;65 09:59:09 INFO - PID 12012 | __end_tp_report 09:59:09 INFO - PID 12012 | __start_cc_report 09:59:09 INFO - PID 12012 | _x_x_mozilla_cycle_collect,1813 09:59:09 INFO - PID 12012 | __end_cc_report 09:59:09 INFO - PID 12012 | __startTimestamp1491757149818__endTimestamp 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | ------- Summary: start ------- 09:59:09 INFO - PID 12012 | Number of tests: 14 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:1.37 (1.2%) stddev-sans-first:0.88 09:59:09 INFO - PID 12012 | Values: 107.0 110.0 111.0 110.0 111.0 112.0 111.0 109.0 110.0 110.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:124.00 stddev:15.41 (12.4%) stddev-sans-first:14.87 09:59:09 INFO - PID 12012 | Values: 148.0 126.0 122.0 164.0 119.0 122.0 119.0 122.0 138.0 118.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 09:59:09 INFO - PID 12012 | Values: 164.0 163.0 163.0 163.0 163.0 163.0 164.0 163.0 163.0 163.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#3] audio-fft Cycles:10 Average:79.70 Median:75.00 stddev:11.54 (15.4%) stddev-sans-first:11.98 09:59:09 INFO - PID 12012 | Values: 73.0 74.0 75.0 109.0 76.0 75.0 75.0 74.0 91.0 75.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:83.00 stddev:9.68 (11.7%) stddev-sans-first:9.96 09:59:09 INFO - PID 12012 | Values: 82.0 82.0 105.0 83.0 83.0 84.0 97.0 84.0 82.0 105.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:59:09 INFO - PID 12012 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:59:09 INFO - PID 12012 | Values: 149.0 149.0 149.0 150.0 149.0 150.0 149.0 149.0 148.0 150.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 09:59:09 INFO - PID 12012 | Values: 94.0 95.0 95.0 94.0 94.0 95.0 96.0 95.0 95.0 94.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#8] json-parse-financial Cycles:10 Average:47.40 Median:48.00 stddev:0.84 (1.8%) stddev-sans-first:0.87 09:59:09 INFO - PID 12012 | Values: 48.0 47.0 46.0 46.0 47.0 48.0 48.0 48.0 48.0 48.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.00 stddev:1.27 (2.3%) stddev-sans-first:0.33 09:59:09 INFO - PID 12012 | Values: 59.0 55.0 55.0 55.0 55.0 55.0 56.0 55.0 55.0 55.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.00 stddev:3.40 (4.0%) stddev-sans-first:3.57 09:59:09 INFO - PID 12012 | Values: 84.0 93.0 84.0 84.0 85.0 83.0 83.0 90.0 84.0 83.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:134.50 stddev:20.33 (15.1%) stddev-sans-first:21.51 09:59:09 INFO - PID 12012 | Values: 135.0 134.0 139.0 130.0 128.0 128.0 135.0 134.0 196.0 131.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.90 Median:187.00 stddev:3.07 (1.6%) stddev-sans-first:2.92 09:59:09 INFO - PID 12012 | Values: 183.0 184.0 188.0 187.0 186.0 185.0 186.0 189.0 187.0 194.0 09:59:09 INFO - PID 12012 | 09:59:09 INFO - PID 12012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.15 (1.7%) stddev-sans-first:1.17 09:59:09 INFO - PID 12012 | Values: 67.0 67.0 68.0 66.0 65.0 65.0 65.0 67.0 65.0 65.0 09:59:09 INFO - PID 12012 | -------- Summary: end -------- 09:59:09 INFO - PID 12012 | 09:59:11 INFO - TEST-INFO | 12012: exit 0 09:59:11 INFO - TEST-OK | kraken | took 62795ms 09:59:11 INFO - SUITE-END | took 1179s 09:59:11 INFO - Completed test suite (00:19:40) 09:59:11 INFO - javascript benchmark 09:59:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7658.172225480683, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3341.949870751939, 3364.1421437533427, 3378.1892345837005, 3382.2051817822794, 3415.8975230743085, 5543.77824887004, 5701.116326969326, 5807.477327040566, 5883.264591926009, 5899.557533185012, 5834.795782147626, 5836.124581312805, 5849.239598852154, 5913.970430147854, 5923.85190370241, 5036.597072234213, 5047.596192304625, 5103.489651034894, 5205.765740541685, 5237.188235823453, 5208.895822083556, 5240.318758561381, 5274.973625131888, 5278.076336641092, 5337.572994160458, 4985.152524070917, 5036.093503169428, 5131.102057139986, 5193.9740301298625, 5194.194899790538, 5058.924116138261, 5071.858831762824, 5135.922961155586, 5166.483351664841, 5200.635955483118, 4997.275395067695, 5092.9745351273, 5107.565856902168, 5134.4095429025765, 5135.666181698178, 5526.944730552683, 5608.298962629671, 5622.269105016363, 5786.88426231473, 5788.450097240798, 6148.815535533941, 6242.719077641517, 6255.843603909939, 6287.748490060392, 6301.810945671591, 6291.874162516724, 6300.30696623371, 6344.0, 6372.776952806676, 6378.553501254914, 5608.10270356741, 5808.273965754281, 5875.030619947661, 5876.471117599436, 5877.206577112035, 6242.719077641426, 6383.872322553616, 6433.38882806142, 6480.0, 6484.773032943825, 5993.280806303272, 6061.333253342217, 6073.939260607426, 6128.1726966858905, 6162.815115546541, 6200.844978875564, 6266.122742816009, 6280.089387038854, 6299.685015749286, 6300.873982520324, 6231.345708700521, 6235.220597425322, 6242.063690446378, 6248.875022499525, 6252.343503932022, 6032.607880487842, 6096.7081148910665, 6117.431594453911, 6189.0, 6259.499240060784, 4802.327674125625, 4807.110684523374, 4809.0862736080035, 4823.686460380064, 4843.854684359404, 4255.76593287366, 4256.489221293465, 4262.573742625775, 4286.978565107154, 4298.26929421999, 5601.271834661468, 5686.14707793826, 5821.27234095738, 5850.648961062265, 5851.180834683148, 6285.968570157212, 6321.557490975588, 6340.714667839959, 6342.080398342307, 6345.0, 5891.46976772084, 5901.881962360729, 5903.911441328383, 5905.557083218776, 5908.497777688859, 5198.92201616976, 5271.894562108813, 5363.19552067193, 5402.459754024566, 5424.918626220609, 6509.218893732687, 6642.302558231316, 6645.169353830771, 6647.102641143384, 6648.700808463631, 6308.684565771785, 6354.7140378684, 6380.042993551005, 6386.201724784402, 6389.2971773105855, 6143.849652621547, 6602.966985165043, 6641.966790166019, 6643.634600097041, 6649.168853893263, 6013.218281623361, 6090.269167699727, 6099.672983688876, 6125.23545181825, 6191.783287584913, 6262.2172228471445, 6288.434040936338, 6296.968515157395, 6297.338779428094, 6302.464290535356, 5837.241158649348, 5860.765569377178, 5916.526677865846, 6121.3878612140215, 6121.908171377522, 6013.248343957005, 6107.977837958849, 6108.144859719731, 6128.411459112376, 6139.3553676863285, 6119.204503414706, 6141.056449558148, 6154.723037463235, 6167.475764560063, 6172.938270617416, 6168.9691551541955, 6199.070139479114, 6199.876002479835, 6205.410486003822, 6205.844853878509, 5742.19609254713, 5828.154917537018, 5988.37122102173, 5991.054848950721, 5997.460228579449], "value": 5727.285375773191, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.1591669579982, 797.2107613462671, 815.4943934760449, 1094.2723089145718, 1104.0560320925604, 30077.548836767437, 38119.42820857686, 38754.0, 38815.0, 38851.61148388515, 40662.39006414906, 41003.79498102505, 41004.384934225935, 41040.17919641605, 41065.58934410655, 6169.568130230886, 6314.810555683337, 8077.636506357228, 8231.95884020579, 8235.341172706168, 8035.276825085741, 8226.218509241613, 8228.917710822874, 8231.83536329273, 8238.299744521722, 8111.634976426046, 8178.918210817875, 8188.877166842472, 8189.262966333029, 8201.630926608317, 8127.187281271885, 8139.104698483162, 8158.918410815934, 8176.141505141994, 8185.754427367158, 8114.148014458515, 8191.221833925827, 8193.50838949665, 8203.753887383387, 8237.711680091168, 37784.622153778386, 37842.0, 37975.240495189944, 37975.24049519022, 38011.61988380108, 3479.704225140866, 3502.6322236165092, 3516.507688923553, 3520.1903562180587, 3522.049046757387, 29863.0, 29953.251168720955, 29991.700082999327, 29997.850010750026, 30016.8499157505, 3956.920861582781, 3964.484616999772, 3976.483057202574, 3981.163955569334, 3985.980070099631, 180151.0, 180738.0, 181109.0, 181328.09335953367, 181903.0, 47858.28212576814, 48220.517794822306, 48296.75851620719, 48349.51650483521, 48433.273500897514, 49574.75212623914, 49668.75165624221, 49691.0, 49978.50021499739, 50032.0, 15306.387744490095, 15346.309416076303, 15403.845961540464, 15429.0, 15446.304916278794, 10713.410762407986, 10876.836847447295, 12159.574414895436, 12588.81116783249, 12600.4329805159, 13570.796438053438, 13575.66060848467, 13651.453941842215, 13818.101823381448, 13826.101303415246, 5160.483951604884, 5194.68831870089, 5240.187770895517, 5258.0, 5298.97350513245, 1062.7661914378825, 1100.785346857355, 1109.3842917181041, 1110.306058713304, 1122.147168152194, 25726.74273257281, 25736.227913162635, 25751.227463176136, 25778.871105644354, 26043.609345859826, 1156.4160099149876, 1170.789257933563, 1186.9109816763605, 1201.5581302436935, 1204.3857632607433, 13077.280749558866, 13620.727585448236, 13758.729809581508, 13848.584542463743, 13883.722325553432, 240816.0, 242643.0, 243010.0, 243082.0, 244152.0, 51664.48335516597, 51772.0, 51840.74079629578, 51948.48051519512, 52035.0, 1450.7751298548953, 1473.8820894328428, 1488.3525666334963, 1492.417956996772, 1520.4906356370739, 23352.18267360634, 24565.263042108767, 24667.25998220056, 24935.75064249407, 24940.12709555157, 37656.623433765315, 48083.519164807905, 49014.75492622514, 49032.26451603157, 49118.26322605092, 153953.0, 154112.0, 154144.0, 154163.22918385337, 154212.0, 28336.716632834232, 28701.56947645745, 31523.21191970219, 31757.364852702354, 31934.52098218575, 40058.599414006654, 40282.19435611213, 40352.0, 40564.79717601393, 40629.59370406258, 30178.84910575521, 30384.634473174498, 30889.382212355176, 31278.37443251168, 31462.842685787342, 29957.700422996364, 30034.84982575073, 30877.0, 31210.68789312078, 31469.37061258716, 34734.826325868205, 35292.64707352893, 35600.46599300961, 35622.465663014555, 35689.8956619992, 29006.0, 29308.560371594016, 29477.85261073681, 29906.70093299126, 30707.2323191922, 22924.885375573016, 24581.63127553124, 24598.50802983966, 24827.255182344557, 24925.875370623755], "value": 16964.791597704767, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.4932776634637, 448.2603703888585, 454.1212753322321, 465.3066930273892, 473.3113320119229, 16755.83244167558, 17280.395186168487, 21226.89386553067, 21924.671129933064, 22559.436014099654, 22348.553028939412, 22445.0, 22581.435464113405, 22740.090396384167, 22906.0, 5806.274215723024, 6062.636241825505, 6070.757169713206, 6076.422739839731, 6077.270727512682, 3716.4053751399783, 5896.115582662592, 6080.14877917092, 6092.847678808021, 6188.690565471731, 3784.6593806557403, 5827.446392592697, 6044.9697751511185, 6047.516198704093, 6049.395060493937, 6018.615718384796, 6020.0, 6044.455998960093, 6052.606580572271, 6083.8174854754425, 5432.293801805779, 5450.209719590677, 5451.2640793493165, 5453.863653408657, 5455.509004189602, 25698.48603027929, 26367.0, 26443.603345949825, 26471.073512426974, 26648.467030659278, 2183.530540933691, 2209.701690271825, 2210.9447263818374, 2213.701150344715, 2214.745304290011, 16548.669026619402, 17222.397216097503, 17367.565810854703, 17383.217755201047, 17469.825301746947, 2277.9316620501413, 2327.453048533593, 2345.061975209913, 2351.1895840202947, 2359.0, 109950.45024774825, 115101.42449287784, 116219.0, 116289.41855290669, 116769.41615291954, 11598.536058557733, 12030.759384812254, 12075.758484830254, 12084.335361555199, 12190.329531875655, 16701.164941752864, 16741.49775506737, 16748.58128546796, 16764.664706705797, 16786.916065419595, 8401.36989725773, 8790.472571645721, 8825.955870220609, 8937.73186804397, 9020.548972551345, 8239.052508961426, 8332.083620767258, 8347.081820999685, 8558.657653693906, 8619.827603447897, 7682.7311044113185, 7706.422018348534, 7764.883526747103, 7791.532508049535, 7831.849119966427, 2177.9237726679808, 2250.5386395788823, 2265.2524666860227, 2288.7940085392393, 2372.2883135059415, 860.694453469022, 890.7416849113814, 973.3673112476805, 1025.3489034463169, 1040.2977989856815, 20033.398998030083, 21166.78833211679, 21281.0, 21393.78606213949, 21510.677339839916, 1077.8221593436995, 1088.1077516436446, 1090.607381342716, 1094.5348227003492, 1099.769048499824, 11118.722031949104, 11528.59649912249, 11545.0, 11600.245984011011, 11651.475683594259, 566761.0, 568831.0, 571832.0, 573920.0, 576298.0, 105254.0, 108728.4563577177, 109712.45143774389, 113186.43406782913, 113254.0, 1162.604714397109, 1222.3032871263472, 1237.5421094195206, 1251.2367455851922, 1258.4903114238748, 16739.414120505724, 16918.492445226664, 17312.567185820455, 17431.128443577516, 18217.817821822144, 48623.75688121678, 49282.26076608782, 49915.00169996507, 50165.74917125391, 50515.49484505108, 64109.0, 65321.673391632736, 66438.66780666065, 66770.66614666895, 68187.0, 9186.127317904788, 9247.306452015991, 9299.30255230874, 9412.858807117762, 9600.231981441328, 14634.853651463349, 15294.388224470897, 15425.84574154289, 15566.198084344927, 15641.608959776097, 13169.670758231121, 13341.332933353488, 13349.933250333686, 13496.392662330416, 13608.591742247749, 11923.642290731292, 12085.879141208827, 12149.392530373269, 12190.6952326189, 12527.749445011232, 13062.80405793933, 13132.540361087316, 13157.144785588906, 13222.008349373644, 13245.602631921058, 9185.311101667536, 9358.578863951003, 9370.906290937004, 9747.366421182884, 9804.754881128029, 13033.934830325788, 13544.525941591997, 13573.932130339284, 13722.108062976275, 13855.722885542435], "value": 10387.326254842963, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.1412581821814, 1385.840628327742, 1410.6967002094548, 1413.5759272218336, 1419.9858001419996, 11012.834807477884, 11476.196666233367, 11491.367974761406, 11493.0, 11498.482568284417, 11159.218854680155, 11330.263532870358, 11682.47428865701, 11685.941570292158, 11690.590829320976, 2398.2445529658144, 2428.2836563213896, 2430.3924018995253, 2432.7567243275707, 2437.9512409751796, 1984.4046785964226, 2337.7895989360954, 2397.4845408237225, 2444.291155564884, 2447.6940382452194, 2036.6843139313355, 2364.243442098529, 2439.7072351317865, 2443.7556244375596, 2448.5470188015183, 2305.0, 2321.0367697405554, 2329.6505524171425, 2330.1029103795076, 2401.4836810085917, 2307.7576854430213, 2336.5794157051723, 2342.320726989171, 2347.97652023481, 2356.882155892216, 11085.889141108566, 11323.320600763898, 11324.0, 11324.886751132466, 11331.773364532663, 6302.653354065525, 6498.02529620556, 6503.0, 6504.0, 6509.707063182168, 3794.9620503794886, 3958.3270843956598, 4073.2871747444374, 4076.286649836267, 4131.834726610932, 1378.5657517881934, 1385.591250581081, 1409.3164815064788, 1431.7852322151657, 1488.642725745824, 16814.411495597597, 16914.0, 16928.153592320457, 16941.57646058846, 16971.915140424342, 5108.770105345268, 5111.080005598954, 5298.496642818926, 5345.251664766935, 5391.35303763543, 12343.6914077147, 12350.505979760708, 12351.25892446438, 12400.13199076056, 12401.689957751129, 6147.477464415575, 6166.660833654192, 6174.938250617436, 6180.381961803783, 6183.072539119168, 5765.4522820332, 5856.092305692539, 6011.609245399035, 6069.878602428015, 6101.389861013863, 4142.212979533939, 4150.91698166035, 4226.76752778594, 4228.450301460791, 4233.470816147981, 1023.9129673977795, 1050.7163065972145, 1174.395186478964, 1181.2144923625865, 1216.5559570756786, 852.2457625001917, 874.4884242717955, 886.1006078829993, 900.4102312985005, 917.1378903830378, 6598.8350291243105, 6604.900926486107, 6627.1716035495565, 6649.368310010638, 6879.862402751917, 642.0818229931243, 648.6918713610997, 653.3531803514486, 664.9002649602598, 766.7967988483057, 4056.7971601419813, 4245.299525578307, 4260.616544511009, 4270.466191726035, 4293.184294983943, 13914.930425347808, 14578.854211457961, 14616.0, 14616.26918654063, 14674.339654715563, 14159.78760318596, 14237.644058898402, 14305.28473576317, 14315.642108947359, 14359.497417590333, 10519.263651544472, 10543.630972916064, 10567.0, 10584.629537966288, 10697.090747286567, 6449.0, 6547.869042619026, 6577.473802095725, 6598.60408375499, 6803.523753337219, 12329.383530823243, 12697.746045079231, 12832.101752877583, 12952.41714122848, 13009.739805204032, 12942.611721648365, 13105.475780969036, 13124.606261812161, 13351.933240333736, 13363.198208107544, 8554.786130346542, 8766.60550275252, 8771.07903670131, 8774.210321071134, 8775.166359195866, 10126.645567405105, 10133.746656333651, 10138.49307534635, 10232.846507302247, 10259.487025648838, 6863.382295593221, 8288.792780180544, 8374.0, 8401.0, 8457.112003239572, 7857.214278572097, 8000.119986801564, 8006.0, 8069.878951815845, 8107.4324797263625, 8042.9597852010365, 8200.05699344583, 8268.007839059352, 8281.83436331282, 8282.254597086292, 5904.61619994699, 6028.0, 6064.939350606437, 6067.332593414632, 6307.400796924285, 5671.234383358194, 5687.578105473632, 5722.74247658848, 5783.884322313615, 5893.2044174035955], "value": 5224.6653029592935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.8755467137194, 428.7448967864121, 432.1853306517214, 432.26730691477957, 433.8892435365465, 5586.972065139668, 5755.640187523117, 5778.768849246036, 5791.07342825148, 5799.971000144993, 5723.54211663066, 5783.82648520544, 5785.16115163301, 5793.0, 5798.217240672508, 4257.2549803784295, 4323.956760432387, 4326.0, 4337.7180483268485, 4356.324769660708, 4359.934600980988, 4363.716358436692, 4375.015621485172, 4382.408374869384, 4387.319965405367, 4334.479862416514, 4345.478542574895, 4359.629431498311, 4359.956400435986, 4363.0619416825375, 4165.937510937353, 4282.764447955361, 4308.719933204332, 4311.0, 4347.152305300468, 3786.148116673754, 3787.0721673190246, 3792.715546334036, 3794.677452416548, 3817.5991520890184, 5580.91628625571, 5594.0, 5599.300087489064, 5601.187827764951, 5607.158926161109, 4975.0, 5066.265391518209, 5098.668586541863, 5120.513551212629, 5131.846044618667, 6029.849253768647, 6030.306514750816, 6049.580167932818, 6056.5457590680435, 6072.605280656788, 4221.831126754957, 4255.234057869582, 4260.829566817354, 4261.680373971964, 4295.6778241632, 5989.765526615623, 6152.169457123276, 6205.3484384139465, 6295.779647712354, 6350.809475715736, 4295.613394794421, 4356.411884395629, 4365.716228445204, 4386.846460373871, 4401.955980440219, 4430.756308403004, 4448.55514448559, 4452.554744525586, 4456.242438785414, 4459.063596644676, 4922.704637721748, 5010.2735103409805, 5089.694618322913, 5097.890286924973, 5098.878246785701, 6004.0, 6043.244594425697, 6074.240719910012, 6086.604370715978, 6112.449879510866, 1535.0, 1556.47079992803, 1557.462675376993, 1567.6786258816915, 1567.7569976653638, 967.8016006718606, 1021.4892553723139, 1022.7085280694967, 1042.9165666746642, 1060.5969731502134, 5831.941680583224, 5874.295084589877, 5875.970620146872, 5899.4985426239255, 5912.374097123326, 6202.937970620236, 6205.348438413992, 6220.315765265817, 6224.253089629274, 6229.7293920692, 5638.802641907596, 5844.1818145459665, 5889.293284805851, 5914.58597898143, 5920.615160014585, 3294.3081952789703, 3310.8841190558214, 3312.337532493511, 3314.6022477302877, 3315.9834200829323, 6343.492520598341, 6492.6690028544035, 6525.151730275129, 6555.967220163869, 6593.142891424084, 6408.231012278557, 6416.0, 6418.101465794793, 6421.839454013687, 6446.4520515756685, 6262.3111457738705, 6517.641529715816, 6521.315261897527, 6539.2479864815205, 6543.214814222324, 6174.753009879554, 6248.8752024636005, 6249.25008998923, 6254.8123556293385, 6262.34245404226, 6204.5967012144065, 6219.813405597839, 6247.875042499034, 6252.562320637512, 6253.530985176039, 5768.961586914228, 6155.507559395327, 6479.157709497735, 6508.8047358579315, 6524.445422139172, 4417.933730994102, 4440.2229609817505, 4444.444444444444, 4450.443694538183, 4461.219286624892, 6176.81469555914, 6285.528585356208, 6295.748170073146, 6295.937040629535, 6296.496280297657, 6060.545459090674, 6085.04472093143, 6101.938980610137, 6102.908456373247, 6130.295016073031, 5961.970190149022, 6038.184845046038, 6065.848353791191, 6129.977107554586, 6130.172426722335, 5998.790042348672, 6002.129691194839, 6021.909671354845, 6045.879082418415, 6050.878982420415, 6043.912095822794, 6084.087386892002, 6110.755569777337, 6119.663418512025, 6127.29536103336, 5810.244668193108, 5876.324222714443, 5918.674472903859, 5929.258842644669, 5995.940040599538], "value": 4621.589529605341, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.1384862802284, 864.8313578852122, 886.1050339157451, 892.2014796756903, 898.8651702244663, 13792.310384480774, 17175.65648687027, 17198.226079826407, 17818.64362712745, 17887.910560447195, 16465.753013704805, 16708.248128834202, 17178.484645460623, 17297.567560810956, 17479.213435395406, 988.3871999360407, 1022.4938655365568, 1024.2062401638716, 1024.8718910136233, 1025.8358662613982, 725.365305357812, 744.359850528545, 987.3384832162433, 1016.5832008876362, 1020.494855046753, 1066.109798318405, 1068.1188019883589, 1068.3536460441399, 1068.5298468673798, 1070.261519551507, 1058.0319008107572, 1059.0521483272466, 1059.0627294844041, 1059.1685526861454, 1063.478895341285, 767.1369709077288, 774.6359211170741, 774.9806254843618, 777.1451403456153, 780.4224873593556, 15270.31283592241, 15438.150901700403, 15585.844141558553, 16921.238544265536, 17170.742438863428, 17239.138043097795, 17429.651406971916, 17640.735388969177, 17684.46946591604, 17896.731549026776, 14355.138691678532, 14596.87045814381, 14722.0, 14862.405503779835, 14894.478693245792, 3387.796732196076, 3406.931861362784, 3411.096059544223, 3412.9488057679155, 3418.3505134024454, 82397.58801205955, 82682.0, 83603.5819820897, 84265.57867210686, 84903.57548212219, 12949.54676586315, 12995.610131696065, 13066.216027038408, 13086.0, 13123.081384303006, 18829.90585047066, 20771.792282077287, 20798.480037999172, 24862.0, 24975.62536561953, 8618.741437756877, 8836.381453298207, 8913.866292005625, 8935.017148113702, 9276.814463710689, 4704.129735998851, 4731.550502702238, 4754.904901901942, 4783.880402989884, 4791.5687588117235, 4399.25212713833, 4537.410136682276, 4553.635709143261, 4567.520410356931, 4571.6799824012, 939.6852054561662, 966.5457235099492, 983.6114734679761, 983.8327484327682, 985.8767654043245, 720.6072690383753, 723.6779633063342, 731.5464412064448, 734.3170851108414, 766.6320166320197, 11531.76936461266, 12635.620931372074, 12659.430325635369, 12818.61544153677, 12826.80759788604, 709.2765379313072, 718.1992078832064, 724.1057294241607, 726.8546290741873, 730.2478447199393, 5489.2589500417735, 5498.972505137449, 5620.353659329147, 5833.591648584558, 5864.882702345929, 81332.0, 81416.0, 81579.59210203911, 82258.0, 86357.56821215854, 71522.64238678878, 73151.26848731445, 74209.25790742024, 76902.23097768951, 77565.61217193877, 63562.0, 64961.02558461627, 65564.0, 65673.67163164154, 65842.0, 12269.815952760537, 13191.67020824487, 13476.46094156262, 13578.728425431633, 13593.45626174942, 31232.21919452032, 32058.83970580132, 32873.342533149684, 33271.50092748659, 33849.0, 52504.0, 53166.0, 53946.19080713871, 53963.46036539584, 54191.72904135454, 16592.336306547604, 17063.829361706223, 17067.573310667332, 17109.657806843545, 17236.82763172352, 17189.31242750276, 17995.640087198444, 18419.0, 18507.53731156678, 18880.150393232063, 15000.774988374966, 16873.662526749642, 16878.0, 16946.745798812783, 17796.733049004535, 17463.825361746727, 17650.91174544119, 17753.289868405118, 17875.0, 17907.10464476797, 16677.749833752747, 16808.915955420143, 17041.318347266468, 17060.91469542694, 17139.228734707216, 11924.821127682919, 11950.820737689115, 12174.634760957186, 12214.816777748518, 12550.121491495873, 12849.614511564669, 13326.86673133295, 13358.866411335763, 13408.061435699798, 13414.932925335312], "value": 8276.891612191206, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1509.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 111.0, 110.0, 111.0, 112.0, 111.0, 109.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 126.0, 122.0, 164.0, 119.0, 122.0, 119.0, 122.0, 138.0, 118.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 163.0, 163.0, 163.0, 164.0, 163.0, 163.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 109.0, 76.0, 75.0, 75.0, 74.0, 91.0, 75.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 105.0, 83.0, 83.0, 84.0, 97.0, 84.0, 82.0, 105.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 150.0, 149.0, 150.0, 149.0, 149.0, 148.0, 150.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 46.0, 46.0, 47.0, 48.0, 48.0, 48.0, 48.0, 48.0], "value": 47.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 93.0, 84.0, 84.0, 85.0, 83.0, 83.0, 90.0, 84.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 139.0, 130.0, 128.0, 128.0, 135.0, 134.0, 196.0, 131.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 188.0, 187.0, 186.0, 185.0, 186.0, 189.0, 187.0, 194.0], "value": 186.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 65.0, 65.0, 65.0, 67.0, 65.0, 65.0], "value": 66.0, "unit": "score"}]}]} 09:59:11 INFO - Return code: 0 09:59:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:59:11 ERROR - # TBPL SUCCESS # 09:59:11 INFO - Running post-action listener: _resource_record_post_action 09:59:11 INFO - [mozharness: 2017-04-09 16:59:11.652894Z] Finished run-tests step (success) 09:59:11 INFO - Running post-run listener: _resource_record_post_run 09:59:11 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 362205184; Read time: 0; Write time: 378788 09:59:11 INFO - TinderboxPrint: CPU usage
13.0% 09:59:11 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:59:11 INFO - TinderboxPrint: I/O write bytes / time
362,205,184 / 378,788 09:59:11 INFO - TinderboxPrint: CPU idle
8,311.6 (87.0%) 09:59:11 INFO - TinderboxPrint: CPU user
1,192.2 (12.5%) 09:59:11 INFO - TinderboxPrint: Swap in / out
0 / 0 09:59:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106962944; Read time: 0; Write time: 159508 09:59:11 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 254799872; Read time: 0; Write time: 219244 09:59:12 INFO - Running post-run listener: _upload_blobber_files 09:59:12 INFO - Blob upload gear active. 09:59:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:59:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:59:12 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'] 09:59:12 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 09:59:12 INFO - (blobuploader) - INFO - Open directory for files ... 09:59:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:59:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:59:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:13 INFO - (blobuploader) - INFO - Done attempting. 09:59:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:59:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:59:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:16 INFO - (blobuploader) - INFO - Done attempting. 09:59:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:59:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:59:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:17 INFO - (blobuploader) - INFO - Done attempting. 09:59:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:59:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:59:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:18 INFO - (blobuploader) - INFO - Done attempting. 09:59:18 INFO - (blobuploader) - INFO - Iteration through files over. 09:59:18 INFO - Return code: 0 09:59:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:59:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:59:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61834b09ab91491a15b37831494bc06d1c5b979db8ed4666f31760586a5ea9cc25cda9a49826f651862f0b45fca1b62f7f57f83f202f5497d152248522fe15a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0173d60eaeb338f16e5e14ff8dd85e7a183c262332e4cbedafed29c9c253a67bc49161135d11fe1465093aa9299cdc9f1b91e9f397e9530c6a904f871fe4f48", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/718e8249ac0182ea303e6f37a8ec06d3461dca3754029193ce7736af1e7a3a1d4de2fb3b1aebd691bb717029b1b6708790054d3d16be6fa3ff7f87ce254133ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6af340b25a6c8b0e98864ee3ef95d5b1bf0f6503d85cce932a223ee3111f197a94b410dd4f93868440af78b0e03d9e700a7d64056a5f778b790078ab796a900f"} 09:59:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:59:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:59:18 INFO - Contents: 09:59:18 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61834b09ab91491a15b37831494bc06d1c5b979db8ed4666f31760586a5ea9cc25cda9a49826f651862f0b45fca1b62f7f57f83f202f5497d152248522fe15a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0173d60eaeb338f16e5e14ff8dd85e7a183c262332e4cbedafed29c9c253a67bc49161135d11fe1465093aa9299cdc9f1b91e9f397e9530c6a904f871fe4f48", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/718e8249ac0182ea303e6f37a8ec06d3461dca3754029193ce7736af1e7a3a1d4de2fb3b1aebd691bb717029b1b6708790054d3d16be6fa3ff7f87ce254133ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6af340b25a6c8b0e98864ee3ef95d5b1bf0f6503d85cce932a223ee3111f197a94b410dd4f93868440af78b0e03d9e700a7d64056a5f778b790078ab796a900f"} 09:59:18 INFO - Running post-run listener: copy_logs_to_upload_dir 09:59:18 INFO - Copying logs to upload dir... 09:59:18 INFO - mkdir: /builds/slave/test/build/upload/logs 09:59:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.114428 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-04-09 09:59:17.920086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 09:59:17.923657) ========= 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=df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710 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/61834b09ab91491a15b37831494bc06d1c5b979db8ed4666f31760586a5ea9cc25cda9a49826f651862f0b45fca1b62f7f57f83f202f5497d152248522fe15a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0173d60eaeb338f16e5e14ff8dd85e7a183c262332e4cbedafed29c9c253a67bc49161135d11fe1465093aa9299cdc9f1b91e9f397e9530c6a904f871fe4f48", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/718e8249ac0182ea303e6f37a8ec06d3461dca3754029193ce7736af1e7a3a1d4de2fb3b1aebd691bb717029b1b6708790054d3d16be6fa3ff7f87ce254133ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6af340b25a6c8b0e98864ee3ef95d5b1bf0f6503d85cce932a223ee3111f197a94b410dd4f93868440af78b0e03d9e700a7d64056a5f778b790078ab796a900f"} build_url:https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/Owjaf1i2T5e8qb5tE98_Bg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61834b09ab91491a15b37831494bc06d1c5b979db8ed4666f31760586a5ea9cc25cda9a49826f651862f0b45fca1b62f7f57f83f202f5497d152248522fe15a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0173d60eaeb338f16e5e14ff8dd85e7a183c262332e4cbedafed29c9c253a67bc49161135d11fe1465093aa9299cdc9f1b91e9f397e9530c6a904f871fe4f48", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/718e8249ac0182ea303e6f37a8ec06d3461dca3754029193ce7736af1e7a3a1d4de2fb3b1aebd691bb717029b1b6708790054d3d16be6fa3ff7f87ce254133ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6af340b25a6c8b0e98864ee3ef95d5b1bf0f6503d85cce932a223ee3111f197a94b410dd4f93868440af78b0e03d9e700a7d64056a5f778b790078ab796a900f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 09:59:17.949086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:59:17.949413) ========= 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=df17445c3590ff7897617a0e00000225-1491755900.982461-1159889710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:59:18.030962) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 09:59:18.031292) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 09:59:18.031593) ========= ========= Total master_lag: 0.16 =========