builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-082 starttime: 1489531726.24 results: success (0) revision: e18a84324de25e10c3c39044cd5e6c5c0ad2aa46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:46.235340) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:46.235764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:46.236050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:46.250207) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:46.250466) ========= 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=51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-14 15:48:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.4M=0s 2017-03-14 15:48:46 (23.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097056 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:46.360646) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:46.361005) ========= 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=51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016379 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:46.411097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:46.411433) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e18a84324de25e10c3c39044cd5e6c5c0ad2aa46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e18a84324de25e10c3c39044cd5e6c5c0ad2aa46 --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=51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-14 15:48:46,998 truncating revision to first 12 chars 2017-03-14 15:48:46,998 Setting DEBUG logging. 2017-03-14 15:48:46,998 attempt 1/10 2017-03-14 15:48:46,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e18a84324de2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-14 15:48:47,579 unpacking tar archive at: mozilla-aurora-e18a84324de2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.922523 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:47.347176) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:47.347511) ========= script_repo_revision: e18a84324de25e10c3c39044cd5e6c5c0ad2aa46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:47.347873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:47.348155) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 15:48:47.357045) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-14 15:48:47.357382) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:48:48 INFO - MultiFileLogger online at 20170314 15:48:48 in /builds/slave/test 15:48:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:48:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:48:48 INFO - {'append_to_log': False, 15:48:48 INFO - 'base_work_dir': '/builds/slave/test', 15:48:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:48:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:48:48 INFO - 'branch': 'Mozilla-Aurora', 15:48:48 INFO - 'buildbot_json_path': 'buildprops.json', 15:48:48 INFO - 'config_files': ('talos/linux_config.py',), 15:48:48 INFO - 'default_actions': ('clobber', 15:48:48 INFO - 'read-buildbot-config', 15:48:48 INFO - 'download-and-extract', 15:48:48 INFO - 'populate-webroot', 15:48:48 INFO - 'create-virtualenv', 15:48:48 INFO - 'install', 15:48:48 INFO - 'run-tests'), 15:48:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:48:48 INFO - 'download_minidump_stackwalk': True, 15:48:48 INFO - 'download_symbols': 'ondemand', 15:48:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:48:48 INFO - 'tooltool.py': '/tools/tooltool.py', 15:48:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:48:48 INFO - '/tools/misc-python/virtualenv.py')}, 15:48:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:48:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:48:48 INFO - 'gecko_profile': False, 15:48:48 INFO - 'gecko_profile_interval': 0, 15:48:48 INFO - 'installer_path': 'installer.exe', 15:48:48 INFO - 'log_level': 'info', 15:48:48 INFO - 'log_name': 'talos', 15:48:48 INFO - 'log_to_console': True, 15:48:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:48:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:48:48 INFO - 'opt_config_files': (), 15:48:48 INFO - 'pip_index': False, 15:48:48 INFO - 'suite': 'dromaeojs', 15:48:48 INFO - 'system_bits': '32', 15:48:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:48:48 INFO - 'title': 'talos-linux64-ix-082', 15:48:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:48:48 INFO - 'use_talos_json': True, 15:48:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:48:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:48:48 INFO - 'work_dir': 'build'} 15:48:48 INFO - [mozharness: 2017-03-14 22:48:48.046447Z] Running clobber step. 15:48:48 INFO - Running pre-action listener: _resource_record_pre_action 15:48:48 INFO - Running main action method: clobber 15:48:48 INFO - rmtree: /builds/slave/test/build 15:48:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:48:49 INFO - Running post-action listener: _resource_record_post_action 15:48:49 INFO - [mozharness: 2017-03-14 22:48:49.622634Z] Finished clobber step (success) 15:48:49 INFO - [mozharness: 2017-03-14 22:48:49.622731Z] Running read-buildbot-config step. 15:48:49 INFO - Running pre-action listener: _resource_record_pre_action 15:48:49 INFO - Running main action method: read_buildbot_config 15:48:49 INFO - Using buildbot properties: 15:48:49 INFO - { 15:48:49 INFO - "project": "", 15:48:49 INFO - "product": "firefox", 15:48:49 INFO - "who": "ryanvm@gmail.com", 15:48:49 INFO - "installer_path": "public/build/target.tar.bz2", 15:48:49 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:48:49 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 15:48:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:48:49 INFO - "stage_platform": "linux64-pgo", 15:48:49 INFO - "basedir": "/builds/slave/test", 15:48:49 INFO - "buildnumber": 1099, 15:48:49 INFO - "platform": "ubuntu64_hw", 15:48:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:48:49 INFO - "slavebuilddir": "test", 15:48:49 INFO - "taskId": "F80Ojcw6S0qZOukuPdrRKQ", 15:48:49 INFO - "branch": "mozilla-aurora", 15:48:49 INFO - "script_repo_revision": "production", 15:48:49 INFO - "revision": "e18a84324de25e10c3c39044cd5e6c5c0ad2aa46", 15:48:49 INFO - "slavename": "talos-linux64-ix-082", 15:48:49 INFO - "repo_path": "releases/mozilla-aurora" 15:48:49 INFO - } 15:48:49 INFO - Finding installer, test and symbols from parent task. 15:48:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F80Ojcw6S0qZOukuPdrRKQ'}, attempt #1 15:48:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F80Ojcw6S0qZOukuPdrRKQ'}, attempt #1 15:48:50 INFO - Task dependencies: ZBy6pcTUTTKaAAo3Dkbwtg 15:48:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg'}, attempt #1 15:48:50 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.tar.bz2 15:48:50 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/test_packages.json 15:48:50 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.crashreporter-symbols.zip 15:48:50 INFO - Running post-action listener: _resource_record_post_action 15:48:50 INFO - [mozharness: 2017-03-14 22:48:50.997639Z] Finished read-buildbot-config step (success) 15:48:50 INFO - [mozharness: 2017-03-14 22:48:50.997857Z] Running download-and-extract step. 15:48:50 INFO - Running pre-action listener: _resource_record_pre_action 15:48:50 INFO - Running main action method: download_and_extract 15:48:50 INFO - mkdir: /builds/slave/test/build/tests 15:48: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')]} 15:48:50 INFO - trying https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.test_packages.json 15:48:50 INFO - Downloading https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:48:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:48:51 INFO - Downloaded 896 bytes. 15:48:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:48:51 INFO - Using the following test package requirements: 15:48:51 INFO - {u'common': [u'target.common.tests.zip'], 15:48:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:48:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:48:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:48:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:48:51 INFO - u'mozbase': [u'target.common.tests.zip'], 15:48:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:48:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:48:51 INFO - u'web-platform': [u'target.common.tests.zip', 15:48:51 INFO - u'target.web-platform.tests.zip'], 15:48:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:48:51 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:48:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.common.tests.zip 15:48:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:48:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.common.tests.zip into memory 15:48:52 INFO - Expected file size: 59531295 15:48:52 INFO - Obtained file size: 59531295 15:49:02 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:49:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.common.tests.zip 15:49:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:49:02 INFO - Fetch https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.common.tests.zip into memory 15:49:03 INFO - Expected file size: 59531295 15:49:03 INFO - Obtained file size: 59531295 15:49:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.talos.tests.zip 15:49:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:49:14 INFO - Fetch https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.talos.tests.zip into memory 15:49:15 INFO - Expected file size: 14404424 15:49:15 INFO - Obtained file size: 14404424 15:49:15 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')]} 15:49:15 INFO - trying https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.tar.bz2 15:49:15 INFO - Downloading https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:49:16 INFO - Downloaded 66648887 bytes. 15:49:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.tar.bz2 15:49:16 INFO - mkdir: /builds/slave/test/properties 15:49:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:49:16 INFO - Writing to file /builds/slave/test/properties/build_url 15:49:16 INFO - Contents: 15:49:16 INFO - build_url:https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.tar.bz2 15:49:16 INFO - Running post-action listener: _resource_record_post_action 15:49:16 INFO - Running post-action listener: set_extra_try_arguments 15:49:16 INFO - [mozharness: 2017-03-14 22:49:16.576638Z] Finished download-and-extract step (success) 15:49:16 INFO - [mozharness: 2017-03-14 22:49:16.576734Z] Running populate-webroot step. 15:49:16 INFO - Running pre-action listener: _resource_record_pre_action 15:49:16 INFO - Running main action method: populate_webroot 15:49:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:49:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:49:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:49:16 INFO - '--tppagecycles', 15:49:16 INFO - '7'], 15:49:16 INFO - 'tests': ['tsvgm']}}, 15:49:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:49:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:49:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:49:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:49:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['damp', 'tps']}, 15:49:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'tests': ['damp', 'tps']}, 15:49:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['dromaeo_dom']}, 15:49:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:49:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['basic_compositor_video']}, 15:49:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:49:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['a11yr', 15:49:16 INFO - 'ts_paint', 15:49:16 INFO - 'tpaint', 15:49:16 INFO - 'sessionrestore', 15:49:16 INFO - 'sessionrestore_no_auto_restore', 15:49:16 INFO - 'tabpaint']}, 15:49:16 INFO - 'other-e10s': {'tests': ['a11yr', 15:49:16 INFO - 'ts_paint', 15:49:16 INFO - 'tpaint', 15:49:16 INFO - 'sessionrestore', 15:49:16 INFO - 'sessionrestore_no_auto_restore', 15:49:16 INFO - 'tabpaint']}, 15:49:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:49:16 INFO - 'ts_paint', 15:49:16 INFO - 'tpaint', 15:49:16 INFO - 'sessionrestore', 15:49:16 INFO - 'sessionrestore_no_auto_restore', 15:49:16 INFO - 'tabpaint']}, 15:49:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:49:16 INFO - 'ts_paint', 15:49:16 INFO - 'tpaint', 15:49:16 INFO - 'sessionrestore', 15:49:16 INFO - 'sessionrestore_no_auto_restore', 15:49:16 INFO - 'tabpaint']}, 15:49:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['a11yr', 15:49:16 INFO - 'ts_paint', 15:49:16 INFO - 'tpaint', 15:49:16 INFO - 'sessionrestore', 15:49:16 INFO - 'sessionrestore_no_auto_restore', 15:49:16 INFO - 'tabpaint']}, 15:49:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['a11yr', 15:49:16 INFO - 'ts_paint', 15:49:16 INFO - 'tpaint', 15:49:16 INFO - 'sessionrestore', 15:49:16 INFO - 'sessionrestore_no_auto_restore', 15:49:16 INFO - 'tabpaint']}, 15:49:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['tsvgx', 15:49:16 INFO - 'tsvgr_opacity', 15:49:16 INFO - 'tart', 15:49:16 INFO - 'tscrollx', 15:49:16 INFO - 'cart', 15:49:16 INFO - 'tsvg_static']}, 15:49:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:49:16 INFO - 'tsvgr_opacity', 15:49:16 INFO - 'tart', 15:49:16 INFO - 'tscrollx', 15:49:16 INFO - 'cart', 15:49:16 INFO - 'tsvg_static']}, 15:49:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['tp5o']}, 15:49:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:49:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'talos_options': ['--disable-e10s', 15:49:16 INFO - '--xperf_path', 15:49:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:16 INFO - 'tests': ['tp5n']}, 15:49:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'talos_options': ['--xperf_path', 15:49:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:16 INFO - 'tests': ['tp5n']}}, 15:49:16 INFO - 'talos.zip': {'path': '', 15:49:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:49:16 INFO - Running post-action listener: _resource_record_post_action 15:49:16 INFO - [mozharness: 2017-03-14 22:49:16.590078Z] Finished populate-webroot step (success) 15:49:16 INFO - [mozharness: 2017-03-14 22:49:16.590168Z] Running create-virtualenv step. 15:49:16 INFO - Running pre-action listener: _resource_record_pre_action 15:49:16 INFO - Running main action method: create_virtualenv 15:49:16 INFO - Creating virtualenv /builds/slave/test/build/venv 15:49:16 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 15:49:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:49:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:49:16 INFO - Using real prefix '/usr' 15:49:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:49:17 INFO - Installing distribute.............................................................................................................................................................................................done. 15:49:19 INFO - Installing pip.................done. 15:49:19 INFO - Return code: 0 15:49:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:49:19 INFO - Reading from file tmpfile_stdout 15:49:19 INFO - Output received: 15:49:19 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) 15:49:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1825b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823290>, '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 0x1823b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1824040>, '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': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', '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 15:49:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:49:19 INFO - Using env: {'DISPLAY': ':0', 15:49:19 INFO - 'HOME': '/home/cltbld', 15:49:19 INFO - 'LANG': 'en_US.UTF-8', 15:49:19 INFO - 'LANGUAGE': 'en_US:en', 15:49:19 INFO - 'LOGNAME': 'cltbld', 15:49:19 INFO - 'MAIL': '/var/mail/cltbld', 15:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:19 INFO - 'MOZ_NO_REMOTE': '1', 15:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:19 INFO - 'NO_EM_RESTART': '1', 15:49:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:19 INFO - 'PWD': '/builds/slave/test', 15:49:19 INFO - 'SHELL': '/bin/bash', 15:49:19 INFO - 'SHLVL': '1', 15:49:19 INFO - 'TERM': 'linux', 15:49:19 INFO - 'TMOUT': '86400', 15:49:19 INFO - 'USER': 'cltbld', 15:49:19 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', 15:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:19 INFO - '_': '/tools/buildbot/bin/python'} 15:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:19 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 15:49:19 INFO - Cleaning up... 15:49:19 INFO - Return code: 0 15:49:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1825b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823290>, '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 0x1823b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1824040>, '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': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', '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 15:49:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:49:19 INFO - Using env: {'DISPLAY': ':0', 15:49:19 INFO - 'HOME': '/home/cltbld', 15:49:19 INFO - 'LANG': 'en_US.UTF-8', 15:49:19 INFO - 'LANGUAGE': 'en_US:en', 15:49:19 INFO - 'LOGNAME': 'cltbld', 15:49:19 INFO - 'MAIL': '/var/mail/cltbld', 15:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:19 INFO - 'MOZ_NO_REMOTE': '1', 15:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:19 INFO - 'NO_EM_RESTART': '1', 15:49:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:19 INFO - 'PWD': '/builds/slave/test', 15:49:19 INFO - 'SHELL': '/bin/bash', 15:49:19 INFO - 'SHLVL': '1', 15:49:19 INFO - 'TERM': 'linux', 15:49:19 INFO - 'TMOUT': '86400', 15:49:19 INFO - 'USER': 'cltbld', 15:49:19 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', 15:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:19 INFO - '_': '/tools/buildbot/bin/python'} 15:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:19 INFO - Downloading/unpacking psutil>=3.1.1 15:49:19 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 15:49:19 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 15:49:19 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 15:49:19 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 15:49:19 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 15:49:19 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 15:49:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:49:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:21 INFO - Installing collected packages: psutil 15:49:21 INFO - Running setup.py install for psutil 15:49:22 INFO - building 'psutil._psutil_linux' extension 15:49:22 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 15:49:22 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 15:49:22 INFO - building 'psutil._psutil_posix' extension 15:49:22 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 15:49:22 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 15:49:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:22 INFO - Successfully installed psutil 15:49:22 INFO - Cleaning up... 15:49:22 INFO - Return code: 0 15:49:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:49:22 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')]} 15:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:22 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')]} 15:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:22 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 0x15881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1825b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823290>, '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 0x1823b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1824040>, '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': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', '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 15:49:22 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 15:49:22 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 15:49:22 INFO - Using env: {'DISPLAY': ':0', 15:49:22 INFO - 'HOME': '/home/cltbld', 15:49:22 INFO - 'LANG': 'en_US.UTF-8', 15:49:22 INFO - 'LANGUAGE': 'en_US:en', 15:49:22 INFO - 'LOGNAME': 'cltbld', 15:49:22 INFO - 'MAIL': '/var/mail/cltbld', 15:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:22 INFO - 'MOZ_NO_REMOTE': '1', 15:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:22 INFO - 'NO_EM_RESTART': '1', 15:49:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:22 INFO - 'PWD': '/builds/slave/test', 15:49:22 INFO - 'SHELL': '/bin/bash', 15:49:22 INFO - 'SHLVL': '1', 15:49:22 INFO - 'TERM': 'linux', 15:49:22 INFO - 'TMOUT': '86400', 15:49:22 INFO - 'USER': 'cltbld', 15:49:22 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', 15:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:22 INFO - '_': '/tools/buildbot/bin/python'} 15:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:49:22 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 15:49:22 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 15:49:22 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 15:49:22 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 15:49:22 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 15:49:22 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 15:49:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:49:24 INFO - Installing collected packages: mozsystemmonitor 15:49:24 INFO - Running setup.py install for mozsystemmonitor 15:49:24 INFO - Successfully installed mozsystemmonitor 15:49:24 INFO - Cleaning up... 15:49:24 INFO - Return code: 0 15:49:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:49:24 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')]} 15:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:24 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')]} 15:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:24 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 0x15881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1825b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823290>, '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 0x1823b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1824040>, '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': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', '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 15:49:24 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 15:49:24 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 15:49:24 INFO - Using env: {'DISPLAY': ':0', 15:49:24 INFO - 'HOME': '/home/cltbld', 15:49:24 INFO - 'LANG': 'en_US.UTF-8', 15:49:24 INFO - 'LANGUAGE': 'en_US:en', 15:49:24 INFO - 'LOGNAME': 'cltbld', 15:49:24 INFO - 'MAIL': '/var/mail/cltbld', 15:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:24 INFO - 'MOZ_NO_REMOTE': '1', 15:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:24 INFO - 'NO_EM_RESTART': '1', 15:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:24 INFO - 'PWD': '/builds/slave/test', 15:49:24 INFO - 'SHELL': '/bin/bash', 15:49:24 INFO - 'SHLVL': '1', 15:49:24 INFO - 'TERM': 'linux', 15:49:24 INFO - 'TMOUT': '86400', 15:49:24 INFO - 'USER': 'cltbld', 15:49:24 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', 15:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:24 INFO - '_': '/tools/buildbot/bin/python'} 15:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:25 INFO - Downloading/unpacking jsonschema==2.5.1 15:49:25 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 15:49:25 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 15:49:25 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 15:49:25 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 15:49:25 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 15:49:25 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 15:49:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49:27 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 15:49:27 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 15:49:27 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 15:49:27 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 15:49:27 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 15:49:27 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 15:49:27 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:27 INFO - warning: no files found matching '*.txt' 15:49:27 INFO - no previously-included directories found matching 'build' 15:49:27 INFO - no previously-included directories found matching 'dist' 15:49:27 INFO - no previously-included directories found matching '.git*' 15:49:27 INFO - Installing collected packages: jsonschema, functools32 15:49:27 INFO - Running setup.py install for functools32 15:49:27 INFO - warning: no files found matching '*.txt' 15:49:27 INFO - no previously-included directories found matching 'build' 15:49:27 INFO - no previously-included directories found matching 'dist' 15:49:27 INFO - no previously-included directories found matching '.git*' 15:49:27 INFO - Successfully installed jsonschema functools32 15:49:27 INFO - Cleaning up... 15:49:27 INFO - Return code: 0 15:49:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1825b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823290>, '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 0x1823b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1824040>, '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': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', '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 15:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:49:27 INFO - Using env: {'DISPLAY': ':0', 15:49:27 INFO - 'HOME': '/home/cltbld', 15:49:27 INFO - 'LANG': 'en_US.UTF-8', 15:49:27 INFO - 'LANGUAGE': 'en_US:en', 15:49:27 INFO - 'LOGNAME': 'cltbld', 15:49:27 INFO - 'MAIL': '/var/mail/cltbld', 15:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:27 INFO - 'MOZ_NO_REMOTE': '1', 15:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:27 INFO - 'NO_EM_RESTART': '1', 15:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:27 INFO - 'PWD': '/builds/slave/test', 15:49:27 INFO - 'SHELL': '/bin/bash', 15:49:27 INFO - 'SHLVL': '1', 15:49:27 INFO - 'TERM': 'linux', 15:49:27 INFO - 'TMOUT': '86400', 15:49:27 INFO - 'USER': 'cltbld', 15:49:27 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', 15:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:27 INFO - '_': '/tools/buildbot/bin/python'} 15:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:49:28 INFO - Cleaning up... 15:49:28 INFO - Return code: 0 15:49:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:28 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')]} 15:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:28 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')]} 15:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:28 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 0x15881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1825b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823290>, '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 0x1823b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1824040>, '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': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', '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 15:49:28 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 15:49:28 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 15:49:28 INFO - Using env: {'DISPLAY': ':0', 15:49:28 INFO - 'HOME': '/home/cltbld', 15:49:28 INFO - 'LANG': 'en_US.UTF-8', 15:49:28 INFO - 'LANGUAGE': 'en_US:en', 15:49:28 INFO - 'LOGNAME': 'cltbld', 15:49:28 INFO - 'MAIL': '/var/mail/cltbld', 15:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:28 INFO - 'MOZ_NO_REMOTE': '1', 15:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:28 INFO - 'NO_EM_RESTART': '1', 15:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:28 INFO - 'PWD': '/builds/slave/test', 15:49:28 INFO - 'SHELL': '/bin/bash', 15:49:28 INFO - 'SHLVL': '1', 15:49:28 INFO - 'TERM': 'linux', 15:49:28 INFO - 'TMOUT': '86400', 15:49:28 INFO - 'USER': 'cltbld', 15:49:28 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', 15:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:28 INFO - '_': '/tools/buildbot/bin/python'} 15:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:28 INFO - Downloading/unpacking blobuploader==1.2.4 15:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:30 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:31 INFO - Downloading docopt-0.6.1.tar.gz 15:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:49:31 INFO - Installing collected packages: blobuploader, requests, docopt 15:49:31 INFO - Running setup.py install for blobuploader 15:49:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:49:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:49:31 INFO - Running setup.py install for requests 15:49:31 INFO - Running setup.py install for docopt 15:49:31 INFO - Successfully installed blobuploader requests docopt 15:49:31 INFO - Cleaning up... 15:49:31 INFO - Return code: 0 15:49:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:31 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')]} 15:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:31 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')]} 15:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:31 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 0x15881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1825b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823290>, '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 0x1823b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1824040>, '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': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', '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 15:49:31 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 15:49:31 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 15:49:31 INFO - Using env: {'DISPLAY': ':0', 15:49:31 INFO - 'HOME': '/home/cltbld', 15:49:31 INFO - 'LANG': 'en_US.UTF-8', 15:49:31 INFO - 'LANGUAGE': 'en_US:en', 15:49:31 INFO - 'LOGNAME': 'cltbld', 15:49:31 INFO - 'MAIL': '/var/mail/cltbld', 15:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:31 INFO - 'MOZ_NO_REMOTE': '1', 15:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:31 INFO - 'NO_EM_RESTART': '1', 15:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:31 INFO - 'PWD': '/builds/slave/test', 15:49:31 INFO - 'SHELL': '/bin/bash', 15:49:31 INFO - 'SHLVL': '1', 15:49:31 INFO - 'TERM': 'linux', 15:49:31 INFO - 'TMOUT': '86400', 15:49:31 INFO - 'USER': 'cltbld', 15:49:31 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', 15:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:31 INFO - '_': '/tools/buildbot/bin/python'} 15:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:31 INFO - Running setup.py (path:/tmp/pip-W9aYgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:32 INFO - Running setup.py (path:/tmp/pip-3q9rUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:32 INFO - Running setup.py (path:/tmp/pip-zDYNsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:32 INFO - Running setup.py (path:/tmp/pip-vrTF2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:32 INFO - Running setup.py (path:/tmp/pip-3SpGYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:32 INFO - Running setup.py (path:/tmp/pip-j7dW1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:32 INFO - Running setup.py (path:/tmp/pip-RgKi9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:32 INFO - Running setup.py (path:/tmp/pip-cWUbCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:32 INFO - Running setup.py (path:/tmp/pip-xz7dPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:32 INFO - Running setup.py (path:/tmp/pip-e6wlj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:32 INFO - Running setup.py (path:/tmp/pip-GElBMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:32 INFO - Running setup.py (path:/tmp/pip-FQx_Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:32 INFO - Running setup.py (path:/tmp/pip-sxAa8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:32 INFO - Running setup.py (path:/tmp/pip-csia8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:32 INFO - Running setup.py (path:/tmp/pip-agixui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:33 INFO - Running setup.py (path:/tmp/pip-ndX1to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:33 INFO - Running setup.py (path:/tmp/pip-4Le9Ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:49:33 INFO - Running setup.py install for manifestparser 15:49:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Running setup.py install for mozcrash 15:49:33 INFO - Running setup.py install for mozdebug 15:49:33 INFO - Running setup.py install for mozdevice 15:49:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Running setup.py install for mozfile 15:49:33 INFO - Running setup.py install for mozhttpd 15:49:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Running setup.py install for mozinfo 15:49:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Running setup.py install for mozInstall 15:49:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Running setup.py install for mozleak 15:49:34 INFO - Running setup.py install for mozlog 15:49:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:49:34 INFO - Running setup.py install for moznetwork 15:49:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:49:34 INFO - Running setup.py install for mozprocess 15:49:34 INFO - Running setup.py install for mozprofile 15:49:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:49:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:49:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:49:34 INFO - Running setup.py install for mozrunner 15:49:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:49:34 INFO - Running setup.py install for mozscreenshot 15:49:34 INFO - Running setup.py install for moztest 15:49:34 INFO - Running setup.py install for mozversion 15:49:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:49:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:49:34 INFO - Cleaning up... 15:49:34 INFO - Return code: 0 15:49:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:34 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')]} 15:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:34 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')]} 15:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:34 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 0x15881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1825b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823290>, '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 0x1823b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1824040>, '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': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', '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 15:49:34 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 15:49:34 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 15:49:34 INFO - Using env: {'DISPLAY': ':0', 15:49:34 INFO - 'HOME': '/home/cltbld', 15:49:34 INFO - 'LANG': 'en_US.UTF-8', 15:49:34 INFO - 'LANGUAGE': 'en_US:en', 15:49:34 INFO - 'LOGNAME': 'cltbld', 15:49:34 INFO - 'MAIL': '/var/mail/cltbld', 15:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:34 INFO - 'MOZ_NO_REMOTE': '1', 15:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:34 INFO - 'NO_EM_RESTART': '1', 15:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:34 INFO - 'PWD': '/builds/slave/test', 15:49:34 INFO - 'SHELL': '/bin/bash', 15:49:34 INFO - 'SHLVL': '1', 15:49:34 INFO - 'TERM': 'linux', 15:49:34 INFO - 'TMOUT': '86400', 15:49:34 INFO - 'USER': 'cltbld', 15:49:34 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', 15:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:34 INFO - '_': '/tools/buildbot/bin/python'} 15:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:35 INFO - Running setup.py (path:/tmp/pip-cJO7pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:35 INFO - Running setup.py (path:/tmp/pip-YOiMRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:35 INFO - Running setup.py (path:/tmp/pip-EFb9ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:35 INFO - Running setup.py (path:/tmp/pip-n6sZNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:35 INFO - Running setup.py (path:/tmp/pip-FNatNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:35 INFO - Running setup.py (path:/tmp/pip-odlw50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:35 INFO - Running setup.py (path:/tmp/pip-mK_gz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:35 INFO - Running setup.py (path:/tmp/pip-7_pzb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:35 INFO - Running setup.py (path:/tmp/pip-w_YJIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:35 INFO - Running setup.py (path:/tmp/pip-AZZ58K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:35 INFO - Running setup.py (path:/tmp/pip-Q_Ilr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:35 INFO - Running setup.py (path:/tmp/pip-8jYhFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:36 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)) 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:36 INFO - Running setup.py (path:/tmp/pip-EZkCLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:36 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)) 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:36 INFO - Running setup.py (path:/tmp/pip-YpXGJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:36 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)) 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:36 INFO - Running setup.py (path:/tmp/pip-VqfxTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:36 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)) 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:36 INFO - Running setup.py (path:/tmp/pip-3dQ1Kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:36 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)) 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:36 INFO - Running setup.py (path:/tmp/pip-kMTGH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:36 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)) 15:49:36 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)) 15:49:36 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)) 15:49:36 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)) 15:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:38 INFO - Downloading blessings-1.6.tar.gz 15:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:38 INFO - Installing collected packages: blessings 15:49:38 INFO - Running setup.py install for blessings 15:49:38 INFO - Successfully installed blessings 15:49:38 INFO - Cleaning up... 15:49:38 INFO - Return code: 0 15:49:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:38 INFO - Reading from file tmpfile_stdout 15:49:38 INFO - Current package versions: 15:49:38 INFO - argparse == 1.2.1 15:49:38 INFO - blessings == 1.6 15:49:38 INFO - blobuploader == 1.2.4 15:49:38 INFO - docopt == 0.6.1 15:49:38 INFO - functools32 == 3.2.3-2 15:49:38 INFO - jsonschema == 2.5.1 15:49:38 INFO - manifestparser == 1.1 15:49:38 INFO - mozInstall == 1.12 15:49:38 INFO - mozcrash == 1.0 15:49:38 INFO - mozdebug == 0.1 15:49:38 INFO - mozdevice == 0.49 15:49:38 INFO - mozfile == 1.2 15:49:38 INFO - mozhttpd == 0.7 15:49:38 INFO - mozinfo == 0.9 15:49:38 INFO - mozleak == 0.1 15:49:38 INFO - mozlog == 3.4 15:49:38 INFO - moznetwork == 0.27 15:49:38 INFO - mozprocess == 0.25 15:49:38 INFO - mozprofile == 0.28 15:49:38 INFO - mozrunner == 6.13 15:49:38 INFO - mozscreenshot == 0.1 15:49:38 INFO - mozsystemmonitor == 0.3 15:49:38 INFO - moztest == 0.8 15:49:38 INFO - mozversion == 1.4 15:49:38 INFO - psutil == 3.1.1 15:49:38 INFO - requests == 1.2.3 15:49:38 INFO - wsgiref == 0.1.2 15:49:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:38 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')]} 15:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:38 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')]} 15:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:38 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 0x15881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1825b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823290>, '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 0x1823b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1824040>, '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': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', '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 15:49:38 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 15:49:38 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 15:49:38 INFO - Using env: {'DISPLAY': ':0', 15:49:38 INFO - 'HOME': '/home/cltbld', 15:49:38 INFO - 'LANG': 'en_US.UTF-8', 15:49:38 INFO - 'LANGUAGE': 'en_US:en', 15:49:38 INFO - 'LOGNAME': 'cltbld', 15:49:38 INFO - 'MAIL': '/var/mail/cltbld', 15:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:38 INFO - 'MOZ_NO_REMOTE': '1', 15:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:38 INFO - 'NO_EM_RESTART': '1', 15:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:38 INFO - 'PWD': '/builds/slave/test', 15:49:38 INFO - 'SHELL': '/bin/bash', 15:49:38 INFO - 'SHLVL': '1', 15:49:38 INFO - 'TERM': 'linux', 15:49:38 INFO - 'TMOUT': '86400', 15:49:38 INFO - 'USER': 'cltbld', 15:49:38 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', 15:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:38 INFO - '_': '/tools/buildbot/bin/python'} 15:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 INFO - Cleaning up... 15:49:39 INFO - Return code: 0 15:49:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:39 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 0x15881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1825b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823290>, '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 0x1823b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1824040>, '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': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', '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 15:49:39 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 15:49:39 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 15:49:39 INFO - Using env: {'DISPLAY': ':0', 15:49:39 INFO - 'HOME': '/home/cltbld', 15:49:39 INFO - 'LANG': 'en_US.UTF-8', 15:49:39 INFO - 'LANGUAGE': 'en_US:en', 15:49:39 INFO - 'LOGNAME': 'cltbld', 15:49:39 INFO - 'MAIL': '/var/mail/cltbld', 15:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:39 INFO - 'MOZ_NO_REMOTE': '1', 15:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:39 INFO - 'NO_EM_RESTART': '1', 15:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:39 INFO - 'PWD': '/builds/slave/test', 15:49:39 INFO - 'SHELL': '/bin/bash', 15:49:39 INFO - 'SHLVL': '1', 15:49:39 INFO - 'TERM': 'linux', 15:49:39 INFO - 'TMOUT': '86400', 15:49:39 INFO - 'USER': 'cltbld', 15:49:39 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', 15:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:39 INFO - '_': '/tools/buildbot/bin/python'} 15:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:49:39 INFO - Cleaning up... 15:49:39 INFO - Return code: 0 15:49:39 INFO - Running post-action listener: _resource_record_post_action 15:49:39 INFO - Running post-action listener: _start_resource_monitoring 15:49:39 INFO - Starting resource monitoring. 15:49:39 INFO - [mozharness: 2017-03-14 22:49:39.370895Z] Finished create-virtualenv step (success) 15:49:39 INFO - [mozharness: 2017-03-14 22:49:39.371466Z] Running install step. 15:49:39 INFO - Running pre-action listener: _resource_record_pre_action 15:49:39 INFO - Running main action method: install 15:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:39 INFO - Reading from file tmpfile_stdout 15:49:39 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:39 INFO - Reading from file tmpfile_stdout 15:49:39 INFO - Output received: 15:49:39 INFO - Usage: mozinstall [options] installer 15:49:39 INFO - Options: 15:49:39 INFO - -h, --help show this help message and exit 15:49:39 INFO - -d DEST, --destination=DEST 15:49:39 INFO - Directory to install application into. [default: 15:49:39 INFO - "/builds/slave/test"] 15:49:39 INFO - --app=APP Application being installed. [default: firefox] 15:49:39 INFO - mkdir: /builds/slave/test/build/application 15:49:39 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'] 15:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:49:56 INFO - Reading from file tmpfile_stdout 15:49:56 INFO - Output received: 15:49:56 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:56 INFO - Running post-action listener: _resource_record_post_action 15:49:56 INFO - [mozharness: 2017-03-14 22:49:56.227933Z] Finished install step (success) 15:49:56 INFO - [mozharness: 2017-03-14 22:49:56.228207Z] Running run-tests step. 15:49:56 INFO - Running pre-action listener: _resource_record_pre_action 15:49:56 INFO - Running main action method: run_tests 15:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:56 INFO - Python 2.7.3 15:49:56 INFO - Return code: 0 15:49:56 INFO - grabbing minidump binary from tooltool 15:49:56 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')]} 15:49:56 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 0x1823290>, '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 0x1823b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1824040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:56 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 15:49:56 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 15:49:56 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 15:49:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:56 INFO - Return code: 0 15:49:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:56 INFO - ENV: RUST_BACKTRACE is now 1 15:49:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 15:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --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 15:49:56 INFO - Using env: {'DISPLAY': ':0', 15:49:56 INFO - 'HOME': '/home/cltbld', 15:49:56 INFO - 'LANG': 'en_US.UTF-8', 15:49:56 INFO - 'LANGUAGE': 'en_US:en', 15:49:56 INFO - 'LOGNAME': 'cltbld', 15:49:56 INFO - 'MAIL': '/var/mail/cltbld', 15:49:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:56 INFO - 'MOZ_NO_REMOTE': '1', 15:49:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:56 INFO - 'NO_EM_RESTART': '1', 15:49:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:56 INFO - 'PWD': '/builds/slave/test', 15:49:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:56 INFO - 'RUST_BACKTRACE': '1', 15:49:56 INFO - 'SHELL': '/bin/bash', 15:49:56 INFO - 'SHLVL': '1', 15:49:56 INFO - 'TERM': 'linux', 15:49:56 INFO - 'TMOUT': '86400', 15:49:56 INFO - 'USER': 'cltbld', 15:49:56 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285', 15:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:56 INFO - '_': '/tools/buildbot/bin/python'} 15:49:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 15:49:56 INFO - mozversion application_buildid: 20170314215032 15:49:56 INFO - mozversion application_changeset: e18a84324de25e10c3c39044cd5e6c5c0ad2aa46 15:49:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:49:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:56 INFO - mozversion application_name: Firefox 15:49:56 INFO - mozversion application_remotingname: firefox-dev 15:49:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:49:56 INFO - mozversion application_vendor: Mozilla 15:49:56 INFO - mozversion application_version: 54.0a2 15:49:56 INFO - mozversion platform_buildid: 20170314215032 15:49:56 INFO - mozversion platform_changeset: e18a84324de25e10c3c39044cd5e6c5c0ad2aa46 15:49:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:49:56 INFO - mozversion platform_version: 54.0a2 15:49:56 INFO - using testdate: 1489531796 15:49:56 INFO - actual date: 1489531796 15:49:56 INFO - starting webserver on 'localhost:43511' 15:49:56 INFO - SUITE-START | Running 2 tests 15:49:56 INFO - TEST-START | dromaeo_css 15:49:56 INFO - operating with platform_type : linux_ 15:49:56 INFO - Initialising browser for dromaeo_css test... 15:49:56 INFO - TEST-INFO | started process 4879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVubdpz/profile http://localhost:43511/getInfo.html) 15:50:00 INFO - PROCESS | 4879 | __metrics Screen width/height:1600/1200 15:50:00 INFO - PROCESS | 4879 | colorDepth:24 15:50:00 INFO - PROCESS | 4879 | Browser inner width/height: 1024/697 15:50:00 INFO - PROCESS | 4879 | __metrics 15:50:01 INFO - PROCESS | 4879 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:50:01 INFO - PROCESS | 4879 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:50:02 INFO - TEST-INFO | 4879: exit 0 15:50:02 INFO - Browser initialized. 15:50:02 INFO - Running cycle 1/1 for dromaeo_css test... 15:50:02 INFO - TEST-INFO | started process 4970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVubdpz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:14 INFO - PROCESS | 4970 | RSS: Main: 139051008 15:50:14 INFO - PROCESS | 4970 | 15:53:15 INFO - PROCESS | 4970 | Cycle 1(1): loaded http://localhost:43511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43511/tests/dromaeo/cssquery-ext.html) 15:53:17 INFO - PROCESS | 4970 | RSS: Main: 276135936 15:53:17 INFO - PROCESS | 4970 | 15:55:04 INFO - PROCESS | 4970 | ************************* 15:55:04 INFO - PROCESS | 4970 | A coding exception was thrown and uncaught in a Task. 15:55:04 INFO - PROCESS | 4970 | 15:55:04 ERROR - PROCESS | 4970 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:55:04 INFO - PROCESS | 4970 | Full stack: 15:55:04 INFO - PROCESS | 4970 | ************************* 15:56:19 INFO - PROCESS | 4970 | Cycle 1(1): loaded http://localhost:43511/tests/dromaeo/cssquery-ext.html (next: http://localhost:43511/tests/dromaeo/cssquery-jquery.html) 15:56:19 INFO - PROCESS | 4970 | RSS: Main: 215711744 15:56:19 INFO - PROCESS | 4970 | 15:59:21 INFO - PROCESS | 4970 | Cycle 1(1): loaded http://localhost:43511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43511/tests/dromaeo/cssquery-mootools.html) 15:59:22 INFO - PROCESS | 4970 | RSS: Main: 222572544 15:59:22 INFO - PROCESS | 4970 | 16:02:24 INFO - PROCESS | 4970 | Cycle 1(1): loaded http://localhost:43511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43511/tests/dromaeo/cssquery-prototype.html) 16:02:24 INFO - PROCESS | 4970 | RSS: Main: 198508544 16:02:24 INFO - PROCESS | 4970 | 16:05:27 INFO - PROCESS | 4970 | Cycle 1(1): loaded http://localhost:43511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43511/tests/dromaeo/cssquery-yui.html) 16:05:28 INFO - PROCESS | 4970 | RSS: Main: 177651712 16:05:28 INFO - PROCESS | 4970 | 16:08:30 INFO - PROCESS | 4970 | Cycle 1(1): loaded http://localhost:43511/tests/dromaeo/cssquery-yui.html (next: http://localhost:43511/tests/dromaeo/cssquery-dojo.html) 16:08:31 INFO - PROCESS | 4970 | RSS: Main: 261906432 16:08:31 INFO - PROCESS | 4970 | 16:08:31 INFO - PROCESS | 4970 | __start_tp_report 16:08:31 INFO - PROCESS | 4970 | _x_x_mozilla_page_load 16:08:31 INFO - PROCESS | 4970 | _x_x_mozilla_page_load_details 16:08:31 INFO - PROCESS | 4970 | |i|pagename|runs| 16:08:31 INFO - PROCESS | 4970 | |0;dojo.html;3353.899383018509;3404.5914490261166;3413.5391722117524;3426.9828650856743;3458.619551849296;5717.085266357383;5792.971035144818;5801.738921748521;5809.157672137538;5823.767049318028;5756.481916627503;5861.296644402667;5866.149408335788;5871.060630299153;5871.324797648272;5169.405518365389;5206.615699795145;5238.5023422774775;5259.789608415678;5279.841604751844;5045;5083.720395378253;5171.689698618076;5289.8942021159555;5303.628745987782;5250.579953603722;5266.762995665185;5267.920981185285;5278;5293.920591191135;5272.367315922094;5287.841364759063;5288.180332048539;5289.2859463972445;5297.761600727977;5009.474005229435;5081.28861959326;5194.71429071401;5200.635955483118;5254.789808407659;5706.543476521868;5741.799037033726;5791.8552036199435;5795.2176456178295;5799.594028418012;6053.545984051169;6140.7364488221765;6227.377262273736;6230.5638605297645;6235.594686345418;6298.811035668938;6311.589746666452;6316.557840951135;6319.273283572402;6320.589161704521;5579.553635709133;5690.430956904276;5790.42095790426;5825.970870145707;5869.882602347929;6399.13611662429;6402.551821372553;6411.070394792729;6419;6427.2929977702415;6141.907871381933;6163.445289923929;6171.352008039181;6174.104754810527;6182.041783523561;6036.5170786336985;6067.423594758491;6139.198457457749;6210.441060304594;6299.874002519924;6248.562600618004;6264.436200741955;6266.843328916813;6272.8118156455375;6279.96860015697;6006.519478441714;6053.485453736482;6128.356522565066;6138.462537397657;6160.045192995003;4725.220338644085;4761.238201887751;4779.95220047802;4784.569388755029;4793.808247670124;4259.659227261812;4273.615374616237;4290.635295999812;4302.161078589645;4327.221100201994;5828.76684932598;5841.094630332221;5957.940420595739;5966;6004.279486461653;6326.398992095744;6328.462080723098;6330.145430366933;6330.4619107375465;6331.461825744771;6046.18376519173;6052.243469566304;6056.606320589148;6057.727402266909;6072.119542666289;5167.483251674803;5191.766370513336;5266.368035835724;5280.339957505312;5360.571154307646;6483.124778154983;6521.11964884744;6534.346565343428;6535.967320163464;6537.542372033912;6232.376762323732;6263.812085637438;6284.685765711788;6290.402411771058;6297.496200304056;6285.811425657238;6325.810225693236;6414.454771344302;6541.70562324687;6544.3782840630065;6167.629942203482;6183.474404675653;6193;6195.380461953769;6210.161628180138;6311.873762524632;6313.2424109107205;6316.494680425647;6321.336259692666;6325.209348831396;5927.229460170151;5957.434043765836;6088.4215999479975;6146.0473626587955;6151.692415379123;6076.3012253591405;6105.084237364431;6112.898653789679;6160.537959653134;6172.351903050115;6136.5090792737365;6140.846478838065;6143.508519318354;6146.846328841636;6148.231471066117;5963.105534169909;5997.670128142994;6021.969890150521;6103.11504831788;6144;6049.879002419839;6065.757369705162;6077.969610151921;6094.299155597163;6100.908486372619 16:08:31 INFO - PROCESS | 4970 | |1;ext.html;765.846830633873;836.8284501677155;840.5461051032443;916.7891384981458;916.9266458683306;30209.942652007183;30617;32649.347013059723;32666.346673066524;43192;44598.33102503457;45151;45318.32022519665;45351.31973020407;45430.772846135806;9121.270298376114;9269.582868770887;9271.860922086174;9273.443593384385;9277.721668349926;7563.470557061008;7652.57910814905;9088.454692718426;9198.586063627154;10656.946715266451;10990.340579565212;11024.228304018721;11050.226484146073;11052.115830733563;11060.557577696882;10957.83563246552;10984.340939543574;10988.230823842334;10989.010989010947;11032.117430605533;10636.680899573024;10706.892931070668;10708.089812365959;10711.089557387631;10711.410872402015;42299;42451;42552.361714574305;42649.78675106636;42663.7866810664;4056.2090392373498;4115.259253334399;4122.443470131554;4135.7518548887165;4173.373993900909;30804.383912321853;30927.690723092706;31144.53283200754;31796;32393.190170245696;4369.4319738434115;4399.802008909607;4439.2675208590545;4439.511653718088;4476.104779044204;217660;219908;221176.89411553;222207;222907;53894;53895;53958.19062713984;53972;54032;56095;56205.43794562084;56223;56240.718796406574;56342.43657563372;14612.123272603678;14912.478063267734;14917.104973701613;14939.925300373428;14945.70108597822;12863.485460581473;12880.549180778815;12885.22688638666;12889.355532223351;12939.870601293867;11744;11946.163768536293;12617.684557885943;13079.346032698328;13537.729245415234;5005.34930459038;5067.721275329893;5108.628305318472;5126.974365128151;5203.453637368098;1008.909198172168;1012.1851909213154;1019.7093828259059;1020.6121673763922;1026.2918586175515;27775.16674499768;27916.16251512458;28201.94968116875;28429.431411371657;28449;1082.5020490574266;1095.370162156763;1097.2648325621853;1101.3446999035561;1111.183280288987;14107.36516856744;14696.779548306784;14853.2573371331;15001.849981500045;15021.399144034334;307701;309300;309741;309942;310766;53806;53869;53913.73043134838;53927.19109213365;53982.730086349315;1491.3736230783097;1499.9475018374305;1508.6831765329405;1516.9154054850835;1522.079142119002;25827.225183244533;27004.32489187786;27502;27559.586606200523;27761.86119069392;47378.28932566083;47791.76104119457;47829.28256076231;47854.760726196146;47904.04191916212;334237;334909;335131;336263;337127;29423.11730648084;29658.25854353572;29746.405071898007;30019;30118.84940575283;33121.50317745284;33232.833835830665;35998.280034399686;37874.242515148995;38348.42477362786;33730.49404258889;33771.3245735079;33814.15464613404;33869.3226135471;33916.660833391354;33658.32683346368;33688.49467258042;33712.83143584365;33733.662663373056;34401.31197375988;34574.82712586421;34586.48120278148;34627.13432164216;34990.12524686903;36217.09457263589;30521.847390763793;31688.36623267568;31993;32372.514412283363;32518.349633006736;25136.748632514173;25423.23730288094;25589.616155757307;25739;25916.222513324632 16:08:31 INFO - PROCESS | 4970 | |2;jquery.html;446.40405059245904;448.7823405648262;450.5832105302594;462.5582568646942;466.9743164125976;19676.803231967675;21224.787752122473;21237.244897959194;21419.464513387175;21578.460538486546;19778.208871645118;20376.490587735316;20501.692474612893;20726.48183795406;20803;5318.627696061258;6631.071649968996;6788.91190531515;6976.337247961435;6982.825429364256;6881.071055407506;6910.896336554955;6949.339812717809;6968.756093536727;6970.024196612479;6706.765263215789;6786;6848.178218613748;6860.142482189726;6967.6167810770385;6830.897536536956;6854.794356169323;6914.5159838811305;6924.376806087476;7319;7513.39892808574;7561.470697051209;7566.356859666935;7568.243175682443;7572.886406703904;24850.751492485026;25375;25543.61684574733;25588.744112558823;25729.742702572923;3088.258817883714;3181.1410919051727;3205.054508919851;3225.7580681448985;3247.009662053073;16191.271392787352;16390.83609163917;16576.83423165765;16622;16982.575435614086;2263.5246598214394;2315.0627864071885;2325.058351367682;2325.592981372327;2358.50471401006;80263.5986820068;80464.59767701183;83836;104695.99999999924;117849;17494.65010699779;17685.646287074185;18214;18298.176582053573;18476.722849157275;31265.8436707815;31320.373592528023;31362.686373135977;31399.37201255962;31643.525347119812;9927.80144397108;9979.45113018791;10057.597696092074;10225;10251.333663311862;8257;8312.25189732927;8353.874691879626;8458.069612342637;8513.574321283912;9042.683506077386;9049.457032578066;9099.727008189764;9309.627614895327;9346.392484488486;3622.42041273395;3788.4885540452237;3818;3874.3800991841736;3915.882523524299;944.579662050381;964.3827950111934;966.7389804752818;993.0863605482973;1005.607812952949;19336.8066319335;19593.510162246057;20442.897785511275;21561.784382156293;21659.566808663738;1065.0999905080196;1079.5681727308981;1106.5186643809968;1108.7616162524935;1110.777844431117;10612.20408469368;11182.16133789969;11335.659930202108;11340.262882912584;11345.546178152947;631811;633773;639718;652799;655742;84739.57630211809;87630.56184719162;120845;122589;124544;1303.8696130386886;1310;1342.2215115233141;1351.86481351866;1357.7691792395317;19102.23591056342;19371.418857433735;19385.51536211606;19481.610367792848;19522.31671891534;52581;52787.472125278255;52819.735901320244;53575.19637205367;54924.725376372866;67787.66106169438;68897.65551172211;69404.30595694181;69722.65138674274;70737.64631176811;12108.51565937388;12140.392980351124;12414.441350139085;12454.626361209179;12484;13538.323083845571;13626;13699.109557878706;13756.243406612732;14308.856911430752;12056.75886482283;12169.452374642986;12305.876941230474;12532.310722910328;12736.363181840685;11760.235584686969;11859;11995.580154694544;12276.447559860006;12495.187812792139;12165.756684866075;12583.496660133493;12871.871281287442;12956.8056479151;13117.278549679859;12150.21023633461;12293.56972505958;12341.876581234432;12393.752124957631;12708.555200567936;11718.648440546796;12049.759004820029;12049.939750301193;12104.45529951172;12179.208351457128 16:08:31 INFO - PROCESS | 4970 | |3;mootools.html;1490.3368001239453;1502.0762231227798;1521.208971334906;1539.491967650676;1568.427523953757;10879.69443666759;11561.53753849847;11592.072634189266;11603.24578902373;11617.709557261061;11299.661010169708;11336.829947550794;11545.884541154586;12003.399830008486;12041.759164816698;2424.2969538833718;2462.2859370782453;2466;2466.272449627364;2469.2221950085755;2388.7358493365386;2436.196055301755;2436.232586735173;2437.171361737009;2437.195725410619;2334.6264597664376;2377.2511658827502;2385.522895420914;2394;2394.437307232799;2257.537204872997;2275.283285764987;2283.2122917593406;2284.7486776454575;2284.7486776454575;2298.4598619324447;2326.639370897514;2352.3883790214495;2352.635341522067;2353.0470159585225;11449.656510304705;11594.94202528982;11608.4195790211;11640.06879449642;11658.941705291503;5508.889822203533;5642.943570564324;5658.971705141448;5662.320521537442;5663.575231857586;3569.9107522311892;3640.7815531068222;3684.1342284563107;3695.2794205130012;3714.7956862372557;1301.1672529581076;1346.7845144776788;1368.8494265630773;1387.7016441465134;1433.1544388810548;16763.329466821433;16771.748423773653;16968.660626787518;17102.828971710373;17116.058616776074;4493.820247190076;4629.537046295411;4676.766161691902;4771.761411929389;4774.116788394158;12730.490780368867;12732.299723515296;12740.80888786669;12746.872531274754;12807.16753411044;5646.124850648156;5650.689212093374;5656.377798442168;5660.688662123623;5663.971680141655;5169.81905633301;5270.894582108336;5341.092014357569;5404.270423492778;5479.835604931858;3975.4235635832642;4005.639492445694;4044.51465824103;4057.6753859691153;4088.4889388826396;1038.444432228754;1049.8792638846478;1055.7730088030958;1059.9417032063157;1073.806714791345;961.778790878102;967.8790151231096;974.3131092579714;982.2387649571639;988.8862780780158;6246.843828904313;6250.062490626442;6294.8111556653375;6343.524235682342;7092.736961439968;1043.9947800261102;1104.0725790335996;1106.4578356605205;1110.3837370259423;1124.2860783402598;4922.729249891218;4947.925781113287;4989.376327959005;5029.396472423333;5078.314427552233;13780.448782048807;14316;14340.282985850667;14585.343659535347;14591.92704036473;14235.359408826627;14363.281835908163;14456.277186140862;14457.710845783025;14568.85431145675;8736.8689469658;9051.547422628842;10330.690079297634;10508.369497830156;10608.098311643442;6950.3049695030095;6961.582305061713;6977.406920411822;7127.75052873147;7216.3505284524645;12887;12903.935480322538;13017.544385946447;13055.086143969831;13185.142965707199;13113.475460981454;13189.670258243621;13234.338283086;13250.602481925558;13508.257045862572;9662.758431039;9881.703548893545;9987.101160895554;10002.549885255326;10004.899951000689;10492.580296788348;10690.037896589345;10754.085902698358;10872.61945831892;11095.16786241019;9644.228461723185;9693.41839489633;9789.118979291898;9978.151857092229;10106.292559520763;9523.904760952302;9546.236301095756;9677.854832177663;9679.128878400978;9696.321257511907;7428.108626964583;7463.626818659154;7466.440016998856;7487.925120748941;7887.250711182429;6328.968355158195;6432.839179020562;6454.935450645621;6530.281669016499;6555.246146693001;6171.413715697002;6261.217347831521;6304.65324407162;6317.747290108528;6381.968090159519 16:08:31 INFO - PROCESS | 4970 | |4;prototype.html;393.0703885311239;413.4748868936451;416.09499338937843;419.4442363867875;441.8033974881179;5260.894782104356;5286.8413947581585;5300.416954135047;5312.73436328184;5337.5196232339085;5069.414598554736;5195.68825870448;5207.244949482323;5224.346956630421;5275.340582427197;4443.800028998687;4445.599896009358;4461.910761784762;4464.258939013787;4480.843170489034;4456.844010459618;4467.955320446787;4476.418065651461;4476.440444944382;4483.3723278741;4254.404383386328;4410.2723050696595;4433.827424561958;4443.5556444355625;4445.644348452132;4390.8902277443;4430.31330143825;4433.401490798749;4435.381085903638;4440.644748420119;4245.426867372896;4264.125854199881;4270.743755374688;4271.786410679485;4293.828246870122;4959.900801983977;5084.567811736007;5132.024915266087;5146.691198528063;5147.588192944593;5182.766775495074;5223.686578805284;5229.816956406546;5242.423333433319;5248.763805628756;5517.751701173457;5551.444855514456;5551.77792888284;5554.777808887639;5604.831855044315;4640.535946405366;4768.380110585636;4792.736399498026;4832.081904438145;4839.112746029052;5493.23094766733;5551.500364967173;5671.744771485293;5748.827535173951;5789;4983.775730092155;4992.375953005874;5004.574611158019;5021.372328458942;5021.915904899499;4834.854954351375;4991.900161996739;5044.571211447068;5050.191969284971;5079.0541485938065;4979.460475157695;5107.157319042316;5185.455527169668;5255.02781985334;5263;5513.862153446115;5514.228008078872;5515.420880807457;5525.917111243334;5530.760042182922;1720.698877696423;1746.5458980665119;1766.169900146929;1766.4788887278028;1772.1493683032218;1402.4810819996667;1440.762274224741;1443.8700516953525;1462.8537146285287;1463.5170393770031;5423.322084739408;5430.5384042356845;5440.483154100354;5445.972770136124;5449.6730196188355;5659.462351076641;5690.914636280377;5699.515541178963;5704.629199102128;5709.972959599366;5159.251908473326;5366.899785544032;5428.240046393508;5438.83683489496;5465.617406781566;2971.465136275491;2984.552317152401;2986.22358186873;2988.2678743707497;2992.5959995400776;5633.521150702154;5831.94168058314;5876.324222714443;5883.882322353529;5902.3507414184405;5805.709714514257;5833.649981001154;5835.153902684172;5847.427132061879;5853.0635098384055;5794.246747922743;5832.416758324133;5850.707464626752;5864.7947321844385;5957.868005079021;5494.36814766307;5571.66570005801;5632.887342253214;5695.601307908407;5714.485696287354;5376.381716102542;5616.556797792973;5634.6337488063145;5637.703328234447;5638.295213098363;5715.257016587817;5759.222504961776;5784.913226301693;5798.768049277982;5810.593258471867;4673.252279635242;4683.36774535447;4689.085628302585;4693.507181746004;4694.201985662377;5446.346438427414;5631.718414079198;5657.4908258256955;5661.971690141523;5672.801451949327;5462.126059830408;5496.532794712334;5511.311086114236;5518.255035570147;5528.44715528444;5528.585356098389;5534.640248383842;5537.473939975695;5544.63959842609;5546.417626149358;5291.259223708606;5491.780328786804;5537.418571049981;5554.194641776839;5581.297704200258;5510;5541.528970037431;5565.554755619622;5574.602920744119;5606.215129881738;5270.920936185884;5422.267993820784;5426.2674538936735;5450.945490545202;5499.890002200013 16:08:31 INFO - PROCESS | 4970 | |5;yui.html;871.381319263323;910.0308171797031;918.1598837064087;921.663592788632;941.9105185007426;16224.432144874918;18079.548011299725;18152.636947261046;18241.270349186016;18305.633887322245;15890.52328430149;15911;16015.679686406265;16033.278502467389;16067.598310042225;704.9224585295614;720.164609053498;725.0393228971608;889.550776857686;907.5144797533321;881.066069965835;896.802703405253;911.1253196930921;911.2618778789168;912.9954350228239;961.2982522758391;963.4123184857232;963.6916186820221;964.6382606522554;968.5060619084247;733.8679037773198;745.4893398022372;932.1470854168496;956.1681337236614;960.4669408478292;693.1162767471463;694.506900100929;695.6313154028322;696.495041095207;697.2957313113741;17072.743908841378;17099.57251068721;17143.657126857517;17198.484045478657;18110.90944545282;15699.843001570067;16278.26747796352;16784.244708988124;16897.91551042237;17210.139493025425;13858.861411385958;13934;14203.147811131365;14244.643883902881;14247.501337453139;4159.272127377727;4187.267228235077;4210.915781684349;4245.1934132514725;4293.184294983975;88037;88384.55807720985;88941.55529222377;89009.10990890137;91228.54385728095;13535.32323383827;13698.863011369958;13804;13910.652233694238;13997.720045599235;26950.03054489115;26978.460430791667;27130;27181.86409067942;27471.17586472409;9205.263578913671;9236.399634023766;9506.33455658111;9511.619535218651;9537.61849526025;4625.421822272216;4731.384919960452;4758.452777930513;4856.538628830255;4888.804447822047;3962.980185099114;4038.192361527706;4072.2873497137884;4093.365528343052;4109.794510274474;674.0125715826338;677.664556044761;679.4123083532709;682.9795106146823;699.2867275379085;680.1566058087935;683.3917813146304;688.3873352715987;698.4272896225046;698.9965050174717;10923.180761442924;10931.672049838518;11399.373034483016;11805.586804461802;11813.350265735467;687.151368060455;696.665600511747;702.301210295759;711.1608302203347;715.7530651925077;5255;5476.397596264408;5613.663180209119;5619.100943849046;5663.263775709213;77734.22265777383;78581.60709196418;79042.20957790349;80347.59826200949;80441;57817;64821.351786482475;66441.33558664352;67537.3246267531;75210;54177;54785.452145478834;61976.69011654913;63343;63879.36120638827;11071;11838;11874.46564904564;11906.880931190577;12165.270083795001;38584.80707596444;39686.801565991984;41781.58218417777;43126.13747725091;43675.12649747051;56046;57697.134542981046;58101.709491452275;58807;59166.11250831155;14033.29833508341;14037.719245614826;14054.367553460323;14085.718285634435;14292.571222863331;16808.915955420143;16956.830431695525;17042.147892605568;17159.056251906266;18286.359977400727;14121.364538595582;14145.080569762933;14192.858071419154;14667.339969701176;14680.192589407685;15403.383864645737;15488.380464781283;15903;16498.58753531171;16642.3343066276;14327.78508322355;14795.852041479448;15358.155301458528;15624;15677;13089.541866035024;13348.265845378597;13786.586402407944;13803;14269.450092720153;10665.786684266426;12770.361481926053;13179.472821087049;13504.392302346614;13617.31913404306 16:08:31 INFO - PROCESS | 4970 | __end_tp_report 16:08:31 INFO - PROCESS | 4970 | __start_cc_report 16:08:31 INFO - PROCESS | 4970 | _x_x_mozilla_cycle_collect,1309 16:08:31 INFO - PROCESS | 4970 | __end_cc_report 16:08:31 INFO - PROCESS | 4970 | __startTimestamp1489532911149__endTimestamp 16:08:31 INFO - PROCESS | 4970 | 16:08:31 INFO - PROCESS | 4970 | ------- Summary: start ------- 16:08:31 INFO - PROCESS | 4970 | Number of tests: 6 16:08:31 INFO - PROCESS | 4970 | 16:08:31 INFO - PROCESS | 4970 | [#0] dojo.html Cycles:165 Average:5789.57 Median:6056.61 stddev:671.79 (11.1%) stddev-sans-first:646.10 16:08:31 INFO - PROCESS | 4970 | Values: 3353.9 3404.6 3413.5 3427.0 3458.6 5717.1 5793.0 5801.7 5809.2 5823.8 5756.5 5861.3 5866.1 5871.1 5871.3 5169.4 5206.6 5238.5 5259.8 5279.8 5045.0 5083.7 5171.7 5289.9 5303.6 5250.6 5266.8 5267.9 5278.0 5293.9 5272.4 5287.8 5288.2 5289.3 5297.8 5009.5 5081.3 5194.7 5200.6 5254.8 5706.5 5741.8 5791.9 5795.2 5799.6 6053.5 6140.7 6227.4 6230.6 6235.6 6298.8 6311.6 6316.6 6319.3 6320.6 5579.6 5690.4 5790.4 5826.0 5869.9 6399.1 6402.6 6411.1 6419.0 6427.3 6141.9 6163.4 6171.4 6174.1 6182.0 6036.5 6067.4 6139.2 6210.4 6299.9 6248.6 6264.4 6266.8 6272.8 6280.0 6006.5 6053.5 6128.4 6138.5 6160.0 4725.2 4761.2 4780.0 4784.6 4793.8 4259.7 4273.6 4290.6 4302.2 4327.2 5828.8 5841.1 5957.9 5966.0 6004.3 6326.4 6328.5 6330.1 6330.5 6331.5 6046.2 6052.2 6056.6 6057.7 6072.1 5167.5 5191.8 5266.4 5280.3 5360.6 6483.1 6521.1 6534.3 6536.0 6537.5 6232.4 6263.8 6284.7 6290.4 6297.5 6285.8 6325.8 6414.5 6541.7 6544.4 6167.6 6183.5 6193.0 6195.4 6210.2 6311.9 6313.2 6316.5 6321.3 6325.2 5927.2 5957.4 6088.4 6146.0 6151.7 6076.3 6105.1 6112.9 6160.5 6172.4 6136.5 6140.8 6143.5 6146.8 6148.2 5963.1 5997.7 6022.0 6103.1 6144.0 6049.9 6065.8 6078.0 6094.3 6100.9 16:08:31 INFO - PROCESS | 4970 | 16:08:31 INFO - PROCESS | 4970 | [#1] ext.html Cycles:180 Average:45428.41 Median:32382.85 stddev:76646.04 (236.7%) stddev-sans-first:76787.69 16:08:31 INFO - PROCESS | 4970 | Values: 765.8 836.8 840.5 916.8 916.9 30209.9 30617.0 32649.3 32666.3 43192.0 44598.3 45151.0 45318.3 45351.3 45430.8 9121.3 9269.6 9271.9 9273.4 9277.7 7563.5 7652.6 9088.5 9198.6 10656.9 10990.3 11024.2 11050.2 11052.1 11060.6 10957.8 10984.3 10988.2 10989.0 11032.1 10636.7 10706.9 10708.1 10711.1 10711.4 42299.0 42451.0 42552.4 42649.8 42663.8 4056.2 4115.3 4122.4 4135.8 4173.4 30804.4 30927.7 31144.5 31796.0 32393.2 4369.4 4399.8 4439.3 4439.5 4476.1 217660.0 219908.0 221176.9 222207.0 222907.0 53894.0 53895.0 53958.2 53972.0 54032.0 56095.0 56205.4 56223.0 56240.7 56342.4 14612.1 14912.5 14917.1 14939.9 14945.7 12863.5 12880.5 12885.2 12889.4 12939.9 11744.0 11946.2 12617.7 13079.3 13537.7 5005.3 5067.7 5108.6 5127.0 5203.5 1008.9 1012.2 1019.7 1020.6 1026.3 27775.2 27916.2 28201.9 28429.4 28449.0 1082.5 1095.4 1097.3 1101.3 1111.2 14107.4 14696.8 14853.3 15001.8 15021.4 307701.0 309300.0 309741.0 309942.0 310766.0 53806.0 53869.0 53913.7 53927.2 53982.7 1491.4 1499.9 1508.7 1516.9 1522.1 25827.2 27004.3 27502.0 27559.6 27761.9 47378.3 47791.8 47829.3 47854.8 47904.0 334237.0 334909.0 335131.0 336263.0 337127.0 29423.1 29658.3 29746.4 30019.0 30118.8 33121.5 33232.8 35998.3 37874.2 38348.4 33730.5 33771.3 33814.2 33869.3 33916.7 33658.3 33688.5 33712.8 33733.7 34401.3 34574.8 34586.5 34627.1 34990.1 36217.1 30521.8 31688.4 31993.0 32372.5 32518.3 25136.7 25423.2 25589.6 25739.0 25916.2 16:08:31 INFO - PROCESS | 4970 | 16:08:31 INFO - PROCESS | 4970 | [#2] jquery.html Cycles:180 Average:36504.15 Median:2320.06 stddev:105641.70 (4553.4%) stddev-sans-first:105903.36 16:08:31 INFO - PROCESS | 4970 | Values: 446.4 448.8 450.6 462.6 467.0 19676.8 21224.8 21237.2 21419.5 21578.5 19778.2 20376.5 20501.7 20726.5 20803.0 5318.6 6631.1 6788.9 6976.3 6982.8 6881.1 6910.9 6949.3 6968.8 6970.0 6706.8 6786.0 6848.2 6860.1 6967.6 6830.9 6854.8 6914.5 6924.4 7319.0 7513.4 7561.5 7566.4 7568.2 7572.9 24850.8 25375.0 25543.6 25588.7 25729.7 3088.3 3181.1 3205.1 3225.8 3247.0 16191.3 16390.8 16576.8 16622.0 16982.6 2263.5 2315.1 2325.1 2325.6 2358.5 80263.6 80464.6 83836.0 104696.0 117849.0 17494.7 17685.6 18214.0 18298.2 18476.7 31265.8 31320.4 31362.7 31399.4 31643.5 9927.8 9979.5 10057.6 10225.0 10251.3 8257.0 8312.3 8353.9 8458.1 8513.6 9042.7 9049.5 9099.7 9309.6 9346.4 3622.4 3788.5 3818.0 3874.4 3915.9 944.6 964.4 966.7 993.1 1005.6 19336.8 19593.5 20442.9 21561.8 21659.6 1065.1 1079.6 1106.5 1108.8 1110.8 10612.2 11182.2 11335.7 11340.3 11345.5 631811.0 633773.0 639718.0 652799.0 655742.0 84739.6 87630.6 120845.0 122589.0 124544.0 1303.9 1310.0 1342.2 1351.9 1357.8 19102.2 19371.4 19385.5 19481.6 19522.3 52581.0 52787.5 52819.7 53575.2 54924.7 67787.7 68897.7 69404.3 69722.7 70737.6 12108.5 12140.4 12414.4 12454.6 12484.0 13538.3 13626.0 13699.1 13756.2 14308.9 12056.8 12169.5 12305.9 12532.3 12736.4 11760.2 11859.0 11995.6 12276.4 12495.2 12165.8 12583.5 12871.9 12956.8 13117.3 12150.2 12293.6 12341.9 12393.8 12708.6 11718.6 12049.8 12049.9 12104.5 12179.2 16:08:31 INFO - PROCESS | 4970 | 16:08:31 INFO - PROCESS | 4970 | [#3] mootools.html Cycles:180 Average:7084.74 Median:2394.22 stddev:4539.11 (189.6%) stddev-sans-first:4532.38 16:08:31 INFO - PROCESS | 4970 | Values: 1490.3 1502.1 1521.2 1539.5 1568.4 10879.7 11561.5 11592.1 11603.2 11617.7 11299.7 11336.8 11545.9 12003.4 12041.8 2424.3 2462.3 2466.0 2466.3 2469.2 2388.7 2436.2 2436.2 2437.2 2437.2 2334.6 2377.3 2385.5 2394.0 2394.4 2257.5 2275.3 2283.2 2284.7 2284.7 2298.5 2326.6 2352.4 2352.6 2353.0 11449.7 11594.9 11608.4 11640.1 11658.9 5508.9 5642.9 5659.0 5662.3 5663.6 3569.9 3640.8 3684.1 3695.3 3714.8 1301.2 1346.8 1368.8 1387.7 1433.2 16763.3 16771.7 16968.7 17102.8 17116.1 4493.8 4629.5 4676.8 4771.8 4774.1 12730.5 12732.3 12740.8 12746.9 12807.2 5646.1 5650.7 5656.4 5660.7 5664.0 5169.8 5270.9 5341.1 5404.3 5479.8 3975.4 4005.6 4044.5 4057.7 4088.5 1038.4 1049.9 1055.8 1059.9 1073.8 961.8 967.9 974.3 982.2 988.9 6246.8 6250.1 6294.8 6343.5 7092.7 1044.0 1104.1 1106.5 1110.4 1124.3 4922.7 4947.9 4989.4 5029.4 5078.3 13780.4 14316.0 14340.3 14585.3 14591.9 14235.4 14363.3 14456.3 14457.7 14568.9 8736.9 9051.5 10330.7 10508.4 10608.1 6950.3 6961.6 6977.4 7127.8 7216.4 12887.0 12903.9 13017.5 13055.1 13185.1 13113.5 13189.7 13234.3 13250.6 13508.3 9662.8 9881.7 9987.1 10002.5 10004.9 10492.6 10690.0 10754.1 10872.6 11095.2 9644.2 9693.4 9789.1 9978.2 10106.3 9523.9 9546.2 9677.9 9679.1 9696.3 7428.1 7463.6 7466.4 7487.9 7887.3 6329.0 6432.8 6454.9 6530.3 6555.2 6171.4 6261.2 6304.7 6317.7 6382.0 16:08:31 INFO - PROCESS | 4970 | 16:08:31 INFO - PROCESS | 4970 | [#4] prototype.html Cycles:180 Average:4858.55 Median:5306.58 stddev:1258.72 (23.7%) stddev-sans-first:1216.81 16:08:31 INFO - PROCESS | 4970 | Values: 393.1 413.5 416.1 419.4 441.8 5260.9 5286.8 5300.4 5312.7 5337.5 5069.4 5195.7 5207.2 5224.3 5275.3 4443.8 4445.6 4461.9 4464.3 4480.8 4456.8 4468.0 4476.4 4476.4 4483.4 4254.4 4410.3 4433.8 4443.6 4445.6 4390.9 4430.3 4433.4 4435.4 4440.6 4245.4 4264.1 4270.7 4271.8 4293.8 4959.9 5084.6 5132.0 5146.7 5147.6 5182.8 5223.7 5229.8 5242.4 5248.8 5517.8 5551.4 5551.8 5554.8 5604.8 4640.5 4768.4 4792.7 4832.1 4839.1 5493.2 5551.5 5671.7 5748.8 5789.0 4983.8 4992.4 5004.6 5021.4 5021.9 4834.9 4991.9 5044.6 5050.2 5079.1 4979.5 5107.2 5185.5 5255.0 5263.0 5513.9 5514.2 5515.4 5525.9 5530.8 1720.7 1746.5 1766.2 1766.5 1772.1 1402.5 1440.8 1443.9 1462.9 1463.5 5423.3 5430.5 5440.5 5446.0 5449.7 5659.5 5690.9 5699.5 5704.6 5710.0 5159.3 5366.9 5428.2 5438.8 5465.6 2971.5 2984.6 2986.2 2988.3 2992.6 5633.5 5831.9 5876.3 5883.9 5902.4 5805.7 5833.6 5835.2 5847.4 5853.1 5794.2 5832.4 5850.7 5864.8 5957.9 5494.4 5571.7 5632.9 5695.6 5714.5 5376.4 5616.6 5634.6 5637.7 5638.3 5715.3 5759.2 5784.9 5798.8 5810.6 4673.3 4683.4 4689.1 4693.5 4694.2 5446.3 5631.7 5657.5 5662.0 5672.8 5462.1 5496.5 5511.3 5518.3 5528.4 5528.6 5534.6 5537.5 5544.6 5546.4 5291.3 5491.8 5537.4 5554.2 5581.3 5510.0 5541.5 5565.6 5574.6 5606.2 5270.9 5422.3 5426.3 5450.9 5499.9 16:08:31 INFO - PROCESS | 4970 | 16:08:31 INFO - PROCESS | 4970 | [#5] yui.html Cycles:180 Average:18832.78 Median:4228.05 stddev:22917.70 (542.0%) stddev-sans-first:22942.30 16:08:31 INFO - PROCESS | 4970 | Values: 871.4 910.0 918.2 921.7 941.9 16224.4 18079.5 18152.6 18241.3 18305.6 15890.5 15911.0 16015.7 16033.3 16067.6 704.9 720.2 725.0 889.6 907.5 881.1 896.8 911.1 911.3 913.0 961.3 963.4 963.7 964.6 968.5 733.9 745.5 932.1 956.2 960.5 693.1 694.5 695.6 696.5 697.3 17072.7 17099.6 17143.7 17198.5 18110.9 15699.8 16278.3 16784.2 16897.9 17210.1 13858.9 13934.0 14203.1 14244.6 14247.5 4159.3 4187.3 4210.9 4245.2 4293.2 88037.0 88384.6 88941.6 89009.1 91228.5 13535.3 13698.9 13804.0 13910.7 13997.7 26950.0 26978.5 27130.0 27181.9 27471.2 9205.3 9236.4 9506.3 9511.6 9537.6 4625.4 4731.4 4758.5 4856.5 4888.8 3963.0 4038.2 4072.3 4093.4 4109.8 674.0 677.7 679.4 683.0 699.3 680.2 683.4 688.4 698.4 699.0 10923.2 10931.7 11399.4 11805.6 11813.4 687.2 696.7 702.3 711.2 715.8 5255.0 5476.4 5613.7 5619.1 5663.3 77734.2 78581.6 79042.2 80347.6 80441.0 57817.0 64821.4 66441.3 67537.3 75210.0 54177.0 54785.5 61976.7 63343.0 63879.4 11071.0 11838.0 11874.5 11906.9 12165.3 38584.8 39686.8 41781.6 43126.1 43675.1 56046.0 57697.1 58101.7 58807.0 59166.1 14033.3 14037.7 14054.4 14085.7 14292.6 16808.9 16956.8 17042.1 17159.1 18286.4 14121.4 14145.1 14192.9 14667.3 14680.2 15403.4 15488.4 15903.0 16498.6 16642.3 14327.8 14795.9 15358.2 15624.0 15677.0 13089.5 13348.3 13786.6 13803.0 14269.5 10665.8 12770.4 13179.5 13504.4 13617.3 16:08:31 INFO - PROCESS | 4970 | -------- Summary: end -------- 16:08:31 INFO - PROCESS | 4970 | 16:08:31 INFO - TEST-INFO | 4970: exit 0 16:08:31 INFO - TEST-OK | dromaeo_css | took 1115433ms 16:08:31 INFO - TEST-START | kraken 16:08:31 INFO - operating with platform_type : linux_ 16:08:31 INFO - Initialising browser for kraken test... 16:08:31 INFO - TEST-INFO | started process 5294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp97QZsE/profile http://localhost:43511/getInfo.html) 16:08:35 INFO - PROCESS | 5294 | __metrics Screen width/height:1600/1200 16:08:35 INFO - PROCESS | 5294 | colorDepth:24 16:08:35 INFO - PROCESS | 5294 | Browser inner width/height: 1024/697 16:08:35 INFO - PROCESS | 5294 | __metrics 16:08:36 INFO - PROCESS | 5294 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:08:36 INFO - PROCESS | 5294 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:08:37 INFO - TEST-INFO | 5294: exit 0 16:08:37 INFO - Browser initialized. 16:08:37 INFO - Running cycle 1/1 for kraken test... 16:08:37 INFO - TEST-INFO | started process 5384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp97QZsE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:49 INFO - PROCESS | 5384 | RSS: Main: 139141120 16:08:49 INFO - PROCESS | 5384 | 16:08:52 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43511/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:52 INFO - PROCESS | 5384 | RSS: Main: 182931456 16:08:52 INFO - PROCESS | 5384 | 16:08:55 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43511/tests/kraken/driver.html?testName=audio-dft) 16:08:56 INFO - PROCESS | 5384 | RSS: Main: 173699072 16:08:56 INFO - PROCESS | 5384 | 16:08:58 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43511/tests/kraken/driver.html?testName=audio-fft) 16:08:59 INFO - PROCESS | 5384 | RSS: Main: 265277440 16:08:59 INFO - PROCESS | 5384 | 16:09:01 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43511/tests/kraken/driver.html?testName=audio-oscillator) 16:09:02 INFO - PROCESS | 5384 | RSS: Main: 171708416 16:09:02 INFO - PROCESS | 5384 | 16:09:04 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:09:04 INFO - PROCESS | 5384 | RSS: Main: 174141440 16:09:04 INFO - PROCESS | 5384 | 16:09:07 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43511/tests/kraken/driver.html?testName=imaging-darkroom) 16:09:08 INFO - PROCESS | 5384 | RSS: Main: 212848640 16:09:08 INFO - PROCESS | 5384 | 16:09:11 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43511/tests/kraken/driver.html?testName=imaging-desaturate) 16:09:12 INFO - PROCESS | 5384 | RSS: Main: 211681280 16:09:12 INFO - PROCESS | 5384 | 16:09:14 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43511/tests/kraken/driver.html?testName=json-parse-financial) 16:09:15 INFO - PROCESS | 5384 | RSS: Main: 210137088 16:09:15 INFO - PROCESS | 5384 | 16:09:17 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:09:17 INFO - PROCESS | 5384 | RSS: Main: 172511232 16:09:17 INFO - PROCESS | 5384 | 16:09:19 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43511/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:09:19 INFO - PROCESS | 5384 | RSS: Main: 179130368 16:09:19 INFO - PROCESS | 5384 | 16:09:21 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:09:22 INFO - PROCESS | 5384 | RSS: Main: 189693952 16:09:22 INFO - PROCESS | 5384 | 16:09:25 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:09:25 INFO - PROCESS | 5384 | RSS: Main: 198696960 16:09:25 INFO - PROCESS | 5384 | 16:09:28 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:09:29 INFO - PROCESS | 5384 | RSS: Main: 194355200 16:09:29 INFO - PROCESS | 5384 | 16:09:30 INFO - PROCESS | 5384 | Cycle 1(1): loaded http://localhost:43511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43511/tests/kraken/driver.html?testName=ai-astar) 16:09:31 INFO - PROCESS | 5384 | RSS: Main: 246136832 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | __start_tp_report 16:09:31 INFO - PROCESS | 5384 | _x_x_mozilla_page_load 16:09:31 INFO - PROCESS | 5384 | _x_x_mozilla_page_load_details 16:09:31 INFO - PROCESS | 5384 | |i|pagename|runs| 16:09:31 INFO - PROCESS | 5384 | |0;ai-astar;103;112;113;112;113;112;111;112;113;112 16:09:31 INFO - PROCESS | 5384 | |1;audio-beat-detection;144;116;117;152;117;117;115;120;142;118 16:09:31 INFO - PROCESS | 5384 | |2;audio-dft;162;161;161;160;161;163;162;161;162;160 16:09:31 INFO - PROCESS | 5384 | |3;audio-fft;74;76;77;107;77;77;76;75;88;75 16:09:31 INFO - PROCESS | 5384 | |4;audio-oscillator;82;82;112;81;81;80;92;80;81;107 16:09:31 INFO - PROCESS | 5384 | |5;imaging-gaussian-blur;113;113;114;113;113;113;115;114;114;114 16:09:31 INFO - PROCESS | 5384 | |6;imaging-darkroom;146;146;147;146;146;146;146;145;146;145 16:09:31 INFO - PROCESS | 5384 | |7;imaging-desaturate;94;94;94;94;93;94;93;94;94;93 16:09:31 INFO - PROCESS | 5384 | |8;json-parse-financial;57;56;58;56;59;54;54;54;54;55 16:09:31 INFO - PROCESS | 5384 | |9;json-stringify-tinderbox;53;53;53;53;53;52;53;53;54;53 16:09:31 INFO - PROCESS | 5384 | |10;stanford-crypto-aes;79;80;75;85;75;81;74;75;78;79 16:09:31 INFO - PROCESS | 5384 | |11;stanford-crypto-ccm;124;122;130;123;120;119;126;120;158;141 16:09:31 INFO - PROCESS | 5384 | |12;stanford-crypto-pbkdf2;164;163;162;166;162;165;164;162;160;162 16:09:31 INFO - PROCESS | 5384 | |13;stanford-crypto-sha256-iterative;60;60;60;61;61;60;62;61;60;62 16:09:31 INFO - PROCESS | 5384 | __end_tp_report 16:09:31 INFO - PROCESS | 5384 | __start_cc_report 16:09:31 INFO - PROCESS | 5384 | _x_x_mozilla_cycle_collect,1690 16:09:31 INFO - PROCESS | 5384 | __end_cc_report 16:09:31 INFO - PROCESS | 5384 | __startTimestamp1489532970998__endTimestamp 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | ------- Summary: start ------- 16:09:31 INFO - PROCESS | 5384 | Number of tests: 14 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.98 (2.7%) stddev-sans-first:0.67 16:09:31 INFO - PROCESS | 5384 | Values: 103.0 112.0 113.0 112.0 113.0 112.0 111.0 112.0 113.0 112.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#1] audio-beat-detection Cycles:10 Average:125.80 Median:119.00 stddev:14.22 (11.9%) stddev-sans-first:13.47 16:09:31 INFO - PROCESS | 5384 | Values: 144.0 116.0 117.0 152.0 117.0 117.0 115.0 120.0 142.0 118.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 16:09:31 INFO - PROCESS | 5384 | Values: 162.0 161.0 161.0 160.0 161.0 163.0 162.0 161.0 162.0 160.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#3] audio-fft Cycles:10 Average:80.20 Median:76.50 stddev:10.21 (13.3%) stddev-sans-first:10.58 16:09:31 INFO - PROCESS | 5384 | Values: 74.0 76.0 77.0 107.0 77.0 77.0 76.0 75.0 88.0 75.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:81.00 stddev:12.02 (14.8%) stddev-sans-first:12.56 16:09:31 INFO - PROCESS | 5384 | Values: 82.0 82.0 112.0 81.0 81.0 80.0 92.0 80.0 81.0 107.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 16:09:31 INFO - PROCESS | 5384 | Values: 113.0 113.0 114.0 113.0 113.0 113.0 115.0 114.0 114.0 114.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 16:09:31 INFO - PROCESS | 5384 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:09:31 INFO - PROCESS | 5384 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 93.0 94.0 94.0 93.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.83 (3.3%) stddev-sans-first:1.88 16:09:31 INFO - PROCESS | 5384 | Values: 57.0 56.0 58.0 56.0 59.0 54.0 54.0 54.0 54.0 55.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#9] json-stringify-tinderbox Cycles:10 Average:53.00 Median:53.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 16:09:31 INFO - PROCESS | 5384 | Values: 53.0 53.0 53.0 53.0 53.0 52.0 53.0 53.0 54.0 53.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:79.00 stddev:3.45 (4.4%) stddev-sans-first:3.64 16:09:31 INFO - PROCESS | 5384 | Values: 79.0 80.0 75.0 85.0 75.0 81.0 74.0 75.0 78.0 79.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:125.00 stddev:12.30 (9.8%) stddev-sans-first:12.95 16:09:31 INFO - PROCESS | 5384 | Values: 124.0 122.0 130.0 123.0 120.0 119.0 126.0 120.0 158.0 141.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:163.50 stddev:1.76 (1.1%) stddev-sans-first:1.83 16:09:31 INFO - PROCESS | 5384 | Values: 164.0 163.0 162.0 166.0 162.0 165.0 164.0 162.0 160.0 162.0 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - PROCESS | 5384 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 16:09:31 INFO - PROCESS | 5384 | Values: 60.0 60.0 60.0 61.0 61.0 60.0 62.0 61.0 60.0 62.0 16:09:31 INFO - PROCESS | 5384 | -------- Summary: end -------- 16:09:31 INFO - PROCESS | 5384 | 16:09:31 INFO - TEST-INFO | 5384: exit 0 16:09:32 INFO - TEST-OK | kraken | took 60070ms 16:09:32 INFO - SUITE-END | took 1175s 16:09:32 INFO - Completed test suite (00:19:35) 16:09:32 INFO - javascript benchmark 16:09:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7853.882735519372, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.899383018509, 3404.5914490261166, 3413.5391722117524, 3426.9828650856743, 3458.619551849296, 5717.085266357383, 5792.971035144818, 5801.738921748521, 5809.157672137538, 5823.767049318028, 5756.481916627503, 5861.296644402667, 5866.149408335788, 5871.060630299153, 5871.324797648272, 5169.405518365389, 5206.615699795145, 5238.5023422774775, 5259.789608415678, 5279.841604751844, 5045.0, 5083.720395378253, 5171.689698618076, 5289.8942021159555, 5303.628745987782, 5250.579953603722, 5266.762995665185, 5267.920981185285, 5278.0, 5293.920591191135, 5272.367315922094, 5287.841364759063, 5288.180332048539, 5289.2859463972445, 5297.761600727977, 5009.474005229435, 5081.28861959326, 5194.71429071401, 5200.635955483118, 5254.789808407659, 5706.543476521868, 5741.799037033726, 5791.8552036199435, 5795.2176456178295, 5799.594028418012, 6053.545984051169, 6140.7364488221765, 6227.377262273736, 6230.5638605297645, 6235.594686345418, 6298.811035668938, 6311.589746666452, 6316.557840951135, 6319.273283572402, 6320.589161704521, 5579.553635709133, 5690.430956904276, 5790.42095790426, 5825.970870145707, 5869.882602347929, 6399.13611662429, 6402.551821372553, 6411.070394792729, 6419.0, 6427.2929977702415, 6141.907871381933, 6163.445289923929, 6171.352008039181, 6174.104754810527, 6182.041783523561, 6036.5170786336985, 6067.423594758491, 6139.198457457749, 6210.441060304594, 6299.874002519924, 6248.562600618004, 6264.436200741955, 6266.843328916813, 6272.8118156455375, 6279.96860015697, 6006.519478441714, 6053.485453736482, 6128.356522565066, 6138.462537397657, 6160.045192995003, 4725.220338644085, 4761.238201887751, 4779.95220047802, 4784.569388755029, 4793.808247670124, 4259.659227261812, 4273.615374616237, 4290.635295999812, 4302.161078589645, 4327.221100201994, 5828.76684932598, 5841.094630332221, 5957.940420595739, 5966.0, 6004.279486461653, 6326.398992095744, 6328.462080723098, 6330.145430366933, 6330.4619107375465, 6331.461825744771, 6046.18376519173, 6052.243469566304, 6056.606320589148, 6057.727402266909, 6072.119542666289, 5167.483251674803, 5191.766370513336, 5266.368035835724, 5280.339957505312, 5360.571154307646, 6483.124778154983, 6521.11964884744, 6534.346565343428, 6535.967320163464, 6537.542372033912, 6232.376762323732, 6263.812085637438, 6284.685765711788, 6290.402411771058, 6297.496200304056, 6285.811425657238, 6325.810225693236, 6414.454771344302, 6541.70562324687, 6544.3782840630065, 6167.629942203482, 6183.474404675653, 6193.0, 6195.380461953769, 6210.161628180138, 6311.873762524632, 6313.2424109107205, 6316.494680425647, 6321.336259692666, 6325.209348831396, 5927.229460170151, 5957.434043765836, 6088.4215999479975, 6146.0473626587955, 6151.692415379123, 6076.3012253591405, 6105.084237364431, 6112.898653789679, 6160.537959653134, 6172.351903050115, 6136.5090792737365, 6140.846478838065, 6143.508519318354, 6146.846328841636, 6148.231471066117, 5963.105534169909, 5997.670128142994, 6021.969890150521, 6103.11504831788, 6144.0, 6049.879002419839, 6065.757369705162, 6077.969610151921, 6094.299155597163, 6100.908486372619], "value": 5743.907041076428, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.846830633873, 836.8284501677155, 840.5461051032443, 916.7891384981458, 916.9266458683306, 30209.942652007183, 30617.0, 32649.347013059723, 32666.346673066524, 43192.0, 44598.33102503457, 45151.0, 45318.32022519665, 45351.31973020407, 45430.772846135806, 9121.270298376114, 9269.582868770887, 9271.860922086174, 9273.443593384385, 9277.721668349926, 7563.470557061008, 7652.57910814905, 9088.454692718426, 9198.586063627154, 10656.946715266451, 10990.340579565212, 11024.228304018721, 11050.226484146073, 11052.115830733563, 11060.557577696882, 10957.83563246552, 10984.340939543574, 10988.230823842334, 10989.010989010947, 11032.117430605533, 10636.680899573024, 10706.892931070668, 10708.089812365959, 10711.089557387631, 10711.410872402015, 42299.0, 42451.0, 42552.361714574305, 42649.78675106636, 42663.7866810664, 4056.2090392373498, 4115.259253334399, 4122.443470131554, 4135.7518548887165, 4173.373993900909, 30804.383912321853, 30927.690723092706, 31144.53283200754, 31796.0, 32393.190170245696, 4369.4319738434115, 4399.802008909607, 4439.2675208590545, 4439.511653718088, 4476.104779044204, 217660.0, 219908.0, 221176.89411553, 222207.0, 222907.0, 53894.0, 53895.0, 53958.19062713984, 53972.0, 54032.0, 56095.0, 56205.43794562084, 56223.0, 56240.718796406574, 56342.43657563372, 14612.123272603678, 14912.478063267734, 14917.104973701613, 14939.925300373428, 14945.70108597822, 12863.485460581473, 12880.549180778815, 12885.22688638666, 12889.355532223351, 12939.870601293867, 11744.0, 11946.163768536293, 12617.684557885943, 13079.346032698328, 13537.729245415234, 5005.34930459038, 5067.721275329893, 5108.628305318472, 5126.974365128151, 5203.453637368098, 1008.909198172168, 1012.1851909213154, 1019.7093828259059, 1020.6121673763922, 1026.2918586175515, 27775.16674499768, 27916.16251512458, 28201.94968116875, 28429.431411371657, 28449.0, 1082.5020490574266, 1095.370162156763, 1097.2648325621853, 1101.3446999035561, 1111.183280288987, 14107.36516856744, 14696.779548306784, 14853.2573371331, 15001.849981500045, 15021.399144034334, 307701.0, 309300.0, 309741.0, 309942.0, 310766.0, 53806.0, 53869.0, 53913.73043134838, 53927.19109213365, 53982.730086349315, 1491.3736230783097, 1499.9475018374305, 1508.6831765329405, 1516.9154054850835, 1522.079142119002, 25827.225183244533, 27004.32489187786, 27502.0, 27559.586606200523, 27761.86119069392, 47378.28932566083, 47791.76104119457, 47829.28256076231, 47854.760726196146, 47904.04191916212, 334237.0, 334909.0, 335131.0, 336263.0, 337127.0, 29423.11730648084, 29658.25854353572, 29746.405071898007, 30019.0, 30118.84940575283, 33121.50317745284, 33232.833835830665, 35998.280034399686, 37874.242515148995, 38348.42477362786, 33730.49404258889, 33771.3245735079, 33814.15464613404, 33869.3226135471, 33916.660833391354, 33658.32683346368, 33688.49467258042, 33712.83143584365, 33733.662663373056, 34401.31197375988, 34574.82712586421, 34586.48120278148, 34627.13432164216, 34990.12524686903, 36217.09457263589, 30521.847390763793, 31688.36623267568, 31993.0, 32372.514412283363, 32518.349633006736, 25136.748632514173, 25423.23730288094, 25589.616155757307, 25739.0, 25916.222513324632], "value": 18585.580874792708, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.40405059245904, 448.7823405648262, 450.5832105302594, 462.5582568646942, 466.9743164125976, 19676.803231967675, 21224.787752122473, 21237.244897959194, 21419.464513387175, 21578.460538486546, 19778.208871645118, 20376.490587735316, 20501.692474612893, 20726.48183795406, 20803.0, 5318.627696061258, 6631.071649968996, 6788.91190531515, 6976.337247961435, 6982.825429364256, 6881.071055407506, 6910.896336554955, 6949.339812717809, 6968.756093536727, 6970.024196612479, 6706.765263215789, 6786.0, 6848.178218613748, 6860.142482189726, 6967.6167810770385, 6830.897536536956, 6854.794356169323, 6914.5159838811305, 6924.376806087476, 7319.0, 7513.39892808574, 7561.470697051209, 7566.356859666935, 7568.243175682443, 7572.886406703904, 24850.751492485026, 25375.0, 25543.61684574733, 25588.744112558823, 25729.742702572923, 3088.258817883714, 3181.1410919051727, 3205.054508919851, 3225.7580681448985, 3247.009662053073, 16191.271392787352, 16390.83609163917, 16576.83423165765, 16622.0, 16982.575435614086, 2263.5246598214394, 2315.0627864071885, 2325.058351367682, 2325.592981372327, 2358.50471401006, 80263.5986820068, 80464.59767701183, 83836.0, 104695.99999999924, 117849.0, 17494.65010699779, 17685.646287074185, 18214.0, 18298.176582053573, 18476.722849157275, 31265.8436707815, 31320.373592528023, 31362.686373135977, 31399.37201255962, 31643.525347119812, 9927.80144397108, 9979.45113018791, 10057.597696092074, 10225.0, 10251.333663311862, 8257.0, 8312.25189732927, 8353.874691879626, 8458.069612342637, 8513.574321283912, 9042.683506077386, 9049.457032578066, 9099.727008189764, 9309.627614895327, 9346.392484488486, 3622.42041273395, 3788.4885540452237, 3818.0, 3874.3800991841736, 3915.882523524299, 944.579662050381, 964.3827950111934, 966.7389804752818, 993.0863605482973, 1005.607812952949, 19336.8066319335, 19593.510162246057, 20442.897785511275, 21561.784382156293, 21659.566808663738, 1065.0999905080196, 1079.5681727308981, 1106.5186643809968, 1108.7616162524935, 1110.777844431117, 10612.20408469368, 11182.16133789969, 11335.659930202108, 11340.262882912584, 11345.546178152947, 631811.0, 633773.0, 639718.0, 652799.0, 655742.0, 84739.57630211809, 87630.56184719162, 120845.0, 122589.0, 124544.0, 1303.8696130386886, 1310.0, 1342.2215115233141, 1351.86481351866, 1357.7691792395317, 19102.23591056342, 19371.418857433735, 19385.51536211606, 19481.610367792848, 19522.31671891534, 52581.0, 52787.472125278255, 52819.735901320244, 53575.19637205367, 54924.725376372866, 67787.66106169438, 68897.65551172211, 69404.30595694181, 69722.65138674274, 70737.64631176811, 12108.51565937388, 12140.392980351124, 12414.441350139085, 12454.626361209179, 12484.0, 13538.323083845571, 13626.0, 13699.109557878706, 13756.243406612732, 14308.856911430752, 12056.75886482283, 12169.452374642986, 12305.876941230474, 12532.310722910328, 12736.363181840685, 11760.235584686969, 11859.0, 11995.580154694544, 12276.447559860006, 12495.187812792139, 12165.756684866075, 12583.496660133493, 12871.871281287442, 12956.8056479151, 13117.278549679859, 12150.21023633461, 12293.56972505958, 12341.876581234432, 12393.752124957631, 12708.555200567936, 11718.648440546796, 12049.759004820029, 12049.939750301193, 12104.45529951172, 12179.208351457128], "value": 11425.353363744256, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.3368001239453, 1502.0762231227798, 1521.208971334906, 1539.491967650676, 1568.427523953757, 10879.69443666759, 11561.53753849847, 11592.072634189266, 11603.24578902373, 11617.709557261061, 11299.661010169708, 11336.829947550794, 11545.884541154586, 12003.399830008486, 12041.759164816698, 2424.2969538833718, 2462.2859370782453, 2466.0, 2466.272449627364, 2469.2221950085755, 2388.7358493365386, 2436.196055301755, 2436.232586735173, 2437.171361737009, 2437.195725410619, 2334.6264597664376, 2377.2511658827502, 2385.522895420914, 2394.0, 2394.437307232799, 2257.537204872997, 2275.283285764987, 2283.2122917593406, 2284.7486776454575, 2284.7486776454575, 2298.4598619324447, 2326.639370897514, 2352.3883790214495, 2352.635341522067, 2353.0470159585225, 11449.656510304705, 11594.94202528982, 11608.4195790211, 11640.06879449642, 11658.941705291503, 5508.889822203533, 5642.943570564324, 5658.971705141448, 5662.320521537442, 5663.575231857586, 3569.9107522311892, 3640.7815531068222, 3684.1342284563107, 3695.2794205130012, 3714.7956862372557, 1301.1672529581076, 1346.7845144776788, 1368.8494265630773, 1387.7016441465134, 1433.1544388810548, 16763.329466821433, 16771.748423773653, 16968.660626787518, 17102.828971710373, 17116.058616776074, 4493.820247190076, 4629.537046295411, 4676.766161691902, 4771.761411929389, 4774.116788394158, 12730.490780368867, 12732.299723515296, 12740.80888786669, 12746.872531274754, 12807.16753411044, 5646.124850648156, 5650.689212093374, 5656.377798442168, 5660.688662123623, 5663.971680141655, 5169.81905633301, 5270.894582108336, 5341.092014357569, 5404.270423492778, 5479.835604931858, 3975.4235635832642, 4005.639492445694, 4044.51465824103, 4057.6753859691153, 4088.4889388826396, 1038.444432228754, 1049.8792638846478, 1055.7730088030958, 1059.9417032063157, 1073.806714791345, 961.778790878102, 967.8790151231096, 974.3131092579714, 982.2387649571639, 988.8862780780158, 6246.843828904313, 6250.062490626442, 6294.8111556653375, 6343.524235682342, 7092.736961439968, 1043.9947800261102, 1104.0725790335996, 1106.4578356605205, 1110.3837370259423, 1124.2860783402598, 4922.729249891218, 4947.925781113287, 4989.376327959005, 5029.396472423333, 5078.314427552233, 13780.448782048807, 14316.0, 14340.282985850667, 14585.343659535347, 14591.92704036473, 14235.359408826627, 14363.281835908163, 14456.277186140862, 14457.710845783025, 14568.85431145675, 8736.8689469658, 9051.547422628842, 10330.690079297634, 10508.369497830156, 10608.098311643442, 6950.3049695030095, 6961.582305061713, 6977.406920411822, 7127.75052873147, 7216.3505284524645, 12887.0, 12903.935480322538, 13017.544385946447, 13055.086143969831, 13185.142965707199, 13113.475460981454, 13189.670258243621, 13234.338283086, 13250.602481925558, 13508.257045862572, 9662.758431039, 9881.703548893545, 9987.101160895554, 10002.549885255326, 10004.899951000689, 10492.580296788348, 10690.037896589345, 10754.085902698358, 10872.61945831892, 11095.16786241019, 9644.228461723185, 9693.41839489633, 9789.118979291898, 9978.151857092229, 10106.292559520763, 9523.904760952302, 9546.236301095756, 9677.854832177663, 9679.128878400978, 9696.321257511907, 7428.108626964583, 7463.626818659154, 7466.440016998856, 7487.925120748941, 7887.250711182429, 6328.968355158195, 6432.839179020562, 6454.935450645621, 6530.281669016499, 6555.246146693001, 6171.413715697002, 6261.217347831521, 6304.65324407162, 6317.747290108528, 6381.968090159519], "value": 5354.99259208779, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.0703885311239, 413.4748868936451, 416.09499338937843, 419.4442363867875, 441.8033974881179, 5260.894782104356, 5286.8413947581585, 5300.416954135047, 5312.73436328184, 5337.5196232339085, 5069.414598554736, 5195.68825870448, 5207.244949482323, 5224.346956630421, 5275.340582427197, 4443.800028998687, 4445.599896009358, 4461.910761784762, 4464.258939013787, 4480.843170489034, 4456.844010459618, 4467.955320446787, 4476.418065651461, 4476.440444944382, 4483.3723278741, 4254.404383386328, 4410.2723050696595, 4433.827424561958, 4443.5556444355625, 4445.644348452132, 4390.8902277443, 4430.31330143825, 4433.401490798749, 4435.381085903638, 4440.644748420119, 4245.426867372896, 4264.125854199881, 4270.743755374688, 4271.786410679485, 4293.828246870122, 4959.900801983977, 5084.567811736007, 5132.024915266087, 5146.691198528063, 5147.588192944593, 5182.766775495074, 5223.686578805284, 5229.816956406546, 5242.423333433319, 5248.763805628756, 5517.751701173457, 5551.444855514456, 5551.77792888284, 5554.777808887639, 5604.831855044315, 4640.535946405366, 4768.380110585636, 4792.736399498026, 4832.081904438145, 4839.112746029052, 5493.23094766733, 5551.500364967173, 5671.744771485293, 5748.827535173951, 5789.0, 4983.775730092155, 4992.375953005874, 5004.574611158019, 5021.372328458942, 5021.915904899499, 4834.854954351375, 4991.900161996739, 5044.571211447068, 5050.191969284971, 5079.0541485938065, 4979.460475157695, 5107.157319042316, 5185.455527169668, 5255.02781985334, 5263.0, 5513.862153446115, 5514.228008078872, 5515.420880807457, 5525.917111243334, 5530.760042182922, 1720.698877696423, 1746.5458980665119, 1766.169900146929, 1766.4788887278028, 1772.1493683032218, 1402.4810819996667, 1440.762274224741, 1443.8700516953525, 1462.8537146285287, 1463.5170393770031, 5423.322084739408, 5430.5384042356845, 5440.483154100354, 5445.972770136124, 5449.6730196188355, 5659.462351076641, 5690.914636280377, 5699.515541178963, 5704.629199102128, 5709.972959599366, 5159.251908473326, 5366.899785544032, 5428.240046393508, 5438.83683489496, 5465.617406781566, 2971.465136275491, 2984.552317152401, 2986.22358186873, 2988.2678743707497, 2992.5959995400776, 5633.521150702154, 5831.94168058314, 5876.324222714443, 5883.882322353529, 5902.3507414184405, 5805.709714514257, 5833.649981001154, 5835.153902684172, 5847.427132061879, 5853.0635098384055, 5794.246747922743, 5832.416758324133, 5850.707464626752, 5864.7947321844385, 5957.868005079021, 5494.36814766307, 5571.66570005801, 5632.887342253214, 5695.601307908407, 5714.485696287354, 5376.381716102542, 5616.556797792973, 5634.6337488063145, 5637.703328234447, 5638.295213098363, 5715.257016587817, 5759.222504961776, 5784.913226301693, 5798.768049277982, 5810.593258471867, 4673.252279635242, 4683.36774535447, 4689.085628302585, 4693.507181746004, 4694.201985662377, 5446.346438427414, 5631.718414079198, 5657.4908258256955, 5661.971690141523, 5672.801451949327, 5462.126059830408, 5496.532794712334, 5511.311086114236, 5518.255035570147, 5528.44715528444, 5528.585356098389, 5534.640248383842, 5537.473939975695, 5544.63959842609, 5546.417626149358, 5291.259223708606, 5491.780328786804, 5537.418571049981, 5554.194641776839, 5581.297704200258, 5510.0, 5541.528970037431, 5565.554755619622, 5574.602920744119, 5606.215129881738, 5270.920936185884, 5422.267993820784, 5426.2674538936735, 5450.945490545202, 5499.890002200013], "value": 4499.110638325374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [871.381319263323, 910.0308171797031, 918.1598837064087, 921.663592788632, 941.9105185007426, 16224.432144874918, 18079.548011299725, 18152.636947261046, 18241.270349186016, 18305.633887322245, 15890.52328430149, 15911.0, 16015.679686406265, 16033.278502467389, 16067.598310042225, 704.9224585295614, 720.164609053498, 725.0393228971608, 889.550776857686, 907.5144797533321, 881.066069965835, 896.802703405253, 911.1253196930921, 911.2618778789168, 912.9954350228239, 961.2982522758391, 963.4123184857232, 963.6916186820221, 964.6382606522554, 968.5060619084247, 733.8679037773198, 745.4893398022372, 932.1470854168496, 956.1681337236614, 960.4669408478292, 693.1162767471463, 694.506900100929, 695.6313154028322, 696.495041095207, 697.2957313113741, 17072.743908841378, 17099.57251068721, 17143.657126857517, 17198.484045478657, 18110.90944545282, 15699.843001570067, 16278.26747796352, 16784.244708988124, 16897.91551042237, 17210.139493025425, 13858.861411385958, 13934.0, 14203.147811131365, 14244.643883902881, 14247.501337453139, 4159.272127377727, 4187.267228235077, 4210.915781684349, 4245.1934132514725, 4293.184294983975, 88037.0, 88384.55807720985, 88941.55529222377, 89009.10990890137, 91228.54385728095, 13535.32323383827, 13698.863011369958, 13804.0, 13910.652233694238, 13997.720045599235, 26950.03054489115, 26978.460430791667, 27130.0, 27181.86409067942, 27471.17586472409, 9205.263578913671, 9236.399634023766, 9506.33455658111, 9511.619535218651, 9537.61849526025, 4625.421822272216, 4731.384919960452, 4758.452777930513, 4856.538628830255, 4888.804447822047, 3962.980185099114, 4038.192361527706, 4072.2873497137884, 4093.365528343052, 4109.794510274474, 674.0125715826338, 677.664556044761, 679.4123083532709, 682.9795106146823, 699.2867275379085, 680.1566058087935, 683.3917813146304, 688.3873352715987, 698.4272896225046, 698.9965050174717, 10923.180761442924, 10931.672049838518, 11399.373034483016, 11805.586804461802, 11813.350265735467, 687.151368060455, 696.665600511747, 702.301210295759, 711.1608302203347, 715.7530651925077, 5255.0, 5476.397596264408, 5613.663180209119, 5619.100943849046, 5663.263775709213, 77734.22265777383, 78581.60709196418, 79042.20957790349, 80347.59826200949, 80441.0, 57817.0, 64821.351786482475, 66441.33558664352, 67537.3246267531, 75210.0, 54177.0, 54785.452145478834, 61976.69011654913, 63343.0, 63879.36120638827, 11071.0, 11838.0, 11874.46564904564, 11906.880931190577, 12165.270083795001, 38584.80707596444, 39686.801565991984, 41781.58218417777, 43126.13747725091, 43675.12649747051, 56046.0, 57697.134542981046, 58101.709491452275, 58807.0, 59166.11250831155, 14033.29833508341, 14037.719245614826, 14054.367553460323, 14085.718285634435, 14292.571222863331, 16808.915955420143, 16956.830431695525, 17042.147892605568, 17159.056251906266, 18286.359977400727, 14121.364538595582, 14145.080569762933, 14192.858071419154, 14667.339969701176, 14680.192589407685, 15403.383864645737, 15488.380464781283, 15903.0, 16498.58753531171, 16642.3343066276, 14327.78508322355, 14795.852041479448, 15358.155301458528, 15624.0, 15677.0, 13089.541866035024, 13348.265845378597, 13786.586402407944, 13803.0, 14269.450092720153, 10665.786684266426, 12770.361481926053, 13179.472821087049, 13504.392302346614, 13617.31913404306], "value": 7986.022618110169, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 112.0, 113.0, 112.0, 111.0, 112.0, 113.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 117.0, 152.0, 117.0, 117.0, 115.0, 120.0, 142.0, 118.0], "value": 125.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 161.0, 163.0, 162.0, 161.0, 162.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 107.0, 77.0, 77.0, 76.0, 75.0, 88.0, 75.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 81.0, 81.0, 80.0, 92.0, 80.0, 81.0, 107.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 115.0, 114.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 56.0, 59.0, 54.0, 54.0, 54.0, 54.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 54.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 75.0, 85.0, 75.0, 81.0, 74.0, 75.0, 78.0, 79.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 122.0, 130.0, 123.0, 120.0, 119.0, 126.0, 120.0, 158.0, 141.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 166.0, 162.0, 165.0, 164.0, 162.0, 160.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 61.0, 60.0, 62.0, 61.0, 60.0, 62.0], "value": 60.7, "unit": "score"}]}]} 16:09:32 INFO - Return code: 0 16:09:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:09:32 ERROR - # TBPL SUCCESS # 16:09:32 INFO - Running post-action listener: _resource_record_post_action 16:09:32 INFO - [mozharness: 2017-03-14 23:09:32.331629Z] Finished run-tests step (success) 16:09:32 INFO - Running post-run listener: _resource_record_post_run 16:09:32 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 262144; Write bytes: 366006272; Read time: 16; Write time: 266652 16:09:32 INFO - TinderboxPrint: CPU usage
13.1% 16:09:32 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 16 16:09:32 INFO - TinderboxPrint: I/O write bytes / time
366,006,272 / 266,652 16:09:32 INFO - TinderboxPrint: CPU idle
8,264.1 (86.9%) 16:09:32 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 16:09:32 INFO - TinderboxPrint: Swap in / out
0 / 0 16:09:32 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111026176; Read time: 0; Write time: 119516 16:09:32 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 254980096; Read time: 16; Write time: 147136 16:09:32 INFO - Running post-run listener: _upload_blobber_files 16:09:32 INFO - Blob upload gear active. 16:09:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:32 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 16:09:32 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:09:32 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:09:33 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:09:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:09:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:34 INFO - (blobuploader) - INFO - Done attempting. 16:09:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:09:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:09:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:35 INFO - (blobuploader) - INFO - Done attempting. 16:09:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:09:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:38 INFO - (blobuploader) - INFO - Done attempting. 16:09:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:09:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:09:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:39 INFO - (blobuploader) - INFO - Done attempting. 16:09:39 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:39 INFO - Return code: 0 16:09:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdd44b090c54c0f36e8191e161a2f6e53e830c19ad889faedf8375ea9d6f21bf0ffcda19e739276c467879046c1727e8a8c6d4e46512c3f3f08658b83123a4ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9f365a76d78da258fc55de6d663edd7efc9a5f42bf131fcd6ba84e532dcbdf72164ca4d99b0c5ac5a4aedc38fbaed2b0916f8959f5834b627769b7df27806c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0f6a5f1ec8687af8b64b607a0ee73115a78a4475ac55d7bacfa986290683383b219ee283dcc073553374c906565d49ec53023e96c43fac7dc33338bb13515df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96d5dabcc7974b5de5c09d7cf379583471a7f3d0c990fe544fb3fe75542b1c0e4433e75bbc62a30920c8026b25631414bcea4d85efdc5851273d43c44c9fcb48"} 16:09:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:39 INFO - Contents: 16:09:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdd44b090c54c0f36e8191e161a2f6e53e830c19ad889faedf8375ea9d6f21bf0ffcda19e739276c467879046c1727e8a8c6d4e46512c3f3f08658b83123a4ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9f365a76d78da258fc55de6d663edd7efc9a5f42bf131fcd6ba84e532dcbdf72164ca4d99b0c5ac5a4aedc38fbaed2b0916f8959f5834b627769b7df27806c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0f6a5f1ec8687af8b64b607a0ee73115a78a4475ac55d7bacfa986290683383b219ee283dcc073553374c906565d49ec53023e96c43fac7dc33338bb13515df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96d5dabcc7974b5de5c09d7cf379583471a7f3d0c990fe544fb3fe75542b1c0e4433e75bbc62a30920c8026b25631414bcea4d85efdc5851273d43c44c9fcb48"} 16:09:39 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:39 INFO - Copying logs to upload dir... 16:09:39 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.353109 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-14 16:09:38.713797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 16:09:38.717519) ========= 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=51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdd44b090c54c0f36e8191e161a2f6e53e830c19ad889faedf8375ea9d6f21bf0ffcda19e739276c467879046c1727e8a8c6d4e46512c3f3f08658b83123a4ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9f365a76d78da258fc55de6d663edd7efc9a5f42bf131fcd6ba84e532dcbdf72164ca4d99b0c5ac5a4aedc38fbaed2b0916f8959f5834b627769b7df27806c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0f6a5f1ec8687af8b64b607a0ee73115a78a4475ac55d7bacfa986290683383b219ee283dcc073553374c906565d49ec53023e96c43fac7dc33338bb13515df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96d5dabcc7974b5de5c09d7cf379583471a7f3d0c990fe544fb3fe75542b1c0e4433e75bbc62a30920c8026b25631414bcea4d85efdc5851273d43c44c9fcb48"} build_url:https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/ZBy6pcTUTTKaAAo3Dkbwtg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdd44b090c54c0f36e8191e161a2f6e53e830c19ad889faedf8375ea9d6f21bf0ffcda19e739276c467879046c1727e8a8c6d4e46512c3f3f08658b83123a4ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9f365a76d78da258fc55de6d663edd7efc9a5f42bf131fcd6ba84e532dcbdf72164ca4d99b0c5ac5a4aedc38fbaed2b0916f8959f5834b627769b7df27806c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0f6a5f1ec8687af8b64b607a0ee73115a78a4475ac55d7bacfa986290683383b219ee283dcc073553374c906565d49ec53023e96c43fac7dc33338bb13515df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96d5dabcc7974b5de5c09d7cf379583471a7f3d0c990fe544fb3fe75542b1c0e4433e75bbc62a30920c8026b25631414bcea4d85efdc5851273d43c44c9fcb48"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 16:09:38.743172) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 16:09:38.743509) ========= 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=51fc86400edbde9650d2781a000001d0-1489531726.198002-58011285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 16:09:38.830270) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 16:09:38.831009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 16:09:38.831788) ========= ========= Total master_lag: 0.16 =========