builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1486255262.48 results: success (0) revision: 45d7372ceb6695e42915f11a4d30fce43cb59841 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-04 16:41:02.485178) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-04 16:41:02.485958) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-04 16:41:02.486261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-04 16:41:02.535352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 16:41:02.535703) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-04 16:41:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-02-04 16:41:03 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120117 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 16:41:02.672868) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 16:41:02.673169) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019012 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 16:41:02.723954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-04 16:41:02.724428) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 45d7372ceb6695e42915f11a4d30fce43cb59841 --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 45d7372ceb6695e42915f11a4d30fce43cb59841 --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=82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-04 16:41:03,211 truncating revision to first 12 chars 2017-02-04 16:41:03,211 Setting DEBUG logging. 2017-02-04 16:41:03,211 attempt 1/10 2017-02-04 16:41:03,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/45d7372ceb66?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-04 16:41:03,935 unpacking tar archive at: mozilla-aurora-45d7372ceb66/testing/mozharness/ program finished with exit code 0 elapsedTime=1.022272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-04 16:41:03.761242) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-04 16:41:03.761578) ========= script_repo_revision: 45d7372ceb6695e42915f11a4d30fce43cb59841 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-04 16:41:03.762052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-04 16:41:03.762332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-04 16:41:03.770133) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-04 16:41:03.770484) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:41:04 INFO - MultiFileLogger online at 20170204 16:41:04 in /builds/slave/test 16:41:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 16:41:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:41:04 INFO - {'append_to_log': False, 16:41:04 INFO - 'base_work_dir': '/builds/slave/test', 16:41:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 16:41:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:41:04 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 16:41:04 INFO - 'buildbot_json_path': 'buildprops.json', 16:41:04 INFO - 'config_files': ('talos/linux_config.py',), 16:41:04 INFO - 'default_actions': ('clobber', 16:41:04 INFO - 'read-buildbot-config', 16:41:04 INFO - 'download-and-extract', 16:41:04 INFO - 'populate-webroot', 16:41:04 INFO - 'create-virtualenv', 16:41:04 INFO - 'install', 16:41:04 INFO - 'run-tests'), 16:41:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:41:04 INFO - 'download_minidump_stackwalk': True, 16:41:04 INFO - 'download_symbols': 'ondemand', 16:41:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:41:04 INFO - 'tooltool.py': '/tools/tooltool.py', 16:41:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:41:04 INFO - '/tools/misc-python/virtualenv.py')}, 16:41:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:41:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:41:04 INFO - 'installer_path': 'installer.exe', 16:41:04 INFO - 'log_level': 'info', 16:41:04 INFO - 'log_name': 'talos', 16:41:04 INFO - 'log_to_console': True, 16:41:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:41:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:41:04 INFO - 'opt_config_files': (), 16:41:04 INFO - 'pip_index': False, 16:41:04 INFO - 'sps_profile': False, 16:41:04 INFO - 'sps_profile_interval': 0, 16:41:04 INFO - 'suite': 'dromaeojs', 16:41:04 INFO - 'system_bits': '32', 16:41:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:41:04 INFO - 'title': 'talos-linux64-ix-066', 16:41:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:41:04 INFO - 'use_talos_json': True, 16:41:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:41:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:41:04 INFO - 'work_dir': 'build'} 16:41:04 INFO - [mozharness: 2017-02-05 00:41:04.354463Z] Running clobber step. 16:41:04 INFO - Running pre-action listener: _resource_record_pre_action 16:41:04 INFO - Running main action method: clobber 16:41:04 INFO - rmtree: /builds/slave/test/build 16:41:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:41:05 INFO - Running post-action listener: _resource_record_post_action 16:41:05 INFO - [mozharness: 2017-02-05 00:41:05.330079Z] Finished clobber step (success) 16:41:05 INFO - [mozharness: 2017-02-05 00:41:05.330185Z] Running read-buildbot-config step. 16:41:05 INFO - Running pre-action listener: _resource_record_pre_action 16:41:05 INFO - Running main action method: read_buildbot_config 16:41:05 INFO - Using buildbot properties: 16:41:05 INFO - { 16:41:05 INFO - "project": "", 16:41:05 INFO - "product": "firefox", 16:41:05 INFO - "who": "philringnalda@gmail.com", 16:41:05 INFO - "installer_path": "public/build/target.tar.bz2", 16:41:05 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:41:05 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 16:41:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 16:41:05 INFO - "stage_platform": "linux64", 16:41:05 INFO - "basedir": "/builds/slave/test", 16:41:05 INFO - "buildnumber": 17, 16:41:05 INFO - "platform": "ubuntu64_hw", 16:41:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:41:05 INFO - "slavebuilddir": "test", 16:41:05 INFO - "taskId": "Pj0VYM5kQse4gnF8K1_52g", 16:41:05 INFO - "branch": "mozilla-aurora", 16:41:05 INFO - "script_repo_revision": "production", 16:41:05 INFO - "revision": "45d7372ceb6695e42915f11a4d30fce43cb59841", 16:41:05 INFO - "slavename": "talos-linux64-ix-066", 16:41:05 INFO - "repo_path": "releases/mozilla-aurora" 16:41:05 INFO - } 16:41:05 INFO - Finding installer, test and symbols from parent task. 16:41:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pj0VYM5kQse4gnF8K1_52g'}, attempt #1 16:41:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pj0VYM5kQse4gnF8K1_52g'}, attempt #1 16:41:06 INFO - Task dependencies: bHDcf800SrygbZPp_D5WDg 16:41:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg'}, attempt #1 16:41:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.tar.bz2 16:41:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/test_packages.json 16:41:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.crashreporter-symbols.zip 16:41:06 INFO - Running post-action listener: _resource_record_post_action 16:41:06 INFO - [mozharness: 2017-02-05 00:41:06.706429Z] Finished read-buildbot-config step (success) 16:41:06 INFO - [mozharness: 2017-02-05 00:41:06.706647Z] Running download-and-extract step. 16:41:06 INFO - Running pre-action listener: _resource_record_pre_action 16:41:06 INFO - Running main action method: download_and_extract 16:41:06 INFO - mkdir: /builds/slave/test/build/tests 16:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:06 INFO - trying https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.test_packages.json 16:41:06 INFO - Downloading https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:41:07 INFO - Downloaded 896 bytes. 16:41:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:41:07 INFO - Using the following test package requirements: 16:41:07 INFO - {u'common': [u'target.common.tests.zip'], 16:41:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:41:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:41:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:41:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:41:07 INFO - u'mozbase': [u'target.common.tests.zip'], 16:41:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:41:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:41:07 INFO - u'web-platform': [u'target.common.tests.zip', 16:41:07 INFO - u'target.web-platform.tests.zip'], 16:41:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:41:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:41:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.common.tests.zip 16:41:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:41:07 INFO - Fetch https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.common.tests.zip into memory 16:41:08 INFO - Expected file size: 21854114 16:41:08 INFO - Obtained file size: 21854114 16:41:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:41:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.common.tests.zip 16:41:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:41:12 INFO - Fetch https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.common.tests.zip into memory 16:41:12 INFO - Expected file size: 21854114 16:41:12 INFO - Obtained file size: 21854114 16:41:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.talos.tests.zip 16:41:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:41:17 INFO - Fetch https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.talos.tests.zip into memory 16:41:18 INFO - Expected file size: 14403485 16:41:18 INFO - Obtained file size: 14403485 16:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:18 INFO - trying https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.tar.bz2 16:41:18 INFO - Downloading https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:41:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:41:19 INFO - Downloaded 66067766 bytes. 16:41:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.tar.bz2 16:41:19 INFO - mkdir: /builds/slave/test/properties 16:41:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:41:19 INFO - Writing to file /builds/slave/test/properties/build_url 16:41:19 INFO - Contents: 16:41:19 INFO - build_url:https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.tar.bz2 16:41:19 INFO - Running post-action listener: _resource_record_post_action 16:41:19 INFO - Running post-action listener: set_extra_try_arguments 16:41:19 INFO - [mozharness: 2017-02-05 00:41:19.544053Z] Finished download-and-extract step (success) 16:41:19 INFO - [mozharness: 2017-02-05 00:41:19.544151Z] Running populate-webroot step. 16:41:19 INFO - Running pre-action listener: _resource_record_pre_action 16:41:19 INFO - Running main action method: populate_webroot 16:41:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:41:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:41:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:41:19 INFO - '--tppagecycles', 16:41:19 INFO - '7'], 16:41:19 INFO - 'tests': ['tsvgm']}}, 16:41:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:41:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:41:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:41:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:41:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:41:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:41:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:41:19 INFO - 'talos_options': ['--disable-e10s'], 16:41:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:41:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:41:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:41:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:41:19 INFO - 'talos_options': ['--disable-e10s'], 16:41:19 INFO - 'tests': ['damp', 'tps']}, 16:41:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:41:19 INFO - 'tests': ['damp', 'tps']}, 16:41:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:41:19 INFO - 'tests': ['dromaeo_dom']}, 16:41:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:41:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:41:19 INFO - 'tests': ['basic_compositor_video']}, 16:41:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:41:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:41:19 INFO - 'tests': ['a11yr', 16:41:19 INFO - 'ts_paint', 16:41:19 INFO - 'tpaint', 16:41:19 INFO - 'sessionrestore', 16:41:19 INFO - 'sessionrestore_no_auto_restore', 16:41:19 INFO - 'tabpaint']}, 16:41:19 INFO - 'other-e10s': {'tests': ['a11yr', 16:41:19 INFO - 'ts_paint', 16:41:19 INFO - 'tpaint', 16:41:19 INFO - 'sessionrestore', 16:41:19 INFO - 'sessionrestore_no_auto_restore', 16:41:19 INFO - 'tabpaint']}, 16:41:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:41:19 INFO - 'ts_paint', 16:41:19 INFO - 'tpaint', 16:41:19 INFO - 'sessionrestore', 16:41:19 INFO - 'sessionrestore_no_auto_restore', 16:41:19 INFO - 'tabpaint']}, 16:41:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:41:19 INFO - 'ts_paint', 16:41:19 INFO - 'tpaint', 16:41:19 INFO - 'sessionrestore', 16:41:19 INFO - 'sessionrestore_no_auto_restore', 16:41:19 INFO - 'tabpaint']}, 16:41:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:41:19 INFO - 'tests': ['a11yr', 16:41:19 INFO - 'ts_paint', 16:41:19 INFO - 'tpaint', 16:41:19 INFO - 'sessionrestore', 16:41:19 INFO - 'sessionrestore_no_auto_restore', 16:41:19 INFO - 'tabpaint']}, 16:41:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:41:19 INFO - 'tests': ['a11yr', 16:41:19 INFO - 'ts_paint', 16:41:19 INFO - 'tpaint', 16:41:19 INFO - 'sessionrestore', 16:41:19 INFO - 'sessionrestore_no_auto_restore', 16:41:19 INFO - 'tabpaint']}, 16:41:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:41:19 INFO - 'tests': ['tsvgx', 16:41:19 INFO - 'tsvgr_opacity', 16:41:19 INFO - 'tart', 16:41:19 INFO - 'tscrollx', 16:41:19 INFO - 'cart', 16:41:19 INFO - 'tsvg_static']}, 16:41:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:41:19 INFO - 'tsvgr_opacity', 16:41:19 INFO - 'tart', 16:41:19 INFO - 'tscrollx', 16:41:19 INFO - 'cart', 16:41:19 INFO - 'tsvg_static']}, 16:41:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:41:19 INFO - 'talos_options': ['--disable-e10s'], 16:41:19 INFO - 'tests': ['tp5o']}, 16:41:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:41:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:41:19 INFO - 'talos_options': ['--disable-e10s', 16:41:19 INFO - '--xperf_path', 16:41:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:41:19 INFO - 'tests': ['tp5n']}, 16:41:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:41:19 INFO - 'talos_options': ['--xperf_path', 16:41:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:41:19 INFO - 'tests': ['tp5n']}}, 16:41:19 INFO - 'talos.zip': {'path': '', 16:41:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:41:19 INFO - Running post-action listener: _resource_record_post_action 16:41:19 INFO - [mozharness: 2017-02-05 00:41:19.557247Z] Finished populate-webroot step (success) 16:41:19 INFO - [mozharness: 2017-02-05 00:41:19.557337Z] Running create-virtualenv step. 16:41:19 INFO - Running pre-action listener: _resource_record_pre_action 16:41:19 INFO - Running main action method: create_virtualenv 16:41:19 INFO - Creating virtualenv /builds/slave/test/build/venv 16:41:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:41:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:41:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:41:19 INFO - Using real prefix '/usr' 16:41:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:41:20 INFO - Installing distribute.............................................................................................................................................................................................done. 16:41:22 INFO - Installing pip.................done. 16:41:22 INFO - Return code: 0 16:41:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:41:22 INFO - Reading from file tmpfile_stdout 16:41:22 INFO - Output received: 16:41:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:41:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:41: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')]} 16:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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')]} 16:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a4d00>, '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 0x20a5a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a5eb0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:41: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', 'pip>=1.5'] in /builds/slave/test/build 16:41: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 pip>=1.5 16:41:22 INFO - Using env: {'DISPLAY': ':0', 16:41:22 INFO - 'HOME': '/home/cltbld', 16:41:22 INFO - 'LANG': 'en_US.UTF-8', 16:41:22 INFO - 'LANGUAGE': 'en_US:en', 16:41:22 INFO - 'LOGNAME': 'cltbld', 16:41:22 INFO - 'MAIL': '/var/mail/cltbld', 16:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:22 INFO - 'MOZ_NO_REMOTE': '1', 16:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:22 INFO - 'NO_EM_RESTART': '1', 16:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:22 INFO - 'PWD': '/builds/slave/test', 16:41:22 INFO - 'SHELL': '/bin/bash', 16:41:22 INFO - 'SHLVL': '1', 16:41:22 INFO - 'TERM': 'linux', 16:41:22 INFO - 'TMOUT': '86400', 16:41:22 INFO - 'USER': 'cltbld', 16:41:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 16:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:22 INFO - '_': '/tools/buildbot/bin/python'} 16:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:41:22 INFO - Cleaning up... 16:41:22 INFO - Return code: 0 16:41:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:41: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')]} 16:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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')]} 16:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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', '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 0x1d351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a4d00>, '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 0x20a5a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a5eb0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:41: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:41: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 psutil>=3.1.1 16:41:22 INFO - Using env: {'DISPLAY': ':0', 16:41:22 INFO - 'HOME': '/home/cltbld', 16:41:22 INFO - 'LANG': 'en_US.UTF-8', 16:41:22 INFO - 'LANGUAGE': 'en_US:en', 16:41:22 INFO - 'LOGNAME': 'cltbld', 16:41:22 INFO - 'MAIL': '/var/mail/cltbld', 16:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:22 INFO - 'MOZ_NO_REMOTE': '1', 16:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:22 INFO - 'NO_EM_RESTART': '1', 16:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:22 INFO - 'PWD': '/builds/slave/test', 16:41:22 INFO - 'SHELL': '/bin/bash', 16:41:22 INFO - 'SHLVL': '1', 16:41:22 INFO - 'TERM': 'linux', 16:41:22 INFO - 'TMOUT': '86400', 16:41:22 INFO - 'USER': 'cltbld', 16:41:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 16:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:22 INFO - '_': '/tools/buildbot/bin/python'} 16:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:22 INFO - Downloading/unpacking psutil>=3.1.1 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:41:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:41:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:41:24 INFO - Installing collected packages: psutil 16:41:24 INFO - Running setup.py install for psutil 16:41:24 INFO - building 'psutil._psutil_linux' extension 16:41:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:41:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:41:25 INFO - building 'psutil._psutil_posix' extension 16:41:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:41:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:41:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:41:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:41:25 INFO - Successfully installed psutil 16:41:25 INFO - Cleaning up... 16:41:25 INFO - Return code: 0 16:41:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:25 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 0x1d351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a4d00>, '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 0x20a5a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a5eb0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:41:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:41:25 INFO - Using env: {'DISPLAY': ':0', 16:41:25 INFO - 'HOME': '/home/cltbld', 16:41:25 INFO - 'LANG': 'en_US.UTF-8', 16:41:25 INFO - 'LANGUAGE': 'en_US:en', 16:41:25 INFO - 'LOGNAME': 'cltbld', 16:41:25 INFO - 'MAIL': '/var/mail/cltbld', 16:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:25 INFO - 'MOZ_NO_REMOTE': '1', 16:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:25 INFO - 'NO_EM_RESTART': '1', 16:41:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:25 INFO - 'PWD': '/builds/slave/test', 16:41:25 INFO - 'SHELL': '/bin/bash', 16:41:25 INFO - 'SHLVL': '1', 16:41:25 INFO - 'TERM': 'linux', 16:41:25 INFO - 'TMOUT': '86400', 16:41:25 INFO - 'USER': 'cltbld', 16:41:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 16:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:25 INFO - '_': '/tools/buildbot/bin/python'} 16:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:41:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:41:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:41:27 INFO - Installing collected packages: mozsystemmonitor 16:41:27 INFO - Running setup.py install for mozsystemmonitor 16:41:27 INFO - Successfully installed mozsystemmonitor 16:41:27 INFO - Cleaning up... 16:41:27 INFO - Return code: 0 16:41:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:41: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')]} 16:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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')]} 16:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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', '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 0x1d351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a4d00>, '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 0x20a5a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a5eb0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:41: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:41: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 jsonschema==2.5.1 16:41:27 INFO - Using env: {'DISPLAY': ':0', 16:41:27 INFO - 'HOME': '/home/cltbld', 16:41:27 INFO - 'LANG': 'en_US.UTF-8', 16:41:27 INFO - 'LANGUAGE': 'en_US:en', 16:41:27 INFO - 'LOGNAME': 'cltbld', 16:41:27 INFO - 'MAIL': '/var/mail/cltbld', 16:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:27 INFO - 'MOZ_NO_REMOTE': '1', 16:41:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:27 INFO - 'NO_EM_RESTART': '1', 16:41:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:27 INFO - 'PWD': '/builds/slave/test', 16:41:27 INFO - 'SHELL': '/bin/bash', 16:41:27 INFO - 'SHLVL': '1', 16:41:27 INFO - 'TERM': 'linux', 16:41:27 INFO - 'TMOUT': '86400', 16:41:27 INFO - 'USER': 'cltbld', 16:41:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 16:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:27 INFO - '_': '/tools/buildbot/bin/python'} 16:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:28 INFO - Downloading/unpacking jsonschema==2.5.1 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:41:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41:30 INFO - Downloading functools32-3.2.3-2.tar.gz 16:41:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:41:30 INFO - warning: no files found matching '*.txt' 16:41:30 INFO - no previously-included directories found matching 'build' 16:41:30 INFO - no previously-included directories found matching 'dist' 16:41:30 INFO - no previously-included directories found matching '.git*' 16:41:30 INFO - Installing collected packages: jsonschema, functools32 16:41:30 INFO - Running setup.py install for functools32 16:41:30 INFO - warning: no files found matching '*.txt' 16:41:30 INFO - no previously-included directories found matching 'build' 16:41:30 INFO - no previously-included directories found matching 'dist' 16:41:30 INFO - no previously-included directories found matching '.git*' 16:41:30 INFO - Successfully installed jsonschema functools32 16:41:30 INFO - Cleaning up... 16:41:30 INFO - Return code: 0 16:41:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a4d00>, '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 0x20a5a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a5eb0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:41:30 INFO - Using env: {'DISPLAY': ':0', 16:41:30 INFO - 'HOME': '/home/cltbld', 16:41:30 INFO - 'LANG': 'en_US.UTF-8', 16:41:30 INFO - 'LANGUAGE': 'en_US:en', 16:41:30 INFO - 'LOGNAME': 'cltbld', 16:41:30 INFO - 'MAIL': '/var/mail/cltbld', 16:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:30 INFO - 'MOZ_NO_REMOTE': '1', 16:41:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:30 INFO - 'NO_EM_RESTART': '1', 16:41:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:30 INFO - 'PWD': '/builds/slave/test', 16:41:30 INFO - 'SHELL': '/bin/bash', 16:41:30 INFO - 'SHLVL': '1', 16:41:30 INFO - 'TERM': 'linux', 16:41:30 INFO - 'TMOUT': '86400', 16:41:30 INFO - 'USER': 'cltbld', 16:41:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 16:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:30 INFO - '_': '/tools/buildbot/bin/python'} 16:41:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:41:30 INFO - Cleaning up... 16:41:30 INFO - Return code: 0 16:41:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a4d00>, '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 0x20a5a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a5eb0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:41:30 INFO - Using env: {'DISPLAY': ':0', 16:41:30 INFO - 'HOME': '/home/cltbld', 16:41:30 INFO - 'LANG': 'en_US.UTF-8', 16:41:30 INFO - 'LANGUAGE': 'en_US:en', 16:41:30 INFO - 'LOGNAME': 'cltbld', 16:41:30 INFO - 'MAIL': '/var/mail/cltbld', 16:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:30 INFO - 'MOZ_NO_REMOTE': '1', 16:41:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:30 INFO - 'NO_EM_RESTART': '1', 16:41:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:30 INFO - 'PWD': '/builds/slave/test', 16:41:30 INFO - 'SHELL': '/bin/bash', 16:41:30 INFO - 'SHLVL': '1', 16:41:30 INFO - 'TERM': 'linux', 16:41:30 INFO - 'TMOUT': '86400', 16:41:30 INFO - 'USER': 'cltbld', 16:41:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 16:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:30 INFO - '_': '/tools/buildbot/bin/python'} 16:41:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:30 INFO - Downloading/unpacking blobuploader==1.2.4 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41:32 INFO - Downloading blobuploader-1.2.4.tar.gz 16:41:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:41:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:41:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:41:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:41:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:41:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:41:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:41:33 INFO - Downloading docopt-0.6.1.tar.gz 16:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:41:33 INFO - Installing collected packages: blobuploader, requests, docopt 16:41:33 INFO - Running setup.py install for blobuploader 16:41:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:41:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:41:33 INFO - Running setup.py install for requests 16:41:34 INFO - Running setup.py install for docopt 16:41:34 INFO - Successfully installed blobuploader requests docopt 16:41:34 INFO - Cleaning up... 16:41:34 INFO - Return code: 0 16:41:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:41: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')]} 16:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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')]} 16:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:34 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 0x1d351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a4d00>, '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 0x20a5a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a5eb0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:41:34 INFO - Using env: {'DISPLAY': ':0', 16:41:34 INFO - 'HOME': '/home/cltbld', 16:41:34 INFO - 'LANG': 'en_US.UTF-8', 16:41:34 INFO - 'LANGUAGE': 'en_US:en', 16:41:34 INFO - 'LOGNAME': 'cltbld', 16:41:34 INFO - 'MAIL': '/var/mail/cltbld', 16:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:34 INFO - 'MOZ_NO_REMOTE': '1', 16:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:34 INFO - 'NO_EM_RESTART': '1', 16:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:34 INFO - 'PWD': '/builds/slave/test', 16:41:34 INFO - 'SHELL': '/bin/bash', 16:41:34 INFO - 'SHLVL': '1', 16:41:34 INFO - 'TERM': 'linux', 16:41:34 INFO - 'TMOUT': '86400', 16:41:34 INFO - 'USER': 'cltbld', 16:41:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 16:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:34 INFO - '_': '/tools/buildbot/bin/python'} 16:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:41:34 INFO - Running setup.py (path:/tmp/pip-NiKzK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:41:34 INFO - Running setup.py (path:/tmp/pip-EaKVph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:41:34 INFO - Running setup.py (path:/tmp/pip-5d5Ocp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:41:34 INFO - Running setup.py (path:/tmp/pip-FH2_Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:41:34 INFO - Running setup.py (path:/tmp/pip-I0B8Pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:41:34 INFO - Running setup.py (path:/tmp/pip-O4a6G4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:41:35 INFO - Running setup.py (path:/tmp/pip-wwHqS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:41:35 INFO - Running setup.py (path:/tmp/pip-7pr05Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:41:35 INFO - Running setup.py (path:/tmp/pip-_gSWXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:41:35 INFO - Running setup.py (path:/tmp/pip-aFmrhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:41:35 INFO - Running setup.py (path:/tmp/pip-His1gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:41:35 INFO - Running setup.py (path:/tmp/pip-PTRS29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:41:35 INFO - Running setup.py (path:/tmp/pip-ewm0jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:41:35 INFO - Running setup.py (path:/tmp/pip-RGtdeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:41:35 INFO - Running setup.py (path:/tmp/pip-aF0sf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:41:35 INFO - Running setup.py (path:/tmp/pip-UfzUUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:41:35 INFO - Running setup.py (path:/tmp/pip-rYA1It-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:41:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:41:35 INFO - Running setup.py install for manifestparser 16:41:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:41:35 INFO - Running setup.py install for mozcrash 16:41:36 INFO - Running setup.py install for mozdebug 16:41:36 INFO - Running setup.py install for mozdevice 16:41:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:41:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:41:36 INFO - Running setup.py install for mozfile 16:41:36 INFO - Running setup.py install for mozhttpd 16:41:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:41:36 INFO - Running setup.py install for mozinfo 16:41:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:41:36 INFO - Running setup.py install for mozInstall 16:41:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:41:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:41:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:41:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:41:36 INFO - Running setup.py install for mozleak 16:41:36 INFO - Running setup.py install for mozlog 16:41:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:41:36 INFO - Running setup.py install for moznetwork 16:41:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:41:36 INFO - Running setup.py install for mozprocess 16:41:37 INFO - Running setup.py install for mozprofile 16:41:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:41:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:41:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:41:37 INFO - Running setup.py install for mozrunner 16:41:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:41:37 INFO - Running setup.py install for mozscreenshot 16:41:37 INFO - Running setup.py install for moztest 16:41:37 INFO - Running setup.py install for mozversion 16:41:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:41:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:41:37 INFO - Cleaning up... 16:41:37 INFO - Return code: 0 16:41:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:37 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 0x1d351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a4d00>, '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 0x20a5a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a5eb0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:41:37 INFO - Using env: {'DISPLAY': ':0', 16:41:37 INFO - 'HOME': '/home/cltbld', 16:41:37 INFO - 'LANG': 'en_US.UTF-8', 16:41:37 INFO - 'LANGUAGE': 'en_US:en', 16:41:37 INFO - 'LOGNAME': 'cltbld', 16:41:37 INFO - 'MAIL': '/var/mail/cltbld', 16:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:37 INFO - 'MOZ_NO_REMOTE': '1', 16:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:37 INFO - 'NO_EM_RESTART': '1', 16:41:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:37 INFO - 'PWD': '/builds/slave/test', 16:41:37 INFO - 'SHELL': '/bin/bash', 16:41:37 INFO - 'SHLVL': '1', 16:41:37 INFO - 'TERM': 'linux', 16:41:37 INFO - 'TMOUT': '86400', 16:41:37 INFO - 'USER': 'cltbld', 16:41:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 16:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:37 INFO - '_': '/tools/buildbot/bin/python'} 16:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:41:37 INFO - Running setup.py (path:/tmp/pip-RXbc2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:41:37 INFO - Running setup.py (path:/tmp/pip-nje_cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:41:38 INFO - Running setup.py (path:/tmp/pip-xayOGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:41:38 INFO - Running setup.py (path:/tmp/pip-Y_D6i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:41:38 INFO - Running setup.py (path:/tmp/pip-FcZpAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:41:38 INFO - Running setup.py (path:/tmp/pip-NkIzOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:41:38 INFO - Running setup.py (path:/tmp/pip-YPgN16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:41:38 INFO - Running setup.py (path:/tmp/pip-_ZMw0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:41:38 INFO - Running setup.py (path:/tmp/pip-DJY2M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:41:38 INFO - Running setup.py (path:/tmp/pip-7fn6wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:41:38 INFO - Running setup.py (path:/tmp/pip-Ixorkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:41:38 INFO - Running setup.py (path:/tmp/pip-T4FKXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:41:38 INFO - Running setup.py (path:/tmp/pip-XruT5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:41:38 INFO - Running setup.py (path:/tmp/pip-tTDleZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:41:38 INFO - Running setup.py (path:/tmp/pip-y5SRG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:41:38 INFO - Running setup.py (path:/tmp/pip-MefFMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:41:39 INFO - Running setup.py (path:/tmp/pip-EpPclN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:41:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:41:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:41:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:41:41 INFO - Downloading blessings-1.6.tar.gz 16:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:41:41 INFO - Installing collected packages: blessings 16:41:41 INFO - Running setup.py install for blessings 16:41:41 INFO - Successfully installed blessings 16:41:41 INFO - Cleaning up... 16:41:41 INFO - Return code: 0 16:41:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:41:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:41:41 INFO - Reading from file tmpfile_stdout 16:41:41 INFO - Current package versions: 16:41:41 INFO - argparse == 1.2.1 16:41:41 INFO - blessings == 1.6 16:41:41 INFO - blobuploader == 1.2.4 16:41:41 INFO - docopt == 0.6.1 16:41:41 INFO - functools32 == 3.2.3-2 16:41:41 INFO - jsonschema == 2.5.1 16:41:41 INFO - manifestparser == 1.1 16:41:41 INFO - mozInstall == 1.12 16:41:41 INFO - mozcrash == 1.0 16:41:41 INFO - mozdebug == 0.1 16:41:41 INFO - mozdevice == 0.49 16:41:41 INFO - mozfile == 1.2 16:41:41 INFO - mozhttpd == 0.7 16:41:41 INFO - mozinfo == 0.9 16:41:41 INFO - mozleak == 0.1 16:41:41 INFO - mozlog == 3.4 16:41:41 INFO - moznetwork == 0.27 16:41:41 INFO - mozprocess == 0.24 16:41:41 INFO - mozprofile == 0.28 16:41:41 INFO - mozrunner == 6.13 16:41:41 INFO - mozscreenshot == 0.1 16:41:41 INFO - mozsystemmonitor == 0.3 16:41:41 INFO - moztest == 0.8 16:41:41 INFO - mozversion == 1.4 16:41:41 INFO - psutil == 3.1.1 16:41:41 INFO - requests == 1.2.3 16:41:41 INFO - wsgiref == 0.1.2 16:41:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:41 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 0x1d351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a4d00>, '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 0x20a5a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a5eb0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:41:41 INFO - Using env: {'DISPLAY': ':0', 16:41:41 INFO - 'HOME': '/home/cltbld', 16:41:41 INFO - 'LANG': 'en_US.UTF-8', 16:41:41 INFO - 'LANGUAGE': 'en_US:en', 16:41:41 INFO - 'LOGNAME': 'cltbld', 16:41:41 INFO - 'MAIL': '/var/mail/cltbld', 16:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:41 INFO - 'MOZ_NO_REMOTE': '1', 16:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:41 INFO - 'NO_EM_RESTART': '1', 16:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:41 INFO - 'PWD': '/builds/slave/test', 16:41:41 INFO - 'SHELL': '/bin/bash', 16:41:41 INFO - 'SHLVL': '1', 16:41:41 INFO - 'TERM': 'linux', 16:41:41 INFO - 'TMOUT': '86400', 16:41:41 INFO - 'USER': 'cltbld', 16:41:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 16:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:41 INFO - '_': '/tools/buildbot/bin/python'} 16:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:41:41 INFO - Cleaning up... 16:41:41 INFO - Return code: 0 16:41:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:41 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 0x1d351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a4d00>, '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 0x20a5a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a5eb0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:41:41 INFO - Using env: {'DISPLAY': ':0', 16:41:41 INFO - 'HOME': '/home/cltbld', 16:41:41 INFO - 'LANG': 'en_US.UTF-8', 16:41:41 INFO - 'LANGUAGE': 'en_US:en', 16:41:41 INFO - 'LOGNAME': 'cltbld', 16:41:41 INFO - 'MAIL': '/var/mail/cltbld', 16:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:41 INFO - 'MOZ_NO_REMOTE': '1', 16:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:41 INFO - 'NO_EM_RESTART': '1', 16:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:41 INFO - 'PWD': '/builds/slave/test', 16:41:41 INFO - 'SHELL': '/bin/bash', 16:41:41 INFO - 'SHLVL': '1', 16:41:41 INFO - 'TERM': 'linux', 16:41:41 INFO - 'TMOUT': '86400', 16:41:41 INFO - 'USER': 'cltbld', 16:41:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 16:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:41 INFO - '_': '/tools/buildbot/bin/python'} 16:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:41:42 INFO - Cleaning up... 16:41:42 INFO - Return code: 0 16:41:42 INFO - Running post-action listener: _resource_record_post_action 16:41:42 INFO - Running post-action listener: _start_resource_monitoring 16:41:42 INFO - Starting resource monitoring. 16:41:42 INFO - [mozharness: 2017-02-05 00:41:42.122376Z] Finished create-virtualenv step (success) 16:41:42 INFO - [mozharness: 2017-02-05 00:41:42.122832Z] Running install step. 16:41:42 INFO - Running pre-action listener: _resource_record_pre_action 16:41:42 INFO - Running main action method: install 16:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:41:42 INFO - Reading from file tmpfile_stdout 16:41:42 INFO - Detecting whether we're running mozinstall >=1.0... 16:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:41:42 INFO - Reading from file tmpfile_stdout 16:41:42 INFO - Output received: 16:41:42 INFO - Usage: mozinstall [options] installer 16:41:42 INFO - Options: 16:41:42 INFO - -h, --help show this help message and exit 16:41:42 INFO - -d DEST, --destination=DEST 16:41:42 INFO - Directory to install application into. [default: 16:41:42 INFO - "/builds/slave/test"] 16:41:42 INFO - --app=APP Application being installed. [default: firefox] 16:41:42 INFO - mkdir: /builds/slave/test/build/application 16:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:42:01 INFO - Reading from file tmpfile_stdout 16:42:01 INFO - Output received: 16:42:01 INFO - /builds/slave/test/build/application/firefox/firefox 16:42:01 INFO - Running post-action listener: _resource_record_post_action 16:42:01 INFO - [mozharness: 2017-02-05 00:42:01.017830Z] Finished install step (success) 16:42:01 INFO - [mozharness: 2017-02-05 00:42:01.017985Z] Running run-tests step. 16:42:01 INFO - Running pre-action listener: _resource_record_pre_action 16:42:01 INFO - Running main action method: run_tests 16:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:42:01 INFO - Python 2.7.3 16:42:01 INFO - Return code: 0 16:42:01 INFO - grabbing minidump binary from tooltool 16:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:01 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 0x20a4d00>, '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 0x20a5a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a5eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:42:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:42:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:42:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:42:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:42:01 INFO - Return code: 0 16:42:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:42:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:42:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:42:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:42:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:42:01 INFO - Using env: {'DISPLAY': ':0', 16:42:01 INFO - 'HOME': '/home/cltbld', 16:42:01 INFO - 'LANG': 'en_US.UTF-8', 16:42:01 INFO - 'LANGUAGE': 'en_US:en', 16:42:01 INFO - 'LOGNAME': 'cltbld', 16:42:01 INFO - 'MAIL': '/var/mail/cltbld', 16:42:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:42:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:01 INFO - 'MOZ_NO_REMOTE': '1', 16:42:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:01 INFO - 'NO_EM_RESTART': '1', 16:42:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:01 INFO - 'PWD': '/builds/slave/test', 16:42:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:42:01 INFO - 'SHELL': '/bin/bash', 16:42:01 INFO - 'SHLVL': '1', 16:42:01 INFO - 'TERM': 'linux', 16:42:01 INFO - 'TMOUT': '86400', 16:42:01 INFO - 'USER': 'cltbld', 16:42:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225', 16:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:01 INFO - '_': '/tools/buildbot/bin/python'} 16:42:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:42:01 INFO - mozversion application_buildid: 20170204233700 16:42:01 INFO - mozversion application_changeset: 45d7372ceb6695e42915f11a4d30fce43cb59841 16:42:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:42:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:42:01 INFO - mozversion application_name: Firefox 16:42:01 INFO - mozversion application_remotingname: firefox-dev 16:42:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:42:01 INFO - mozversion application_vendor: Mozilla 16:42:01 INFO - mozversion application_version: 53.0a2 16:42:01 INFO - mozversion platform_buildid: 20170204233700 16:42:01 INFO - mozversion platform_changeset: 45d7372ceb6695e42915f11a4d30fce43cb59841 16:42:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:42:01 INFO - mozversion platform_version: 53.0a2 16:42:01 INFO - using testdate: 1486255321 16:42:01 INFO - actual date: 1486255321 16:42:01 INFO - starting webserver on 'localhost:44248' 16:42:01 INFO - SUITE-START | Running 2 tests 16:42:01 INFO - TEST-START | dromaeo_css 16:42:01 INFO - operating with platform_type : linux_ 16:42:01 INFO - Initialising browser for dromaeo_css test... 16:42:01 INFO - TEST-INFO | started process 7664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKvFP3u/profile http://localhost:44248/getInfo.html) 16:42:05 INFO - PROCESS | 7664 | __metrics Screen width/height:1600/1200 16:42:05 INFO - PROCESS | 7664 | colorDepth:24 16:42:05 INFO - PROCESS | 7664 | Browser inner width/height: 1024/697 16:42:05 INFO - PROCESS | 7664 | __metrics 16:42:06 INFO - PROCESS | 7664 | 1486255326132 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 16:42:06 INFO - PROCESS | 7664 | 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:42:06 INFO - PROCESS | 7664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:42:06 INFO - PROCESS | 7664 | console.error: PushService: 16:42:06 INFO - PROCESS | 7664 | stateChangeProcessEnqueue: Error transitioning state 16:42:06 INFO - PROCESS | 7664 | UnknownError 16:42:07 INFO - TEST-INFO | 7664: exit 0 16:42:07 INFO - Browser initialized. 16:42:07 INFO - Running cycle 1/1 for dromaeo_css test... 16:42:07 INFO - TEST-INFO | started process 7758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKvFP3u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:19 INFO - PROCESS | 7758 | RSS: Main: 138399744 16:42:19 INFO - PROCESS | 7758 | 16:45:19 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44248/tests/dromaeo/cssquery-ext.html) 16:45:20 INFO - PROCESS | 7758 | RSS: Main: 243564544 16:45:20 INFO - PROCESS | 7758 | 16:47:08 INFO - PROCESS | 7758 | ************************* 16:47:08 INFO - PROCESS | 7758 | A coding exception was thrown and uncaught in a Task. 16:47:08 INFO - PROCESS | 7758 | 16:47:08 ERROR - PROCESS | 7758 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:47:08 INFO - PROCESS | 7758 | Full stack: 16:47:08 INFO - PROCESS | 7758 | ************************* 16:48:22 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44248/tests/dromaeo/cssquery-ext.html (next: http://localhost:44248/tests/dromaeo/cssquery-jquery.html) 16:48:23 INFO - PROCESS | 7758 | RSS: Main: 225968128 16:48:23 INFO - PROCESS | 7758 | 16:51:24 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44248/tests/dromaeo/cssquery-mootools.html) 16:51:25 INFO - PROCESS | 7758 | RSS: Main: 176193536 16:51:25 INFO - PROCESS | 7758 | 16:54:27 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44248/tests/dromaeo/cssquery-prototype.html) 16:54:27 INFO - PROCESS | 7758 | RSS: Main: 228294656 16:54:27 INFO - PROCESS | 7758 | 16:57:30 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44248/tests/dromaeo/cssquery-yui.html) 16:57:31 INFO - PROCESS | 7758 | RSS: Main: 173481984 16:57:31 INFO - PROCESS | 7758 | 17:00:33 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44248/tests/dromaeo/cssquery-yui.html (next: http://localhost:44248/tests/dromaeo/cssquery-dojo.html) 17:00:33 INFO - PROCESS | 7758 | RSS: Main: 264642560 17:00:33 INFO - PROCESS | 7758 | 17:00:33 INFO - PROCESS | 7758 | __start_tp_report 17:00:33 INFO - PROCESS | 7758 | _x_x_mozilla_page_load 17:00:33 INFO - PROCESS | 7758 | _x_x_mozilla_page_load_details 17:00:33 INFO - PROCESS | 7758 | |i|pagename|runs| 17:00:33 INFO - PROCESS | 7758 | |0;dojo.html;3240.2385439421732;3263.3962716897377;3298.4062868683627;3303.4714445688696;3309.851056702449;5424.376196737377;5486.259354987081;5545.140503222007;5549.5837812164045;5552.222688823558;5504.834854954348;5522.585806064541;5523.861903452405;5530.2810634617545;5535.944640553594;4996.650234483587;5010.6993580385115;5043.39479262489;5051;5113.181890897457;4927.162382394984;4955.950440495603;5036.370453693288;5088.92366614501;5093.465186155438;4908.803647854082;4922.310876477296;4970;5036.546710796028;5058.544730974211;5068.898622027576;5079.288899554065;5085.364329458817;5087.6184286178495;5104.795808167669;4862.7325497097645;4978;5005.1491246488185;5037.471065538139;5060.291559181717;5364.651297665679;5388.191771234307;5441.156620723755;5444.50999410055;5498.80754173606;5869.4717475427415;5921.585489015771;5929.911051334234;5930.318013428425;5940.257467816523;5933.3473317934995;5949.077892926603;5974.103884417329;5978.073398623221;5992.221011268551;5426.8914621707345;5459.972700136514;5512.228288039678;5520.420355862657;5547.8890422191735;6041.093835924647;6041.969790151021;6054.606450580698;6058.909116363258;6083.270007599028;5784.2769653793275;5806.65160090396;5823.155642431823;5830.737616807254;5839.620424672383;5702.116171993348;5726.627769194989;5732.541396688255;5768.250127483484;5889.941100589025;5693.516051135617;5748.770049198069;5752.309722833287;5772.3938986406665;5783.65298082108;5776.393478684761;5783.450572195718;5796.101604251347;5796.391378905154;5797.47822695951;4458.9331160032625;4502.639788816887;4523.88690282739;4534.659900507475;4581.152486789954;3996.7402118862183;4016.3172260715164;4048.858289959896;4068.9186216275507;4070.531888832763;5551.8889622207325;5552.944470555323;5553.694546799965;5553.722313884289;5622.100463925753;5676.716164191774;5706.115552089433;5782.508486778587;5834.591578589458;5840.766369345263;5665.943340566541;5666.716664166775;5669.971650141723;5695.515881150149;5707.315122185281;5010.774515146827;5021.322121513549;5025.723585202849;5033.47148549397;5058.747062646853;5984.820455386345;6038.728257228435;6068.332483426908;6157.322694503601;6164.106204600308;5865.618734782225;5932.16949627044;5939.940600594112;5965.552583556338;5972.074328479092;6181.660008699385;6186.319504854552;6188.938110618837;6197.628142311476;6202.100695399232;5578.051731205786;5626.071698169756;5706.4864162225595;5760.395158508296;5771.97114014444;5799.217105690678;5822.417758224144;5828.854278643068;5840.182374467663;5895.7052147391605;5695.430456954271;5710.885782284248;5718.342390625131;5720.056190728483;5725.914111288417;5600.327960644749;5735.4551317624755;5742.913856292243;5743;5743.885122297447;5576.163575463713;5607.663540187602;5639.407862174577;5642.746076426489;5733.39799321082;5718.828435146952;5725.141228815711;5731.684757338387;5735.426457354231;5740.512056475246;5560.138178582326;5595.860103497445;5601.6358936668985;5604.467575580314;5609.467100625434 17:00:33 INFO - PROCESS | 7758 | |1;ext.html;556.4099118602902;585.1077107411197;621.4655396359132;636.7771280051979;645.6158585641541;37201;49911.50088499114;51895.74052129734;52017.219741703906;56476.43523564763;53564.196537051976;54051.72974135134;54125.72937135309;54137.1879421808;54138.72930635351;8686.174813392749;8886.688965886164;9544.475053872035;9744.269179811507;9754.46350450725;11290.830637540403;11637.127215458831;11643.35961522116;12033.458494367775;12046.518139274462;11774.941125294405;11854.229475084136;11855.170138090338;11867;11868.821967670492;11770.705732356717;11801.232919860182;11827.586034488837;11828.349440780754;11838.112141589416;11535.59625413115;11610.767784644344;11613.709657258636;11614.883851161465;11616.651500455;49703;49950;50328;50368.49631503711;50385.748071259775;4474.977625111854;4576.084783043371;4633.4439867215815;4704;4722.386089808338;36163.81918090419;36413.27173456516;36884.81557592195;37131.25737485235;37949.81025094857;4640.86077417678;4669;4682.929756053662;4702.1771190041945;4735.431748190204;357366;358617;360246;360417.5937360942;361543;72883.63558182176;73239;73266.26733732595;73280.26719732842;73327;74962;75078;75147.62426187834;75370.62314688391;75557.24442755502;18237.63524729498;18655.253789848255;18717.906410467862;18727.90636046811;18736.53158671044;12776.233425994471;13073.803892941614;13426.664333391744;13867.306634668226;13931.791023134661;20692.172313107607;21590.244341447975;21672.458188545097;21706.891465542885;21799.564008719735;6811.352921472452;6954.165500139914;6955.652217389212;7061.823454413578;7156.499045066796;994.7463396833762;1019.887812340642;1021.2442792333619;1024.6567399920962;1033.0960409641564;34618.82690586581;34799.4780078299;35378.11554711153;35547.4667879982;35905.46141807875;1163.906887449002;1169.2750494693344;1185.9051275897907;1212.0788200967152;1213.9332336721388;18338.358157464423;18356.35752748674;18481.353152639593;18532.536686582942;18752.53118672044;551531;561657;562493;565057;565758;51851.48148518542;51921.221181682304;51985.48014519807;52013;52022;1571.5128310223868;1590.6977674241857;1594.5057032320017;1626.2356692354574;1628.5847108987132;33485;34797.82601086979;34921.301573968885;35294.82352588221;35321;61612.69193654003;62553;62779;62793;62834.685826570574;382129;383147;385096;385352;388701;40054;45018.77490612526;47132.7643361781;47645.28532071952;49746.502534974185;51968.480315196364;52413.21380179377;52875;52926.206106909194;52973.470265296855;44825.77587112044;45389.31916021329;45410.77294613506;45980.7700961493;47183;43600.78199608982;43967.78016109899;45238.547614523435;45337.319940200265;46505;43703.562964371224;43825;44968.32547511855;44973.32540011968;45070;35514.82242588874;36521.634783651825;36618.633813662585;36981.260374792895;39757.80121099376;27698;27723.722762772115;27915;27981.580276296278;28524.57213141846 17:00:33 INFO - PROCESS | 7758 | |2;jquery.html;398.2453251089188;413.4604341334557;427.8908878236048;428.9528151903291;432.0667358505627;20440.08019639116;21289.680654790172;22399.55200895981;22567.774322256773;22652.77347226527;21644.675329870064;21853.890730546365;21860.562788744217;21998.120075197014;22009.33971980839;5980.880382392361;6198.659073750942;6204.875902481947;6205.22434695663;6206.565540412173;5786.103154011114;6014.8496287592725;6027.126066720323;6034.275886893557;6187.412195841411;6205.286392064902;6218.8445288867915;6224.968875155618;6226.097215903691;6234.937650623504;6853.657317134148;6899.517033807636;6929.72281108755;6960.617166055865;6974.232834388264;5930.466258036754;5956.702164891782;5990.371011043865;6009.09863520471;6223.968880155616;13891.583252502442;14102;14558.199299038548;14713.264336783224;14781.778273325908;2721.319670082479;2847.174319447358;2848.8148270362362;2850.700676428966;2861.1416575027615;10556.947215263952;10569.577216911315;10595.788084238273;10690;11000.504977275961;2017.5662232619911;2062.2163577840474;2067.069818581629;2092.476880779805;2121.331780489141;84061.57969210176;94072;95958;98450.99999999929;100120;11934.462949167135;12376.133670643148;12382.876171238353;12545.749085018431;12569.371531423392;17963.820361796214;17977.370792022215;18006.639867202844;18008.819911800714;18021.18904649294;8795.956020219857;8859.291256699578;8967.058458861857;9002.549872506479;9086.273098152133;8311.298827880963;8352.415330926777;8354.498730076215;8548.572571371407;8554.144585541397;5240.502152295526;5261.184516399888;5291.947080529222;5347.572194224453;5454.972725136428;2143.1106090972385;2173.978260217409;2199.7800219977876;2212.723409573803;2248.797608215236;933.5518950903604;944.2729098594044;949.349695458613;956.1920177450044;960.8943016268205;17484.737728934077;18897.527561811065;20184.59630807405;20365.185392584426;20653.690194647093;965.0783501755807;965.0879918477112;968.4576637083115;974.5906719177963;987.4322264697684;10782.78434431307;11266.380349080879;11313.773724525463;11387.772244555063;11438.370889601152;661090;668390;679028;687098;692079;80708;106193;107626.46186769016;108559.45720271506;110170.44914775375;1057.6615483045352;1059.147386353977;1096.736783172049;1097.1716354152722;1103.5806393570392;17316.82683173152;17726.91136544309;17800.198991045694;17816.821831781515;18165;46207.84480387883;46339.536604633526;46454.89375833288;47451.525484744714;48706.26940595823;63457.682711586145;64249.67875160594;64359;64909.67545162244;64974.35025649683;6205.503559715302;8978.10218978097;9194.54027298619;9330.580123894306;9379.906200937903;11330.263532870336;14077.155370677792;14356.282185890872;14472;14704.264786760405;10230.948845255725;11888.881111189123;12140.089493287862;12294.262344259372;12460.626181214579;11546.19176657626;11600.593979210687;11825.645230643095;11861.466234019663;12054.457549410474;11798.056155507711;11992.820107698217;12071.215371000857;12076.637700868989;12110.51557937708;8939.329550283624;8968.461892286483;8981.730548083568;9054.637814487347;9160;9253.53732313395;11697.181197316106;12111.939440302742;12154.574589889311;12164.2701437914 17:00:33 INFO - PROCESS | 7758 | |3;mootools.html;1391.9930400347996;1490.888183386246;1512.2212060788695;1516.7497362935123;1521.1861654015097;7409;8265.173482651739;8534.573271336432;8552.059273479912;8768.079351668079;8596.785080372994;8650.35122365822;8652.653893844254;8683.044865064838;8688.044315125348;2121.1939463004037;2190.1786829938774;2409.8674572898485;2461.2739241923587;2464.4824586836785;2397.160993652225;2473.4558397152596;2480.59070253408;2489.029278581355;2507.059852555292;2395.4131237846664;2416.915407960722;2424.2969538833718;2424.5150969806023;2433.9391515212083;2430.7812296893276;2440.46309811842;2457.778799907999;2460.4463995600936;2469.2715648883623;2399.28021593523;2459.18846780562;2467.1734968785477;2469.76537228963;2469.802415806731;8567;8611.48331100136;8611.827763444759;8632.482051076955;8637.568121593895;5067.265246539268;5266.894662106736;5275.340582427197;5278.1291086970605;5278.947210527884;3321.983390083058;3362.6717446608454;3410.437277849152;3465.5668041494814;3484.738644601665;1248.2385744695728;1284.1203775413871;1314.2377421095837;1315.3357554435045;1333.7065845514069;11558.653240402802;11626.244294120856;11658.242214256046;11664.766704665944;11679.708007299885;4324.762138082373;4610.976945115253;4688.554587314268;4693.929591056137;4730.101280756645;10012.349197302152;10032.69901902944;10033.147182489423;10068.194544436428;10078.445685487368;5389.056915039931;5404.162354835007;5404.270423492857;5417;5417.214503896913;4335.783210839509;4704.1062198182235;4881.316615673809;4906.116898958222;4958.776855041532;4133.458619161914;4150.709450338508;4218.8523401681405;4259.97870010648;4260.339647354665;1285.5050805439787;1303.6219496346143;1307.6796184934562;1308.770965081126;1316.1773891317926;989.3272574649163;1081.9296745711504;1083.1226706367868;1084.5336505302796;1092.2900114925203;5930.733117009745;5955.76176952917;6091.592292189886;6091.878162436727;6227.719752611053;629.8929182039064;634.8825467288566;1047.8061558611682;1063.0910571461443;1081.167501024207;4135.545090040093;4237.957620423818;4255.765932873722;4269.4449721536;4321.65426765858;10154.593816247416;10480;10493.108085812639;10494.475276236157;10513.421761803174;10259;10351.948240258751;10359.533820977924;10370.22223333253;10397.220208484243;7800.882986755203;7979.561124138112;8096.473729207582;8109.918900811034;8128.674853005814;5637.379888212211;5710.17202505626;5835;5842.737076831638;5931.881362372815;9501.334906556474;9504.714858554255;9532.428054316486;9598.472084035446;9608.567614457506;9389.718308450758;9586.281028922998;9631.229501639711;9712.75718107053;9725.6596019139;6839.760608378683;6843.349881761224;6962.338577835098;7031.472639552157;7035.437165026888;7739.729109481141;7802.765917022499;7809.258120478546;7812.218778122142;7816.687332506636;6713.56361836479;6848.212455567674;6880.862382752417;6913.585184888922;7007.229204787367;6873.621950792754;6894.207166175954;6908.516403851682;7039.54242974205;7096.432285417051;6428.485721142204;6513.674316284072;6515.413612774873;6517.869642607026;6519.706613202512;4916.827911023097;4996.925046124238;5047.318611987482;5054.494550544916;5091.338126043591;4663.655717156438;4812.927806082842;4856.198727210112;4975.328330675313;4979.3277907482025 17:00:33 INFO - PROCESS | 7758 | |4;prototype.html;377.66576579726933;387.3627882133888;399.936169788363;400.7194963525532;404.8239016028028;5400.1629747389115;5422.620416570841;5428.565714742821;5430.321209848769;5497.175423686444;5367.490088441602;5377.973110134453;5381.354237491497;5383;5403.972980135094;4203.264428724976;4317.244482215616;4322.675799315049;4324.848630297948;4355.412019377391;4346.130773845228;4346.956530434687;4351.4343135392355;4359.673024523157;4363.563643635627;4310.439642846425;4312.741235525878;4341.480481831365;4344.45694288214;4364.10535840152;4028.2144981728575;4183.3515805050265;4244.129953359554;4343.326784348431;4360.23695853226;3721.423179407196;3734.25314937011;3739.8878033659034;3745.550533935918;3750.5124333836425;5229.843104706865;5246.527812496894;5251.343582052244;5271.525562699376;5302.6023048271145;4605.4933957264675;4809.763459991086;4849.515048495157;4858;4862.902741945177;5626.046325679051;5627.577931655102;5633.8591535211945;5638.323401191842;5642.420122365744;4104.004077023789;4104.610062044131;4107.938380924288;4115.34154535273;4122.237386083584;5242.397124330712;5510.862228444281;5693.772249110072;5860.238169038041;5873.882522349571;4155.833766649361;4157.272477316457;4157.896052598649;4162.937555936603;4166.687498437569;4211.642010429086;4213.894652633648;4226.520717748764;4227.302495088337;4241.703080784378;4572.177008138567;4686;4808.63935204861;4836.371271734652;4842.3125165532765;5432.261676263558;5606.411326810708;5630.690312032878;5645.628835888937;5678.829635110953;1407.1697698358018;1413.8162038934872;1417.149710173908;1418.8793952513945;1422.8150340455675;952.8189643967625;979.0845559401982;980.6028558433845;980.8185485685171;998.9660701174249;5293.735313234323;5321.414644389114;5348.197770334403;5421.566274698014;5422.511973922287;5525.696086715189;5543.334799824047;5598.216249725042;5617.943820561742;5659.207710920475;5110.28456016158;5304.310439642822;5359.196120581944;5389.299391079135;5413.9729301353245;2918.2266699324696;2927.956080658792;2942.367391010943;2982.388610334876;2983.970160298413;5745.253117094751;5770.509506691894;5782.161586569924;5793.797217097382;5799.9130013049835;5589.496945274945;5663.235463212413;5782.183758719225;5930;5930.495907847881;5868.501177399969;5998.940010599838;6010.849728756729;6016.669083200379;6019.247594050744;5705.486506214461;5750.338711048283;5772.480476757112;5774.595778295647;5776.942230577641;5529.617595601099;5651.406602306699;5685.630434021941;5695.487406133468;5696.174054762119;5957.553183511341;5982.905982905948;5990.7903223386975;6003.669798160969;6020.608660437058;4039.4546736190237;4144.254034273859;4184.393262976912;4190;4199.685023623179;5769.855428791235;5777.768889244383;5782.595218334676;5794.870000349892;5817.680027598522;5614.687334472681;5660.773569057356;5668.461496157858;5668.971655141698;5706.029974904193;5410.080286351408;5584.636998595079;5605.691686957093;5662.433756624305;5683.914741278967;5613.719314034363;5620.943790562205;5633.63381380209;5661.094224924157;5661.801836935688;5584.647456038106;5681.289838770153;5708.628939118944;5715.771369145187;5733.254676891977;5444.863878403072;5535.557155427637;5580.237782297789;5592.916106258491;5607.635503692247 17:00:33 INFO - PROCESS | 7758 | |5;yui.html;804.4891493901374;821;833.8248967716779;900.4507250577149;913.7487191022468;15282.159481228528;16195.190240487973;16201.351945922164;17645.117744112806;18232.27070917165;16598.75101873473;16756.58108547287;16776.916115419437;16783;16786.66426671466;697.4141720954398;716.1871276101637;800.6757263308369;820.9507429554246;822.313368337439;839.412411312081;841.8274253777961;841.970531031414;842.0653075086649;842.970496032639;878.9384743067988;883.3948745109589;883.6112110671316;885.1281487734608;885.1723638398087;734.5188901269677;757.4697711601873;851.6891334662804;875.916787905148;877.9604917778715;646.5732616473152;646.5764923974804;646.7639311651213;646.9256035555924;647.0843756085134;16039.759403608956;16349.591260218589;16427;16498.17509124551;17256.050917199547;15106.244687765678;16064.839351606452;16071.035737855766;16161.515154545383;16431.753523697153;13475.258860762655;13578;13593.116447430984;13760.518381856687;14114.294285285694;4570.474395444533;4699.271612900006;4766.475687674388;4787.952120478821;4802.447718512381;74519.62740186264;74617;74724.62637686831;76783;76794.61602691951;11938.553181282185;11992.580259690869;12013.459394327276;12106;12285.1400401971;23515.41211469727;23654.7634523656;23672.17147399833;23675.763242367357;23696.64455033176;8266.875996860052;8511.829763404698;8574.914250857537;8848.955755221183;8948.414378427331;5021.5229553192385;5078.898422031539;5120.948790512121;5130.51260130287;5179.533841954167;3643.5263415756312;3696.131409118855;3747.868824591126;3766.322062028806;3769.566499852497;613.6287546034584;617.3147805935408;620.3641267700643;623.8689875126183;624.0109426558864;782.8257613579631;785.140271402813;790.3321693169263;805.1545876829423;807.5477732469835;10494.947525262478;10781.892181078088;10918.781624367628;10943.890561094446;11172.832407513893;781.0666253826736;785.9135495095535;787.0869791042478;797.1669605262515;814.0841553252591;5355.024740313578;5357.946420535823;5370.838874833761;5430.375506816767;5458.344998600193;79270.60364698255;80090.59954700306;80885.76456941657;81035.59482202551;81573.18426815774;59149.70425147847;62801.68599156975;71927.64036179785;72556.27443725601;74728;62339.37660623426;63161;63570.36429635737;64176;65788.67105664441;10003.34978226413;10105.191584673355;10276.640317588848;10341.482925853828;10411.635592754217;43580.56419435892;44081.11837763291;44556.331655025846;44685.32972005488;45143.54856451525;55202.72398637981;55420.44579554153;56254.1561876564;56260.43739562552;57852.710736446046;14175.22036288014;14412.85587144157;14474;14723.779143312644;14732.852671473149;16076.839231608003;16246.268917898959;16545.25546350441;16571.585710357336;16817.831821681626;14396;14529.27353632293;14814.555563333117;15433.22833858325;15707.214639268219;15444.0733555987;15559.14424706652;15849.0189225621;16038.599035024217;16685;13966.511172108927;14003.50987715425;14057;14529.34617942174;14540;12146.635600931986;12706;13043.804342935053;13337.19976801395;13992.650183745487;11597.18819682614;11788.764224715285;11844.881551184379;11962.342071186169;11964.76070478603 17:00:33 INFO - PROCESS | 7758 | __end_tp_report 17:00:33 INFO - PROCESS | 7758 | __start_cc_report 17:00:33 INFO - PROCESS | 7758 | _x_x_mozilla_cycle_collect,964 17:00:33 INFO - PROCESS | 7758 | __end_cc_report 17:00:33 INFO - PROCESS | 7758 | __startTimestamp1486256433938__endTimestamp 17:00:33 INFO - PROCESS | 7758 | 17:00:33 INFO - PROCESS | 7758 | ------- Summary: start ------- 17:00:33 INFO - PROCESS | 7758 | Number of tests: 6 17:00:33 INFO - PROCESS | 7758 | 17:00:33 INFO - PROCESS | 7758 | [#0] dojo.html Cycles:165 Average:5459.07 Median:5665.94 stddev:600.63 (10.6%) stddev-sans-first:576.70 17:00:33 INFO - PROCESS | 7758 | Values: 3240.2 3263.4 3298.4 3303.5 3309.9 5424.4 5486.3 5545.1 5549.6 5552.2 5504.8 5522.6 5523.9 5530.3 5535.9 4996.7 5010.7 5043.4 5051.0 5113.2 4927.2 4956.0 5036.4 5088.9 5093.5 4908.8 4922.3 4970.0 5036.5 5058.5 5068.9 5079.3 5085.4 5087.6 5104.8 4862.7 4978.0 5005.1 5037.5 5060.3 5364.7 5388.2 5441.2 5444.5 5498.8 5869.5 5921.6 5929.9 5930.3 5940.3 5933.3 5949.1 5974.1 5978.1 5992.2 5426.9 5460.0 5512.2 5520.4 5547.9 6041.1 6042.0 6054.6 6058.9 6083.3 5784.3 5806.7 5823.2 5830.7 5839.6 5702.1 5726.6 5732.5 5768.3 5889.9 5693.5 5748.8 5752.3 5772.4 5783.7 5776.4 5783.5 5796.1 5796.4 5797.5 4458.9 4502.6 4523.9 4534.7 4581.2 3996.7 4016.3 4048.9 4068.9 4070.5 5551.9 5552.9 5553.7 5553.7 5622.1 5676.7 5706.1 5782.5 5834.6 5840.8 5665.9 5666.7 5670.0 5695.5 5707.3 5010.8 5021.3 5025.7 5033.5 5058.7 5984.8 6038.7 6068.3 6157.3 6164.1 5865.6 5932.2 5939.9 5965.6 5972.1 6181.7 6186.3 6188.9 6197.6 6202.1 5578.1 5626.1 5706.5 5760.4 5772.0 5799.2 5822.4 5828.9 5840.2 5895.7 5695.4 5710.9 5718.3 5720.1 5725.9 5600.3 5735.5 5742.9 5743.0 5743.9 5576.2 5607.7 5639.4 5642.7 5733.4 5718.8 5725.1 5731.7 5735.4 5740.5 5560.1 5595.9 5601.6 5604.5 5609.5 17:00:33 INFO - PROCESS | 7758 | 17:00:33 INFO - PROCESS | 7758 | [#1] ext.html Cycles:180 Average:63253.44 Median:41827.39 stddev:117362.21 (280.6%) stddev-sans-first:117597.03 17:00:33 INFO - PROCESS | 7758 | Values: 556.4 585.1 621.5 636.8 645.6 37201.0 49911.5 51895.7 52017.2 56476.4 53564.2 54051.7 54125.7 54137.2 54138.7 8686.2 8886.7 9544.5 9744.3 9754.5 11290.8 11637.1 11643.4 12033.5 12046.5 11774.9 11854.2 11855.2 11867.0 11868.8 11770.7 11801.2 11827.6 11828.3 11838.1 11535.6 11610.8 11613.7 11614.9 11616.7 49703.0 49950.0 50328.0 50368.5 50385.7 4475.0 4576.1 4633.4 4704.0 4722.4 36163.8 36413.3 36884.8 37131.3 37949.8 4640.9 4669.0 4682.9 4702.2 4735.4 357366.0 358617.0 360246.0 360417.6 361543.0 72883.6 73239.0 73266.3 73280.3 73327.0 74962.0 75078.0 75147.6 75370.6 75557.2 18237.6 18655.3 18717.9 18727.9 18736.5 12776.2 13073.8 13426.7 13867.3 13931.8 20692.2 21590.2 21672.5 21706.9 21799.6 6811.4 6954.2 6955.7 7061.8 7156.5 994.7 1019.9 1021.2 1024.7 1033.1 34618.8 34799.5 35378.1 35547.5 35905.5 1163.9 1169.3 1185.9 1212.1 1213.9 18338.4 18356.4 18481.4 18532.5 18752.5 551531.0 561657.0 562493.0 565057.0 565758.0 51851.5 51921.2 51985.5 52013.0 52022.0 1571.5 1590.7 1594.5 1626.2 1628.6 33485.0 34797.8 34921.3 35294.8 35321.0 61612.7 62553.0 62779.0 62793.0 62834.7 382129.0 383147.0 385096.0 385352.0 388701.0 40054.0 45018.8 47132.8 47645.3 49746.5 51968.5 52413.2 52875.0 52926.2 52973.5 44825.8 45389.3 45410.8 45980.8 47183.0 43600.8 43967.8 45238.5 45337.3 46505.0 43703.6 43825.0 44968.3 44973.3 45070.0 35514.8 36521.6 36618.6 36981.3 39757.8 27698.0 27723.7 27915.0 27981.6 28524.6 17:00:33 INFO - PROCESS | 7758 | 17:00:33 INFO - PROCESS | 7758 | [#2] jquery.html Cycles:180 Average:35469.14 Median:2847.99 stddev:111336.04 (3909.3%) stddev-sans-first:111617.22 17:00:33 INFO - PROCESS | 7758 | Values: 398.2 413.5 427.9 429.0 432.1 20440.1 21289.7 22399.6 22567.8 22652.8 21644.7 21853.9 21860.6 21998.1 22009.3 5980.9 6198.7 6204.9 6205.2 6206.6 5786.1 6014.8 6027.1 6034.3 6187.4 6205.3 6218.8 6225.0 6226.1 6234.9 6853.7 6899.5 6929.7 6960.6 6974.2 5930.5 5956.7 5990.4 6009.1 6224.0 13891.6 14102.0 14558.2 14713.3 14781.8 2721.3 2847.2 2848.8 2850.7 2861.1 10556.9 10569.6 10595.8 10690.0 11000.5 2017.6 2062.2 2067.1 2092.5 2121.3 84061.6 94072.0 95958.0 98451.0 100120.0 11934.5 12376.1 12382.9 12545.7 12569.4 17963.8 17977.4 18006.6 18008.8 18021.2 8796.0 8859.3 8967.1 9002.5 9086.3 8311.3 8352.4 8354.5 8548.6 8554.1 5240.5 5261.2 5291.9 5347.6 5455.0 2143.1 2174.0 2199.8 2212.7 2248.8 933.6 944.3 949.3 956.2 960.9 17484.7 18897.5 20184.6 20365.2 20653.7 965.1 965.1 968.5 974.6 987.4 10782.8 11266.4 11313.8 11387.8 11438.4 661090.0 668390.0 679028.0 687098.0 692079.0 80708.0 106193.0 107626.5 108559.5 110170.4 1057.7 1059.1 1096.7 1097.2 1103.6 17316.8 17726.9 17800.2 17816.8 18165.0 46207.8 46339.5 46454.9 47451.5 48706.3 63457.7 64249.7 64359.0 64909.7 64974.4 6205.5 8978.1 9194.5 9330.6 9379.9 11330.3 14077.2 14356.3 14472.0 14704.3 10230.9 11888.9 12140.1 12294.3 12460.6 11546.2 11600.6 11825.6 11861.5 12054.5 11798.1 11992.8 12071.2 12076.6 12110.5 8939.3 8968.5 8981.7 9054.6 9160.0 9253.5 11697.2 12111.9 12154.6 12164.3 17:00:33 INFO - PROCESS | 7758 | 17:00:33 INFO - PROCESS | 7758 | [#3] mootools.html Cycles:180 Average:5612.44 Median:4834.56 stddev:3060.56 (63.3%) stddev-sans-first:3052.70 17:00:33 INFO - PROCESS | 7758 | Values: 1392.0 1490.9 1512.2 1516.7 1521.2 7409.0 8265.2 8534.6 8552.1 8768.1 8596.8 8650.4 8652.7 8683.0 8688.0 2121.2 2190.2 2409.9 2461.3 2464.5 2397.2 2473.5 2480.6 2489.0 2507.1 2395.4 2416.9 2424.3 2424.5 2433.9 2430.8 2440.5 2457.8 2460.4 2469.3 2399.3 2459.2 2467.2 2469.8 2469.8 8567.0 8611.5 8611.8 8632.5 8637.6 5067.3 5266.9 5275.3 5278.1 5278.9 3322.0 3362.7 3410.4 3465.6 3484.7 1248.2 1284.1 1314.2 1315.3 1333.7 11558.7 11626.2 11658.2 11664.8 11679.7 4324.8 4611.0 4688.6 4693.9 4730.1 10012.3 10032.7 10033.1 10068.2 10078.4 5389.1 5404.2 5404.3 5417.0 5417.2 4335.8 4704.1 4881.3 4906.1 4958.8 4133.5 4150.7 4218.9 4260.0 4260.3 1285.5 1303.6 1307.7 1308.8 1316.2 989.3 1081.9 1083.1 1084.5 1092.3 5930.7 5955.8 6091.6 6091.9 6227.7 629.9 634.9 1047.8 1063.1 1081.2 4135.5 4238.0 4255.8 4269.4 4321.7 10154.6 10480.0 10493.1 10494.5 10513.4 10259.0 10351.9 10359.5 10370.2 10397.2 7800.9 7979.6 8096.5 8109.9 8128.7 5637.4 5710.2 5835.0 5842.7 5931.9 9501.3 9504.7 9532.4 9598.5 9608.6 9389.7 9586.3 9631.2 9712.8 9725.7 6839.8 6843.3 6962.3 7031.5 7035.4 7739.7 7802.8 7809.3 7812.2 7816.7 6713.6 6848.2 6880.9 6913.6 7007.2 6873.6 6894.2 6908.5 7039.5 7096.4 6428.5 6513.7 6515.4 6517.9 6519.7 4916.8 4996.9 5047.3 5054.5 5091.3 4663.7 4812.9 4856.2 4975.3 4979.3 17:00:33 INFO - PROCESS | 7758 | 17:00:33 INFO - PROCESS | 7758 | [#4] prototype.html Cycles:180 Average:4749.02 Median:5417.77 stddev:1374.91 (25.4%) stddev-sans-first:1339.05 17:00:33 INFO - PROCESS | 7758 | Values: 377.7 387.4 399.9 400.7 404.8 5400.2 5422.6 5428.6 5430.3 5497.2 5367.5 5378.0 5381.4 5383.0 5404.0 4203.3 4317.2 4322.7 4324.8 4355.4 4346.1 4347.0 4351.4 4359.7 4363.6 4310.4 4312.7 4341.5 4344.5 4364.1 4028.2 4183.4 4244.1 4343.3 4360.2 3721.4 3734.3 3739.9 3745.6 3750.5 5229.8 5246.5 5251.3 5271.5 5302.6 4605.5 4809.8 4849.5 4858.0 4862.9 5626.0 5627.6 5633.9 5638.3 5642.4 4104.0 4104.6 4107.9 4115.3 4122.2 5242.4 5510.9 5693.8 5860.2 5873.9 4155.8 4157.3 4157.9 4162.9 4166.7 4211.6 4213.9 4226.5 4227.3 4241.7 4572.2 4686.0 4808.6 4836.4 4842.3 5432.3 5606.4 5630.7 5645.6 5678.8 1407.2 1413.8 1417.1 1418.9 1422.8 952.8 979.1 980.6 980.8 999.0 5293.7 5321.4 5348.2 5421.6 5422.5 5525.7 5543.3 5598.2 5617.9 5659.2 5110.3 5304.3 5359.2 5389.3 5414.0 2918.2 2928.0 2942.4 2982.4 2984.0 5745.3 5770.5 5782.2 5793.8 5799.9 5589.5 5663.2 5782.2 5930.0 5930.5 5868.5 5998.9 6010.8 6016.7 6019.2 5705.5 5750.3 5772.5 5774.6 5776.9 5529.6 5651.4 5685.6 5695.5 5696.2 5957.6 5982.9 5990.8 6003.7 6020.6 4039.5 4144.3 4184.4 4190.0 4199.7 5769.9 5777.8 5782.6 5794.9 5817.7 5614.7 5660.8 5668.5 5669.0 5706.0 5410.1 5584.6 5605.7 5662.4 5683.9 5613.7 5620.9 5633.6 5661.1 5661.8 5584.6 5681.3 5708.6 5715.8 5733.3 5444.9 5535.6 5580.2 5592.9 5607.6 17:00:33 INFO - PROCESS | 7758 | 17:00:33 INFO - PROCESS | 7758 | [#5] yui.html Cycles:180 Average:18352.54 Median:4634.87 stddev:22305.07 (481.2%) stddev-sans-first:22328.72 17:00:33 INFO - PROCESS | 7758 | Values: 804.5 821.0 833.8 900.5 913.7 15282.2 16195.2 16201.4 17645.1 18232.3 16598.8 16756.6 16776.9 16783.0 16786.7 697.4 716.2 800.7 821.0 822.3 839.4 841.8 842.0 842.1 843.0 878.9 883.4 883.6 885.1 885.2 734.5 757.5 851.7 875.9 878.0 646.6 646.6 646.8 646.9 647.1 16039.8 16349.6 16427.0 16498.2 17256.1 15106.2 16064.8 16071.0 16161.5 16431.8 13475.3 13578.0 13593.1 13760.5 14114.3 4570.5 4699.3 4766.5 4788.0 4802.4 74519.6 74617.0 74724.6 76783.0 76794.6 11938.6 11992.6 12013.5 12106.0 12285.1 23515.4 23654.8 23672.2 23675.8 23696.6 8266.9 8511.8 8574.9 8849.0 8948.4 5021.5 5078.9 5120.9 5130.5 5179.5 3643.5 3696.1 3747.9 3766.3 3769.6 613.6 617.3 620.4 623.9 624.0 782.8 785.1 790.3 805.2 807.5 10494.9 10781.9 10918.8 10943.9 11172.8 781.1 785.9 787.1 797.2 814.1 5355.0 5357.9 5370.8 5430.4 5458.3 79270.6 80090.6 80885.8 81035.6 81573.2 59149.7 62801.7 71927.6 72556.3 74728.0 62339.4 63161.0 63570.4 64176.0 65788.7 10003.3 10105.2 10276.6 10341.5 10411.6 43580.6 44081.1 44556.3 44685.3 45143.5 55202.7 55420.4 56254.2 56260.4 57852.7 14175.2 14412.9 14474.0 14723.8 14732.9 16076.8 16246.3 16545.3 16571.6 16817.8 14396.0 14529.3 14814.6 15433.2 15707.2 15444.1 15559.1 15849.0 16038.6 16685.0 13966.5 14003.5 14057.0 14529.3 14540.0 12146.6 12706.0 13043.8 13337.2 13992.7 11597.2 11788.8 11844.9 11962.3 11964.8 17:00:33 INFO - PROCESS | 7758 | -------- Summary: end -------- 17:00:33 INFO - PROCESS | 7758 | 17:00:34 INFO - TEST-INFO | 7758: exit 0 17:00:34 INFO - TEST-OK | dromaeo_css | took 1113450ms 17:00:34 INFO - TEST-START | kraken 17:00:34 INFO - operating with platform_type : linux_ 17:00:34 INFO - Initialising browser for kraken test... 17:00:34 INFO - TEST-INFO | started process 8077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmHkY4C/profile http://localhost:44248/getInfo.html) 17:00:38 INFO - PROCESS | 8077 | __metrics Screen width/height:1600/1200 17:00:38 INFO - PROCESS | 8077 | colorDepth:24 17:00:38 INFO - PROCESS | 8077 | Browser inner width/height: 1024/697 17:00:38 INFO - PROCESS | 8077 | __metrics 17:00:39 INFO - PROCESS | 8077 | 1486256439646 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 17:00:39 INFO - PROCESS | 8077 | 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" 17:00:39 INFO - PROCESS | 8077 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:00:40 INFO - PROCESS | 8077 | console.error: PushService: 17:00:40 INFO - PROCESS | 8077 | stateChangeProcessEnqueue: Error transitioning state 17:00:40 INFO - PROCESS | 8077 | UnknownError 17:00:40 INFO - TEST-INFO | 8077: exit 0 17:00:40 INFO - Browser initialized. 17:00:40 INFO - Running cycle 1/1 for kraken test... 17:00:40 INFO - TEST-INFO | started process 8172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmHkY4C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:52 INFO - PROCESS | 8172 | RSS: Main: 137814016 17:00:52 INFO - PROCESS | 8172 | 17:00:55 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44248/tests/kraken/driver.html?testName=audio-beat-detection) 17:00:56 INFO - PROCESS | 8172 | RSS: Main: 182222848 17:00:56 INFO - PROCESS | 8172 | 17:00:58 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44248/tests/kraken/driver.html?testName=audio-dft) 17:00:59 INFO - PROCESS | 8172 | RSS: Main: 171646976 17:00:59 INFO - PROCESS | 8172 | 17:01:01 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44248/tests/kraken/driver.html?testName=audio-fft) 17:01:02 INFO - PROCESS | 8172 | RSS: Main: 263708672 17:01:02 INFO - PROCESS | 8172 | 17:01:04 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44248/tests/kraken/driver.html?testName=audio-oscillator) 17:01:05 INFO - PROCESS | 8172 | RSS: Main: 169586688 17:01:05 INFO - PROCESS | 8172 | 17:01:07 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:01:07 INFO - PROCESS | 8172 | RSS: Main: 172773376 17:01:07 INFO - PROCESS | 8172 | 17:01:10 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44248/tests/kraken/driver.html?testName=imaging-darkroom) 17:01:11 INFO - PROCESS | 8172 | RSS: Main: 210911232 17:01:11 INFO - PROCESS | 8172 | 17:01:14 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44248/tests/kraken/driver.html?testName=imaging-desaturate) 17:01:15 INFO - PROCESS | 8172 | RSS: Main: 209735680 17:01:15 INFO - PROCESS | 8172 | 17:01:18 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44248/tests/kraken/driver.html?testName=json-parse-financial) 17:01:18 INFO - PROCESS | 8172 | RSS: Main: 207757312 17:01:18 INFO - PROCESS | 8172 | 17:01:20 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:01:20 INFO - PROCESS | 8172 | RSS: Main: 170221568 17:01:20 INFO - PROCESS | 8172 | 17:01:22 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44248/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:01:23 INFO - PROCESS | 8172 | RSS: Main: 177336320 17:01:23 INFO - PROCESS | 8172 | 17:01:25 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:01:25 INFO - PROCESS | 8172 | RSS: Main: 187224064 17:01:25 INFO - PROCESS | 8172 | 17:01:28 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:01:28 INFO - PROCESS | 8172 | RSS: Main: 196083712 17:01:28 INFO - PROCESS | 8172 | 17:01:31 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:01:32 INFO - PROCESS | 8172 | RSS: Main: 192487424 17:01:32 INFO - PROCESS | 8172 | 17:01:33 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:44248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44248/tests/kraken/driver.html?testName=ai-astar) 17:01:34 INFO - PROCESS | 8172 | RSS: Main: 244600832 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | __start_tp_report 17:01:34 INFO - PROCESS | 8172 | _x_x_mozilla_page_load 17:01:34 INFO - PROCESS | 8172 | _x_x_mozilla_page_load_details 17:01:34 INFO - PROCESS | 8172 | |i|pagename|runs| 17:01:34 INFO - PROCESS | 8172 | |0;ai-astar;110;115;112;115;114;114;112;113;113;114 17:01:34 INFO - PROCESS | 8172 | |1;audio-beat-detection;142;121;116;159;119;121;116;117;139;117 17:01:34 INFO - PROCESS | 8172 | |2;audio-dft;161;160;159;161;161;161;161;160;160;160 17:01:34 INFO - PROCESS | 8172 | |3;audio-fft;75;75;77;119;79;75;76;76;89;75 17:01:34 INFO - PROCESS | 8172 | |4;audio-oscillator;83;82;109;83;84;83;92;83;83;112 17:01:34 INFO - PROCESS | 8172 | |5;imaging-gaussian-blur;117;117;117;117;116;117;118;117;117;117 17:01:34 INFO - PROCESS | 8172 | |6;imaging-darkroom;146;147;147;147;148;147;147;147;147;146 17:01:34 INFO - PROCESS | 8172 | |7;imaging-desaturate;97;95;95;96;95;96;96;95;95;95 17:01:34 INFO - PROCESS | 8172 | |8;json-parse-financial;49;50;49;48;49;49;50;49;50;51 17:01:34 INFO - PROCESS | 8172 | |9;json-stringify-tinderbox;64;64;64;63;65;64;64;64;64;64 17:01:34 INFO - PROCESS | 8172 | |10;stanford-crypto-aes;79;83;76;77;77;76;78;77;75;76 17:01:34 INFO - PROCESS | 8172 | |11;stanford-crypto-ccm;131;124;123;123;123;130;129;119;157;119 17:01:34 INFO - PROCESS | 8172 | |12;stanford-crypto-pbkdf2;162;159;157;157;156;161;160;161;157;158 17:01:34 INFO - PROCESS | 8172 | |13;stanford-crypto-sha256-iterative;62;59;63;61;62;61;61;59;59;60 17:01:34 INFO - PROCESS | 8172 | __end_tp_report 17:01:34 INFO - PROCESS | 8172 | __start_cc_report 17:01:34 INFO - PROCESS | 8172 | _x_x_mozilla_cycle_collect,1522 17:01:34 INFO - PROCESS | 8172 | __end_cc_report 17:01:34 INFO - PROCESS | 8172 | __startTimestamp1486256494091__endTimestamp 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | ------- Summary: start ------- 17:01:34 INFO - PROCESS | 8172 | Number of tests: 14 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:1.55 (1.4%) stddev-sans-first:1.13 17:01:34 INFO - PROCESS | 8172 | Values: 110.0 115.0 112.0 115.0 114.0 114.0 112.0 113.0 113.0 114.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:121.00 stddev:14.80 (12.2%) stddev-sans-first:14.62 17:01:34 INFO - PROCESS | 8172 | Values: 142.0 121.0 116.0 159.0 119.0 121.0 116.0 117.0 139.0 117.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 17:01:34 INFO - PROCESS | 8172 | Values: 161.0 160.0 159.0 161.0 161.0 161.0 161.0 160.0 160.0 160.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:13.82 (18.2%) stddev-sans-first:14.45 17:01:34 INFO - PROCESS | 8172 | Values: 75.0 75.0 77.0 119.0 79.0 75.0 76.0 76.0 89.0 75.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:83.00 stddev:11.50 (13.9%) stddev-sans-first:11.96 17:01:34 INFO - PROCESS | 8172 | Values: 83.0 82.0 109.0 83.0 84.0 83.0 92.0 83.0 83.0 112.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 17:01:34 INFO - PROCESS | 8172 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 17:01:34 INFO - PROCESS | 8172 | Values: 146.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 146.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 17:01:34 INFO - PROCESS | 8172 | Values: 97.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:49.50 stddev:0.84 (1.7%) stddev-sans-first:0.88 17:01:34 INFO - PROCESS | 8172 | Values: 49.0 50.0 49.0 48.0 49.0 49.0 50.0 49.0 50.0 51.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 17:01:34 INFO - PROCESS | 8172 | Values: 64.0 64.0 64.0 63.0 65.0 64.0 64.0 64.0 64.0 64.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:77.00 stddev:2.27 (2.9%) stddev-sans-first:2.33 17:01:34 INFO - PROCESS | 8172 | Values: 79.0 83.0 76.0 77.0 77.0 76.0 78.0 77.0 75.0 76.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:126.50 stddev:11.09 (8.8%) stddev-sans-first:11.71 17:01:34 INFO - PROCESS | 8172 | Values: 131.0 124.0 123.0 123.0 123.0 130.0 129.0 119.0 157.0 119.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:159.50 stddev:2.10 (1.3%) stddev-sans-first:1.88 17:01:34 INFO - PROCESS | 8172 | Values: 162.0 159.0 157.0 157.0 156.0 161.0 160.0 161.0 157.0 158.0 17:01:34 INFO - PROCESS | 8172 | 17:01:34 INFO - PROCESS | 8172 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:61.00 stddev:1.42 (2.3%) stddev-sans-first:1.42 17:01:34 INFO - PROCESS | 8172 | Values: 62.0 59.0 63.0 61.0 62.0 61.0 61.0 59.0 59.0 60.0 17:01:34 INFO - PROCESS | 8172 | -------- Summary: end -------- 17:01:34 INFO - PROCESS | 8172 | 17:01:35 INFO - TEST-INFO | 8172: exit 0 17:01:35 INFO - TEST-OK | kraken | took 60420ms 17:01:35 INFO - SUITE-END | took 1173s 17:01:35 INFO - Completed test suite (00:19:33) 17:01:35 INFO - javascript benchmark 17:01:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3240.2385439421732, 3263.3962716897377, 3298.4062868683627, 3303.4714445688696, 3309.851056702449, 5424.376196737377, 5486.259354987081, 5545.140503222007, 5549.5837812164045, 5552.222688823558, 5504.834854954348, 5522.585806064541, 5523.861903452405, 5530.2810634617545, 5535.944640553594, 4996.650234483587, 5010.6993580385115, 5043.39479262489, 5051.0, 5113.181890897457, 4927.162382394984, 4955.950440495603, 5036.370453693288, 5088.92366614501, 5093.465186155438, 4908.803647854082, 4922.310876477296, 4970.0, 5036.546710796028, 5058.544730974211, 5068.898622027576, 5079.288899554065, 5085.364329458817, 5087.6184286178495, 5104.795808167669, 4862.7325497097645, 4978.0, 5005.1491246488185, 5037.471065538139, 5060.291559181717, 5364.651297665679, 5388.191771234307, 5441.156620723755, 5444.50999410055, 5498.80754173606, 5869.4717475427415, 5921.585489015771, 5929.911051334234, 5930.318013428425, 5940.257467816523, 5933.3473317934995, 5949.077892926603, 5974.103884417329, 5978.073398623221, 5992.221011268551, 5426.8914621707345, 5459.972700136514, 5512.228288039678, 5520.420355862657, 5547.8890422191735, 6041.093835924647, 6041.969790151021, 6054.606450580698, 6058.909116363258, 6083.270007599028, 5784.2769653793275, 5806.65160090396, 5823.155642431823, 5830.737616807254, 5839.620424672383, 5702.116171993348, 5726.627769194989, 5732.541396688255, 5768.250127483484, 5889.941100589025, 5693.516051135617, 5748.770049198069, 5752.309722833287, 5772.3938986406665, 5783.65298082108, 5776.393478684761, 5783.450572195718, 5796.101604251347, 5796.391378905154, 5797.47822695951, 4458.9331160032625, 4502.639788816887, 4523.88690282739, 4534.659900507475, 4581.152486789954, 3996.7402118862183, 4016.3172260715164, 4048.858289959896, 4068.9186216275507, 4070.531888832763, 5551.8889622207325, 5552.944470555323, 5553.694546799965, 5553.722313884289, 5622.100463925753, 5676.716164191774, 5706.115552089433, 5782.508486778587, 5834.591578589458, 5840.766369345263, 5665.943340566541, 5666.716664166775, 5669.971650141723, 5695.515881150149, 5707.315122185281, 5010.774515146827, 5021.322121513549, 5025.723585202849, 5033.47148549397, 5058.747062646853, 5984.820455386345, 6038.728257228435, 6068.332483426908, 6157.322694503601, 6164.106204600308, 5865.618734782225, 5932.16949627044, 5939.940600594112, 5965.552583556338, 5972.074328479092, 6181.660008699385, 6186.319504854552, 6188.938110618837, 6197.628142311476, 6202.100695399232, 5578.051731205786, 5626.071698169756, 5706.4864162225595, 5760.395158508296, 5771.97114014444, 5799.217105690678, 5822.417758224144, 5828.854278643068, 5840.182374467663, 5895.7052147391605, 5695.430456954271, 5710.885782284248, 5718.342390625131, 5720.056190728483, 5725.914111288417, 5600.327960644749, 5735.4551317624755, 5742.913856292243, 5743.0, 5743.885122297447, 5576.163575463713, 5607.663540187602, 5639.407862174577, 5642.746076426489, 5733.39799321082, 5718.828435146952, 5725.141228815711, 5731.684757338387, 5735.426457354231, 5740.512056475246, 5560.138178582326, 5595.860103497445, 5601.6358936668985, 5604.467575580314, 5609.467100625434], "value": 5420.256284373362, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.4099118602902, 585.1077107411197, 621.4655396359132, 636.7771280051979, 645.6158585641541, 37201.0, 49911.50088499114, 51895.74052129734, 52017.219741703906, 56476.43523564763, 53564.196537051976, 54051.72974135134, 54125.72937135309, 54137.1879421808, 54138.72930635351, 8686.174813392749, 8886.688965886164, 9544.475053872035, 9744.269179811507, 9754.46350450725, 11290.830637540403, 11637.127215458831, 11643.35961522116, 12033.458494367775, 12046.518139274462, 11774.941125294405, 11854.229475084136, 11855.170138090338, 11867.0, 11868.821967670492, 11770.705732356717, 11801.232919860182, 11827.586034488837, 11828.349440780754, 11838.112141589416, 11535.59625413115, 11610.767784644344, 11613.709657258636, 11614.883851161465, 11616.651500455, 49703.0, 49950.0, 50328.0, 50368.49631503711, 50385.748071259775, 4474.977625111854, 4576.084783043371, 4633.4439867215815, 4704.0, 4722.386089808338, 36163.81918090419, 36413.27173456516, 36884.81557592195, 37131.25737485235, 37949.81025094857, 4640.86077417678, 4669.0, 4682.929756053662, 4702.1771190041945, 4735.431748190204, 357366.0, 358617.0, 360246.0, 360417.5937360942, 361543.0, 72883.63558182176, 73239.0, 73266.26733732595, 73280.26719732842, 73327.0, 74962.0, 75078.0, 75147.62426187834, 75370.62314688391, 75557.24442755502, 18237.63524729498, 18655.253789848255, 18717.906410467862, 18727.90636046811, 18736.53158671044, 12776.233425994471, 13073.803892941614, 13426.664333391744, 13867.306634668226, 13931.791023134661, 20692.172313107607, 21590.244341447975, 21672.458188545097, 21706.891465542885, 21799.564008719735, 6811.352921472452, 6954.165500139914, 6955.652217389212, 7061.823454413578, 7156.499045066796, 994.7463396833762, 1019.887812340642, 1021.2442792333619, 1024.6567399920962, 1033.0960409641564, 34618.82690586581, 34799.4780078299, 35378.11554711153, 35547.4667879982, 35905.46141807875, 1163.906887449002, 1169.2750494693344, 1185.9051275897907, 1212.0788200967152, 1213.9332336721388, 18338.358157464423, 18356.35752748674, 18481.353152639593, 18532.536686582942, 18752.53118672044, 551531.0, 561657.0, 562493.0, 565057.0, 565758.0, 51851.48148518542, 51921.221181682304, 51985.48014519807, 52013.0, 52022.0, 1571.5128310223868, 1590.6977674241857, 1594.5057032320017, 1626.2356692354574, 1628.5847108987132, 33485.0, 34797.82601086979, 34921.301573968885, 35294.82352588221, 35321.0, 61612.69193654003, 62553.0, 62779.0, 62793.0, 62834.685826570574, 382129.0, 383147.0, 385096.0, 385352.0, 388701.0, 40054.0, 45018.77490612526, 47132.7643361781, 47645.28532071952, 49746.502534974185, 51968.480315196364, 52413.21380179377, 52875.0, 52926.206106909194, 52973.470265296855, 44825.77587112044, 45389.31916021329, 45410.77294613506, 45980.7700961493, 47183.0, 43600.78199608982, 43967.78016109899, 45238.547614523435, 45337.319940200265, 46505.0, 43703.562964371224, 43825.0, 44968.32547511855, 44973.32540011968, 45070.0, 35514.82242588874, 36521.634783651825, 36618.633813662585, 36981.260374792895, 39757.80121099376, 27698.0, 27723.722762772115, 27915.0, 27981.580276296278, 28524.57213141846], "value": 22655.688039970373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.2453251089188, 413.4604341334557, 427.8908878236048, 428.9528151903291, 432.0667358505627, 20440.08019639116, 21289.680654790172, 22399.55200895981, 22567.774322256773, 22652.77347226527, 21644.675329870064, 21853.890730546365, 21860.562788744217, 21998.120075197014, 22009.33971980839, 5980.880382392361, 6198.659073750942, 6204.875902481947, 6205.22434695663, 6206.565540412173, 5786.103154011114, 6014.8496287592725, 6027.126066720323, 6034.275886893557, 6187.412195841411, 6205.286392064902, 6218.8445288867915, 6224.968875155618, 6226.097215903691, 6234.937650623504, 6853.657317134148, 6899.517033807636, 6929.72281108755, 6960.617166055865, 6974.232834388264, 5930.466258036754, 5956.702164891782, 5990.371011043865, 6009.09863520471, 6223.968880155616, 13891.583252502442, 14102.0, 14558.199299038548, 14713.264336783224, 14781.778273325908, 2721.319670082479, 2847.174319447358, 2848.8148270362362, 2850.700676428966, 2861.1416575027615, 10556.947215263952, 10569.577216911315, 10595.788084238273, 10690.0, 11000.504977275961, 2017.5662232619911, 2062.2163577840474, 2067.069818581629, 2092.476880779805, 2121.331780489141, 84061.57969210176, 94072.0, 95958.0, 98450.99999999929, 100120.0, 11934.462949167135, 12376.133670643148, 12382.876171238353, 12545.749085018431, 12569.371531423392, 17963.820361796214, 17977.370792022215, 18006.639867202844, 18008.819911800714, 18021.18904649294, 8795.956020219857, 8859.291256699578, 8967.058458861857, 9002.549872506479, 9086.273098152133, 8311.298827880963, 8352.415330926777, 8354.498730076215, 8548.572571371407, 8554.144585541397, 5240.502152295526, 5261.184516399888, 5291.947080529222, 5347.572194224453, 5454.972725136428, 2143.1106090972385, 2173.978260217409, 2199.7800219977876, 2212.723409573803, 2248.797608215236, 933.5518950903604, 944.2729098594044, 949.349695458613, 956.1920177450044, 960.8943016268205, 17484.737728934077, 18897.527561811065, 20184.59630807405, 20365.185392584426, 20653.690194647093, 965.0783501755807, 965.0879918477112, 968.4576637083115, 974.5906719177963, 987.4322264697684, 10782.78434431307, 11266.380349080879, 11313.773724525463, 11387.772244555063, 11438.370889601152, 661090.0, 668390.0, 679028.0, 687098.0, 692079.0, 80708.0, 106193.0, 107626.46186769016, 108559.45720271506, 110170.44914775375, 1057.6615483045352, 1059.147386353977, 1096.736783172049, 1097.1716354152722, 1103.5806393570392, 17316.82683173152, 17726.91136544309, 17800.198991045694, 17816.821831781515, 18165.0, 46207.84480387883, 46339.536604633526, 46454.89375833288, 47451.525484744714, 48706.26940595823, 63457.682711586145, 64249.67875160594, 64359.0, 64909.67545162244, 64974.35025649683, 6205.503559715302, 8978.10218978097, 9194.54027298619, 9330.580123894306, 9379.906200937903, 11330.263532870336, 14077.155370677792, 14356.282185890872, 14472.0, 14704.264786760405, 10230.948845255725, 11888.881111189123, 12140.089493287862, 12294.262344259372, 12460.626181214579, 11546.19176657626, 11600.593979210687, 11825.645230643095, 11861.466234019663, 12054.457549410474, 11798.056155507711, 11992.820107698217, 12071.215371000857, 12076.637700868989, 12110.51557937708, 8939.329550283624, 8968.461892286483, 8981.730548083568, 9054.637814487347, 9160.0, 9253.53732313395, 11697.181197316106, 12111.939440302742, 12154.574589889311, 12164.2701437914], "value": 9832.717160688457, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.9930400347996, 1490.888183386246, 1512.2212060788695, 1516.7497362935123, 1521.1861654015097, 7409.0, 8265.173482651739, 8534.573271336432, 8552.059273479912, 8768.079351668079, 8596.785080372994, 8650.35122365822, 8652.653893844254, 8683.044865064838, 8688.044315125348, 2121.1939463004037, 2190.1786829938774, 2409.8674572898485, 2461.2739241923587, 2464.4824586836785, 2397.160993652225, 2473.4558397152596, 2480.59070253408, 2489.029278581355, 2507.059852555292, 2395.4131237846664, 2416.915407960722, 2424.2969538833718, 2424.5150969806023, 2433.9391515212083, 2430.7812296893276, 2440.46309811842, 2457.778799907999, 2460.4463995600936, 2469.2715648883623, 2399.28021593523, 2459.18846780562, 2467.1734968785477, 2469.76537228963, 2469.802415806731, 8567.0, 8611.48331100136, 8611.827763444759, 8632.482051076955, 8637.568121593895, 5067.265246539268, 5266.894662106736, 5275.340582427197, 5278.1291086970605, 5278.947210527884, 3321.983390083058, 3362.6717446608454, 3410.437277849152, 3465.5668041494814, 3484.738644601665, 1248.2385744695728, 1284.1203775413871, 1314.2377421095837, 1315.3357554435045, 1333.7065845514069, 11558.653240402802, 11626.244294120856, 11658.242214256046, 11664.766704665944, 11679.708007299885, 4324.762138082373, 4610.976945115253, 4688.554587314268, 4693.929591056137, 4730.101280756645, 10012.349197302152, 10032.69901902944, 10033.147182489423, 10068.194544436428, 10078.445685487368, 5389.056915039931, 5404.162354835007, 5404.270423492857, 5417.0, 5417.214503896913, 4335.783210839509, 4704.1062198182235, 4881.316615673809, 4906.116898958222, 4958.776855041532, 4133.458619161914, 4150.709450338508, 4218.8523401681405, 4259.97870010648, 4260.339647354665, 1285.5050805439787, 1303.6219496346143, 1307.6796184934562, 1308.770965081126, 1316.1773891317926, 989.3272574649163, 1081.9296745711504, 1083.1226706367868, 1084.5336505302796, 1092.2900114925203, 5930.733117009745, 5955.76176952917, 6091.592292189886, 6091.878162436727, 6227.719752611053, 629.8929182039064, 634.8825467288566, 1047.8061558611682, 1063.0910571461443, 1081.167501024207, 4135.545090040093, 4237.957620423818, 4255.765932873722, 4269.4449721536, 4321.65426765858, 10154.593816247416, 10480.0, 10493.108085812639, 10494.475276236157, 10513.421761803174, 10259.0, 10351.948240258751, 10359.533820977924, 10370.22223333253, 10397.220208484243, 7800.882986755203, 7979.561124138112, 8096.473729207582, 8109.918900811034, 8128.674853005814, 5637.379888212211, 5710.17202505626, 5835.0, 5842.737076831638, 5931.881362372815, 9501.334906556474, 9504.714858554255, 9532.428054316486, 9598.472084035446, 9608.567614457506, 9389.718308450758, 9586.281028922998, 9631.229501639711, 9712.75718107053, 9725.6596019139, 6839.760608378683, 6843.349881761224, 6962.338577835098, 7031.472639552157, 7035.437165026888, 7739.729109481141, 7802.765917022499, 7809.258120478546, 7812.218778122142, 7816.687332506636, 6713.56361836479, 6848.212455567674, 6880.862382752417, 6913.585184888922, 7007.229204787367, 6873.621950792754, 6894.207166175954, 6908.516403851682, 7039.54242974205, 7096.432285417051, 6428.485721142204, 6513.674316284072, 6515.413612774873, 6517.869642607026, 6519.706613202512, 4916.827911023097, 4996.925046124238, 5047.318611987482, 5054.494550544916, 5091.338126043591, 4663.655717156438, 4812.927806082842, 4856.198727210112, 4975.328330675313, 4979.3277907482025], "value": 4581.974492898162, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.66576579726933, 387.3627882133888, 399.936169788363, 400.7194963525532, 404.8239016028028, 5400.1629747389115, 5422.620416570841, 5428.565714742821, 5430.321209848769, 5497.175423686444, 5367.490088441602, 5377.973110134453, 5381.354237491497, 5383.0, 5403.972980135094, 4203.264428724976, 4317.244482215616, 4322.675799315049, 4324.848630297948, 4355.412019377391, 4346.130773845228, 4346.956530434687, 4351.4343135392355, 4359.673024523157, 4363.563643635627, 4310.439642846425, 4312.741235525878, 4341.480481831365, 4344.45694288214, 4364.10535840152, 4028.2144981728575, 4183.3515805050265, 4244.129953359554, 4343.326784348431, 4360.23695853226, 3721.423179407196, 3734.25314937011, 3739.8878033659034, 3745.550533935918, 3750.5124333836425, 5229.843104706865, 5246.527812496894, 5251.343582052244, 5271.525562699376, 5302.6023048271145, 4605.4933957264675, 4809.763459991086, 4849.515048495157, 4858.0, 4862.902741945177, 5626.046325679051, 5627.577931655102, 5633.8591535211945, 5638.323401191842, 5642.420122365744, 4104.004077023789, 4104.610062044131, 4107.938380924288, 4115.34154535273, 4122.237386083584, 5242.397124330712, 5510.862228444281, 5693.772249110072, 5860.238169038041, 5873.882522349571, 4155.833766649361, 4157.272477316457, 4157.896052598649, 4162.937555936603, 4166.687498437569, 4211.642010429086, 4213.894652633648, 4226.520717748764, 4227.302495088337, 4241.703080784378, 4572.177008138567, 4686.0, 4808.63935204861, 4836.371271734652, 4842.3125165532765, 5432.261676263558, 5606.411326810708, 5630.690312032878, 5645.628835888937, 5678.829635110953, 1407.1697698358018, 1413.8162038934872, 1417.149710173908, 1418.8793952513945, 1422.8150340455675, 952.8189643967625, 979.0845559401982, 980.6028558433845, 980.8185485685171, 998.9660701174249, 5293.735313234323, 5321.414644389114, 5348.197770334403, 5421.566274698014, 5422.511973922287, 5525.696086715189, 5543.334799824047, 5598.216249725042, 5617.943820561742, 5659.207710920475, 5110.28456016158, 5304.310439642822, 5359.196120581944, 5389.299391079135, 5413.9729301353245, 2918.2266699324696, 2927.956080658792, 2942.367391010943, 2982.388610334876, 2983.970160298413, 5745.253117094751, 5770.509506691894, 5782.161586569924, 5793.797217097382, 5799.9130013049835, 5589.496945274945, 5663.235463212413, 5782.183758719225, 5930.0, 5930.495907847881, 5868.501177399969, 5998.940010599838, 6010.849728756729, 6016.669083200379, 6019.247594050744, 5705.486506214461, 5750.338711048283, 5772.480476757112, 5774.595778295647, 5776.942230577641, 5529.617595601099, 5651.406602306699, 5685.630434021941, 5695.487406133468, 5696.174054762119, 5957.553183511341, 5982.905982905948, 5990.7903223386975, 6003.669798160969, 6020.608660437058, 4039.4546736190237, 4144.254034273859, 4184.393262976912, 4190.0, 4199.685023623179, 5769.855428791235, 5777.768889244383, 5782.595218334676, 5794.870000349892, 5817.680027598522, 5614.687334472681, 5660.773569057356, 5668.461496157858, 5668.971655141698, 5706.029974904193, 5410.080286351408, 5584.636998595079, 5605.691686957093, 5662.433756624305, 5683.914741278967, 5613.719314034363, 5620.943790562205, 5633.63381380209, 5661.094224924157, 5661.801836935688, 5584.647456038106, 5681.289838770153, 5708.628939118944, 5715.771369145187, 5733.254676891977, 5444.863878403072, 5535.557155427637, 5580.237782297789, 5592.916106258491, 5607.635503692247], "value": 4324.822042037421, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.4891493901374, 821.0, 833.8248967716779, 900.4507250577149, 913.7487191022468, 15282.159481228528, 16195.190240487973, 16201.351945922164, 17645.117744112806, 18232.27070917165, 16598.75101873473, 16756.58108547287, 16776.916115419437, 16783.0, 16786.66426671466, 697.4141720954398, 716.1871276101637, 800.6757263308369, 820.9507429554246, 822.313368337439, 839.412411312081, 841.8274253777961, 841.970531031414, 842.0653075086649, 842.970496032639, 878.9384743067988, 883.3948745109589, 883.6112110671316, 885.1281487734608, 885.1723638398087, 734.5188901269677, 757.4697711601873, 851.6891334662804, 875.916787905148, 877.9604917778715, 646.5732616473152, 646.5764923974804, 646.7639311651213, 646.9256035555924, 647.0843756085134, 16039.759403608956, 16349.591260218589, 16427.0, 16498.17509124551, 17256.050917199547, 15106.244687765678, 16064.839351606452, 16071.035737855766, 16161.515154545383, 16431.753523697153, 13475.258860762655, 13578.0, 13593.116447430984, 13760.518381856687, 14114.294285285694, 4570.474395444533, 4699.271612900006, 4766.475687674388, 4787.952120478821, 4802.447718512381, 74519.62740186264, 74617.0, 74724.62637686831, 76783.0, 76794.61602691951, 11938.553181282185, 11992.580259690869, 12013.459394327276, 12106.0, 12285.1400401971, 23515.41211469727, 23654.7634523656, 23672.17147399833, 23675.763242367357, 23696.64455033176, 8266.875996860052, 8511.829763404698, 8574.914250857537, 8848.955755221183, 8948.414378427331, 5021.5229553192385, 5078.898422031539, 5120.948790512121, 5130.51260130287, 5179.533841954167, 3643.5263415756312, 3696.131409118855, 3747.868824591126, 3766.322062028806, 3769.566499852497, 613.6287546034584, 617.3147805935408, 620.3641267700643, 623.8689875126183, 624.0109426558864, 782.8257613579631, 785.140271402813, 790.3321693169263, 805.1545876829423, 807.5477732469835, 10494.947525262478, 10781.892181078088, 10918.781624367628, 10943.890561094446, 11172.832407513893, 781.0666253826736, 785.9135495095535, 787.0869791042478, 797.1669605262515, 814.0841553252591, 5355.024740313578, 5357.946420535823, 5370.838874833761, 5430.375506816767, 5458.344998600193, 79270.60364698255, 80090.59954700306, 80885.76456941657, 81035.59482202551, 81573.18426815774, 59149.70425147847, 62801.68599156975, 71927.64036179785, 72556.27443725601, 74728.0, 62339.37660623426, 63161.0, 63570.36429635737, 64176.0, 65788.67105664441, 10003.34978226413, 10105.191584673355, 10276.640317588848, 10341.482925853828, 10411.635592754217, 43580.56419435892, 44081.11837763291, 44556.331655025846, 44685.32972005488, 45143.54856451525, 55202.72398637981, 55420.44579554153, 56254.1561876564, 56260.43739562552, 57852.710736446046, 14175.22036288014, 14412.85587144157, 14474.0, 14723.779143312644, 14732.852671473149, 16076.839231608003, 16246.268917898959, 16545.25546350441, 16571.585710357336, 16817.831821681626, 14396.0, 14529.27353632293, 14814.555563333117, 15433.22833858325, 15707.214639268219, 15444.0733555987, 15559.14424706652, 15849.0189225621, 16038.599035024217, 16685.0, 13966.511172108927, 14003.50987715425, 14057.0, 14529.34617942174, 14540.0, 12146.635600931986, 12706.0, 13043.804342935053, 13337.19976801395, 13992.650183745487, 11597.18819682614, 11788.764224715285, 11844.881551184379, 11962.342071186169, 11964.76070478603], "value": 7769.382549293425, "unit": "score"}], "name": "dromaeo_css", "value": 7554.770550271663, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 112.0, 115.0, 114.0, 114.0, 112.0, 113.0, 113.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 121.0, 116.0, 159.0, 119.0, 121.0, 116.0, 117.0, 139.0, 117.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 119.0, 79.0, 75.0, 76.0, 76.0, 89.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 109.0, 83.0, 84.0, 83.0, 92.0, 83.0, 83.0, 112.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 49.0, 48.0, 49.0, 49.0, 50.0, 49.0, 50.0, 51.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 76.0, 77.0, 77.0, 76.0, 78.0, 77.0, 75.0, 76.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 124.0, 123.0, 123.0, 123.0, 130.0, 129.0, 119.0, 157.0, 119.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 157.0, 157.0, 156.0, 161.0, 160.0, 161.0, 157.0, 158.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 63.0, 61.0, 62.0, 61.0, 61.0, 59.0, 59.0, 60.0], "value": 60.7, "unit": "score"}], "name": "kraken", "value": 1468.8, "alertThreshold": 2.0}]} 17:01:35 INFO - Return code: 0 17:01:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:01:35 ERROR - # TBPL SUCCESS # 17:01:35 INFO - Running post-action listener: _resource_record_post_action 17:01:35 INFO - [mozharness: 2017-02-05 01:01:35.410803Z] Finished run-tests step (success) 17:01:35 INFO - Running post-run listener: _resource_record_post_run 17:01:35 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 266240; Write bytes: 381145088; Read time: 56; Write time: 231000 17:01:35 INFO - TinderboxPrint: CPU usage
13.0% 17:01:35 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 56 17:01:35 INFO - TinderboxPrint: I/O write bytes / time
381,145,088 / 231,000 17:01:35 INFO - TinderboxPrint: CPU idle
8,284.1 (87.0%) 17:01:35 INFO - TinderboxPrint: CPU user
1,191.3 (12.5%) 17:01:35 INFO - TinderboxPrint: Swap in / out
0 / 0 17:01:35 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 110223360; Read time: 0; Write time: 107840 17:01:35 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254111744; Read time: 56; Write time: 117852 17:01:36 INFO - Running post-run listener: _upload_blobber_files 17:01:36 INFO - Blob upload gear active. 17:01:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:01:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:01:36 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:01:36 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:01:36 INFO - (blobuploader) - INFO - Open directory for files ... 17:01:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:01:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:01:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:01:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:01:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:01:37 INFO - (blobuploader) - INFO - Done attempting. 17:01:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:01:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:01:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:01:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:01:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:01:40 INFO - (blobuploader) - INFO - Done attempting. 17:01:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:01:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:01:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:01:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:01:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:01:41 INFO - (blobuploader) - INFO - Done attempting. 17:01:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:01:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:01:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:01:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:01:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:01:41 INFO - (blobuploader) - INFO - Done attempting. 17:01:41 INFO - (blobuploader) - INFO - Iteration through files over. 17:01:41 INFO - Return code: 0 17:01:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:01:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:01:41 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/308eafef827d55daa0b09914a8b1e81fcdcd27796bf8f299f37cabf8e5f4c345a836665b7c2ddfa9015e124106a32bc77ef3bd635fa822f1e4fbc9acae6ce9dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b5da3fd69047c7e6d48388b3d8268fc6413ea9887722c23a784b22de99502b5d3f99460ea143332ddbcb9ba457a80547ede810234843d9356724aa928d65fc33", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ac838142c75abb436e57a2a064a244771bc5af8e31b4a4ab46391779f5ea6cfaa1fe205e68658eb3a97c37624c1377fa6fc81946286ec63635f4cd9da1dc5ace", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/32d3c98caa06743e64fd4de78d4bb97674ba9bdd0d0a4f4878d2c1a46674657c75ead3fb566b163edcd60b9b9cd5735eb087d25b228e38dbf3a433e52075f1f6"} 17:01:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:01:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:01:41 INFO - Contents: 17:01:41 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/308eafef827d55daa0b09914a8b1e81fcdcd27796bf8f299f37cabf8e5f4c345a836665b7c2ddfa9015e124106a32bc77ef3bd635fa822f1e4fbc9acae6ce9dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b5da3fd69047c7e6d48388b3d8268fc6413ea9887722c23a784b22de99502b5d3f99460ea143332ddbcb9ba457a80547ede810234843d9356724aa928d65fc33", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ac838142c75abb436e57a2a064a244771bc5af8e31b4a4ab46391779f5ea6cfaa1fe205e68658eb3a97c37624c1377fa6fc81946286ec63635f4cd9da1dc5ace", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/32d3c98caa06743e64fd4de78d4bb97674ba9bdd0d0a4f4878d2c1a46674657c75ead3fb566b163edcd60b9b9cd5735eb087d25b228e38dbf3a433e52075f1f6"} 17:01:41 INFO - Running post-run listener: copy_logs_to_upload_dir 17:01:41 INFO - Copying logs to upload dir... 17:01:41 INFO - mkdir: /builds/slave/test/build/upload/logs 17:01:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.768964 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-04 17:01:41.530644) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-04 17:01:41.534470) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/308eafef827d55daa0b09914a8b1e81fcdcd27796bf8f299f37cabf8e5f4c345a836665b7c2ddfa9015e124106a32bc77ef3bd635fa822f1e4fbc9acae6ce9dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b5da3fd69047c7e6d48388b3d8268fc6413ea9887722c23a784b22de99502b5d3f99460ea143332ddbcb9ba457a80547ede810234843d9356724aa928d65fc33", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ac838142c75abb436e57a2a064a244771bc5af8e31b4a4ab46391779f5ea6cfaa1fe205e68658eb3a97c37624c1377fa6fc81946286ec63635f4cd9da1dc5ace", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/32d3c98caa06743e64fd4de78d4bb97674ba9bdd0d0a4f4878d2c1a46674657c75ead3fb566b163edcd60b9b9cd5735eb087d25b228e38dbf3a433e52075f1f6"} build_url:https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/bHDcf800SrygbZPp_D5WDg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/308eafef827d55daa0b09914a8b1e81fcdcd27796bf8f299f37cabf8e5f4c345a836665b7c2ddfa9015e124106a32bc77ef3bd635fa822f1e4fbc9acae6ce9dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b5da3fd69047c7e6d48388b3d8268fc6413ea9887722c23a784b22de99502b5d3f99460ea143332ddbcb9ba457a80547ede810234843d9356724aa928d65fc33", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ac838142c75abb436e57a2a064a244771bc5af8e31b4a4ab46391779f5ea6cfaa1fe205e68658eb3a97c37624c1377fa6fc81946286ec63635f4cd9da1dc5ace", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/32d3c98caa06743e64fd4de78d4bb97674ba9bdd0d0a4f4878d2c1a46674657c75ead3fb566b163edcd60b9b9cd5735eb087d25b228e38dbf3a433e52075f1f6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-04 17:01:41.559348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:01:41.559712) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1486246811.632140-698052225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:01:41.641937) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-04 17:01:41.642269) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-04 17:01:41.642570) ========= ========= Total master_lag: 0.15 =========