builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1486408204.62 results: success (0) revision: 05fae22830c0365b8173be4a2584ff0375b547a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 11:10:04.620022) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 11:10:04.620535) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 11:10:04.620867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 11:10:04.637752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:10:04.638121) ========= 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=8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-06 11:10:04-- 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% 36.5M=0s 2017-02-06 11:10:05 (36.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125903 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:10:04.778986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:10:04.779641) ========= 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=8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016186 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:10:04.830895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 11:10:04.831309) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 05fae22830c0365b8173be4a2584ff0375b547a1 --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 05fae22830c0365b8173be4a2584ff0375b547a1 --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=8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-06 11:10:05,185 truncating revision to first 12 chars 2017-02-06 11:10:05,186 Setting DEBUG logging. 2017-02-06 11:10:05,186 attempt 1/10 2017-02-06 11:10:05,186 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/05fae22830c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 11:10:06,509 unpacking tar archive at: mozilla-aurora-05fae22830c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.634404 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 11:10:06.479052) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 11:10:06.479383) ========= script_repo_revision: 05fae22830c0365b8173be4a2584ff0375b547a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 11:10:06.479781) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 11:10:06.480053) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 11:10:06.488908) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-02-06 11:10:06.489324) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:10:06 INFO - MultiFileLogger online at 20170206 11:10:06 in /builds/slave/test 11:10:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:10:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:10:06 INFO - {'append_to_log': False, 11:10:06 INFO - 'base_work_dir': '/builds/slave/test', 11:10:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:10:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:10:06 INFO - 'branch': 'Mozilla-Aurora', 11:10:06 INFO - 'buildbot_json_path': 'buildprops.json', 11:10:06 INFO - 'config_files': ('talos/linux_config.py',), 11:10:06 INFO - 'default_actions': ('clobber', 11:10:06 INFO - 'read-buildbot-config', 11:10:06 INFO - 'download-and-extract', 11:10:06 INFO - 'populate-webroot', 11:10:06 INFO - 'create-virtualenv', 11:10:06 INFO - 'install', 11:10:06 INFO - 'run-tests'), 11:10:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:10:06 INFO - 'download_minidump_stackwalk': True, 11:10:06 INFO - 'download_symbols': 'ondemand', 11:10:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:10:06 INFO - 'tooltool.py': '/tools/tooltool.py', 11:10:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:10:06 INFO - '/tools/misc-python/virtualenv.py')}, 11:10:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:10:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:10:06 INFO - 'installer_path': 'installer.exe', 11:10:06 INFO - 'log_level': 'info', 11:10:06 INFO - 'log_name': 'talos', 11:10:06 INFO - 'log_to_console': True, 11:10:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:10:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:10:06 INFO - 'opt_config_files': (), 11:10:06 INFO - 'pip_index': False, 11:10:06 INFO - 'sps_profile': False, 11:10:06 INFO - 'sps_profile_interval': 0, 11:10:06 INFO - 'suite': 'dromaeojs', 11:10:06 INFO - 'system_bits': '32', 11:10:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:10:06 INFO - 'title': 'talos-linux64-ix-038', 11:10:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:10:06 INFO - 'use_talos_json': True, 11:10:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:10:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:10:06 INFO - 'work_dir': 'build'} 11:10:06 INFO - [mozharness: 2017-02-06 19:10:06.944081Z] Running clobber step. 11:10:06 INFO - Running pre-action listener: _resource_record_pre_action 11:10:06 INFO - Running main action method: clobber 11:10:06 INFO - rmtree: /builds/slave/test/build 11:10:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:10:08 INFO - Running post-action listener: _resource_record_post_action 11:10:08 INFO - [mozharness: 2017-02-06 19:10:08.136839Z] Finished clobber step (success) 11:10:08 INFO - [mozharness: 2017-02-06 19:10:08.136938Z] Running read-buildbot-config step. 11:10:08 INFO - Running pre-action listener: _resource_record_pre_action 11:10:08 INFO - Running main action method: read_buildbot_config 11:10:08 INFO - Using buildbot properties: 11:10:08 INFO - { 11:10:08 INFO - "project": "", 11:10:08 INFO - "product": "firefox", 11:10:08 INFO - "who": "ryanvm@gmail.com", 11:10:08 INFO - "installer_path": "public/build/target.tar.bz2", 11:10:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:10:08 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 11:10:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:10:08 INFO - "stage_platform": "linux64-pgo", 11:10:08 INFO - "basedir": "/builds/slave/test", 11:10:08 INFO - "buildnumber": 734, 11:10:08 INFO - "platform": "ubuntu64_hw", 11:10:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:10:08 INFO - "slavebuilddir": "test", 11:10:08 INFO - "taskId": "clusn_LpTtGwfsM5LXflkQ", 11:10:08 INFO - "branch": "mozilla-aurora", 11:10:08 INFO - "script_repo_revision": "production", 11:10:08 INFO - "revision": "05fae22830c0365b8173be4a2584ff0375b547a1", 11:10:08 INFO - "slavename": "talos-linux64-ix-038", 11:10:08 INFO - "repo_path": "releases/mozilla-aurora" 11:10:08 INFO - } 11:10:08 INFO - Finding installer, test and symbols from parent task. 11:10:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/clusn_LpTtGwfsM5LXflkQ'}, attempt #1 11:10:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/clusn_LpTtGwfsM5LXflkQ'}, attempt #1 11:10:09 INFO - Task dependencies: WYWMQ5U2TUKNQ5uJhb0cnA 11:10:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA'}, attempt #1 11:10:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.tar.bz2 11:10:09 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/test_packages.json 11:10:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.crashreporter-symbols.zip 11:10:09 INFO - Running post-action listener: _resource_record_post_action 11:10:09 INFO - [mozharness: 2017-02-06 19:10:09.508495Z] Finished read-buildbot-config step (success) 11:10:09 INFO - [mozharness: 2017-02-06 19:10:09.508749Z] Running download-and-extract step. 11:10:09 INFO - Running pre-action listener: _resource_record_pre_action 11:10:09 INFO - Running main action method: download_and_extract 11:10:09 INFO - mkdir: /builds/slave/test/build/tests 11:10:09 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')]} 11:10:09 INFO - trying https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.test_packages.json 11:10:09 INFO - Downloading https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:10:10 INFO - Downloaded 896 bytes. 11:10:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:10:10 INFO - Using the following test package requirements: 11:10:10 INFO - {u'common': [u'target.common.tests.zip'], 11:10:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:10:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:10:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:10:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:10:10 INFO - u'mozbase': [u'target.common.tests.zip'], 11:10:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:10:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:10:10 INFO - u'web-platform': [u'target.common.tests.zip', 11:10:10 INFO - u'target.web-platform.tests.zip'], 11:10:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:10:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:10:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.common.tests.zip 11:10:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:10:10 INFO - Fetch https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.common.tests.zip into memory 11:10:11 INFO - Expected file size: 21856948 11:10:11 INFO - Obtained file size: 21856948 11:10:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:10:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.common.tests.zip 11:10:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:10:15 INFO - Fetch https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.common.tests.zip into memory 11:10:18 INFO - Expected file size: 21856948 11:10:18 INFO - Obtained file size: 21856948 11:10:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.talos.tests.zip 11:10:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:10:23 INFO - Fetch https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.talos.tests.zip into memory 11:10:23 INFO - Expected file size: 14403485 11:10:23 INFO - Obtained file size: 14403485 11:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:24 INFO - trying https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.tar.bz2 11:10:24 INFO - Downloading https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:10:26 INFO - Downloaded 66092801 bytes. 11:10:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.tar.bz2 11:10:26 INFO - mkdir: /builds/slave/test/properties 11:10:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:10:26 INFO - Writing to file /builds/slave/test/properties/build_url 11:10:26 INFO - Contents: 11:10:26 INFO - build_url:https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.tar.bz2 11:10:26 INFO - Running post-action listener: _resource_record_post_action 11:10:26 INFO - Running post-action listener: set_extra_try_arguments 11:10:26 INFO - [mozharness: 2017-02-06 19:10:26.143201Z] Finished download-and-extract step (success) 11:10:26 INFO - [mozharness: 2017-02-06 19:10:26.143317Z] Running populate-webroot step. 11:10:26 INFO - Running pre-action listener: _resource_record_pre_action 11:10:26 INFO - Running main action method: populate_webroot 11:10:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:10:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:10:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:10:26 INFO - '--tppagecycles', 11:10:26 INFO - '7'], 11:10:26 INFO - 'tests': ['tsvgm']}}, 11:10:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:10:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:10:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:10:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:10:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:10:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:10:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:10:26 INFO - 'talos_options': ['--disable-e10s'], 11:10:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:10:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:10:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:10:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:10:26 INFO - 'talos_options': ['--disable-e10s'], 11:10:26 INFO - 'tests': ['damp', 'tps']}, 11:10:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:10:26 INFO - 'tests': ['damp', 'tps']}, 11:10:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:10:26 INFO - 'tests': ['dromaeo_dom']}, 11:10:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:10:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:10:26 INFO - 'tests': ['basic_compositor_video']}, 11:10:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:10:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:10:26 INFO - 'tests': ['a11yr', 11:10:26 INFO - 'ts_paint', 11:10:26 INFO - 'tpaint', 11:10:26 INFO - 'sessionrestore', 11:10:26 INFO - 'sessionrestore_no_auto_restore', 11:10:26 INFO - 'tabpaint']}, 11:10:26 INFO - 'other-e10s': {'tests': ['a11yr', 11:10:26 INFO - 'ts_paint', 11:10:26 INFO - 'tpaint', 11:10:26 INFO - 'sessionrestore', 11:10:26 INFO - 'sessionrestore_no_auto_restore', 11:10:26 INFO - 'tabpaint']}, 11:10:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:10:26 INFO - 'ts_paint', 11:10:26 INFO - 'tpaint', 11:10:26 INFO - 'sessionrestore', 11:10:26 INFO - 'sessionrestore_no_auto_restore', 11:10:26 INFO - 'tabpaint']}, 11:10:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:10:26 INFO - 'ts_paint', 11:10:26 INFO - 'tpaint', 11:10:26 INFO - 'sessionrestore', 11:10:26 INFO - 'sessionrestore_no_auto_restore', 11:10:26 INFO - 'tabpaint']}, 11:10:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:10:26 INFO - 'tests': ['a11yr', 11:10:26 INFO - 'ts_paint', 11:10:26 INFO - 'tpaint', 11:10:26 INFO - 'sessionrestore', 11:10:26 INFO - 'sessionrestore_no_auto_restore', 11:10:26 INFO - 'tabpaint']}, 11:10:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:10:26 INFO - 'tests': ['a11yr', 11:10:26 INFO - 'ts_paint', 11:10:26 INFO - 'tpaint', 11:10:26 INFO - 'sessionrestore', 11:10:26 INFO - 'sessionrestore_no_auto_restore', 11:10:26 INFO - 'tabpaint']}, 11:10:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:10:26 INFO - 'tests': ['tsvgx', 11:10:26 INFO - 'tsvgr_opacity', 11:10:26 INFO - 'tart', 11:10:26 INFO - 'tscrollx', 11:10:26 INFO - 'cart', 11:10:26 INFO - 'tsvg_static']}, 11:10:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:10:26 INFO - 'tsvgr_opacity', 11:10:26 INFO - 'tart', 11:10:26 INFO - 'tscrollx', 11:10:26 INFO - 'cart', 11:10:26 INFO - 'tsvg_static']}, 11:10:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:10:26 INFO - 'talos_options': ['--disable-e10s'], 11:10:26 INFO - 'tests': ['tp5o']}, 11:10:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:10:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:10:26 INFO - 'talos_options': ['--disable-e10s', 11:10:26 INFO - '--xperf_path', 11:10:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:10:26 INFO - 'tests': ['tp5n']}, 11:10:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:10:26 INFO - 'talos_options': ['--xperf_path', 11:10:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:10:26 INFO - 'tests': ['tp5n']}}, 11:10:26 INFO - 'talos.zip': {'path': '', 11:10:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:10:26 INFO - Running post-action listener: _resource_record_post_action 11:10:26 INFO - [mozharness: 2017-02-06 19:10:26.158286Z] Finished populate-webroot step (success) 11:10:26 INFO - [mozharness: 2017-02-06 19:10:26.158375Z] Running create-virtualenv step. 11:10:26 INFO - Running pre-action listener: _resource_record_pre_action 11:10:26 INFO - Running main action method: create_virtualenv 11:10:26 INFO - Creating virtualenv /builds/slave/test/build/venv 11:10:26 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 11:10:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:10:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:10:26 INFO - Using real prefix '/usr' 11:10:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:10:26 INFO - Installing distribute.............................................................................................................................................................................................done. 11:10:28 INFO - Installing pip.................done. 11:10:28 INFO - Return code: 0 11:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:10:28 INFO - Reading from file tmpfile_stdout 11:10:28 INFO - Output received: 11:10:28 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) 11:10:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c850>, '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 0x20816d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081b60>, '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': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', '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 11:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:10:28 INFO - Using env: {'DISPLAY': ':0', 11:10:28 INFO - 'HOME': '/home/cltbld', 11:10:28 INFO - 'LANG': 'en_US.UTF-8', 11:10:28 INFO - 'LANGUAGE': 'en_US:en', 11:10:28 INFO - 'LOGNAME': 'cltbld', 11:10:28 INFO - 'MAIL': '/var/mail/cltbld', 11:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:28 INFO - 'MOZ_NO_REMOTE': '1', 11:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:28 INFO - 'NO_EM_RESTART': '1', 11:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:28 INFO - 'PWD': '/builds/slave/test', 11:10:28 INFO - 'SHELL': '/bin/bash', 11:10:28 INFO - 'SHLVL': '1', 11:10:28 INFO - 'TERM': 'linux', 11:10:28 INFO - 'TMOUT': '86400', 11:10:28 INFO - 'USER': 'cltbld', 11:10:28 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', 11:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:28 INFO - '_': '/tools/buildbot/bin/python'} 11:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:29 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 11:10:29 INFO - Cleaning up... 11:10:29 INFO - Return code: 0 11:10:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:29 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c850>, '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 0x20816d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081b60>, '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': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', '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 11:10:29 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 11:10:29 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 11:10:29 INFO - Using env: {'DISPLAY': ':0', 11:10:29 INFO - 'HOME': '/home/cltbld', 11:10:29 INFO - 'LANG': 'en_US.UTF-8', 11:10:29 INFO - 'LANGUAGE': 'en_US:en', 11:10:29 INFO - 'LOGNAME': 'cltbld', 11:10:29 INFO - 'MAIL': '/var/mail/cltbld', 11:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:29 INFO - 'MOZ_NO_REMOTE': '1', 11:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:29 INFO - 'NO_EM_RESTART': '1', 11:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:29 INFO - 'PWD': '/builds/slave/test', 11:10:29 INFO - 'SHELL': '/bin/bash', 11:10:29 INFO - 'SHLVL': '1', 11:10:29 INFO - 'TERM': 'linux', 11:10:29 INFO - 'TMOUT': '86400', 11:10:29 INFO - 'USER': 'cltbld', 11:10:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', 11:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:29 INFO - '_': '/tools/buildbot/bin/python'} 11:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:29 INFO - Downloading/unpacking psutil>=3.1.1 11:10:29 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 11:10:29 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 11:10:29 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 11:10:29 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 11:10:29 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 11:10:29 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 11:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:10:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:10:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:10:31 INFO - Installing collected packages: psutil 11:10:31 INFO - Running setup.py install for psutil 11:10:31 INFO - building 'psutil._psutil_linux' extension 11:10:31 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 11:10:31 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 11:10:31 INFO - building 'psutil._psutil_posix' extension 11:10:31 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 11:10:31 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 11:10:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:10:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:10:31 INFO - Successfully installed psutil 11:10:31 INFO - Cleaning up... 11:10:32 INFO - Return code: 0 11:10:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:10:32 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')]} 11:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:32 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')]} 11:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:32 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c850>, '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 0x20816d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081b60>, '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': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', '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 11:10:32 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 11:10:32 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 11:10:32 INFO - Using env: {'DISPLAY': ':0', 11:10:32 INFO - 'HOME': '/home/cltbld', 11:10:32 INFO - 'LANG': 'en_US.UTF-8', 11:10:32 INFO - 'LANGUAGE': 'en_US:en', 11:10:32 INFO - 'LOGNAME': 'cltbld', 11:10:32 INFO - 'MAIL': '/var/mail/cltbld', 11:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:32 INFO - 'MOZ_NO_REMOTE': '1', 11:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:32 INFO - 'NO_EM_RESTART': '1', 11:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:32 INFO - 'PWD': '/builds/slave/test', 11:10:32 INFO - 'SHELL': '/bin/bash', 11:10:32 INFO - 'SHLVL': '1', 11:10:32 INFO - 'TERM': 'linux', 11:10:32 INFO - 'TMOUT': '86400', 11:10:32 INFO - 'USER': 'cltbld', 11:10:32 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', 11:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:32 INFO - '_': '/tools/buildbot/bin/python'} 11:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:10:32 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 11:10:32 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 11:10:32 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 11:10:32 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 11:10:32 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 11:10:32 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 11:10:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:10:34 INFO - Installing collected packages: mozsystemmonitor 11:10:34 INFO - Running setup.py install for mozsystemmonitor 11:10:34 INFO - Successfully installed mozsystemmonitor 11:10:34 INFO - Cleaning up... 11:10:34 INFO - Return code: 0 11:10:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:10: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')]} 11:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10: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')]} 11:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:34 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c850>, '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 0x20816d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081b60>, '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': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', '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 11:10:34 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 11:10:34 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 11:10:34 INFO - Using env: {'DISPLAY': ':0', 11:10:34 INFO - 'HOME': '/home/cltbld', 11:10:34 INFO - 'LANG': 'en_US.UTF-8', 11:10:34 INFO - 'LANGUAGE': 'en_US:en', 11:10:34 INFO - 'LOGNAME': 'cltbld', 11:10:34 INFO - 'MAIL': '/var/mail/cltbld', 11:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:34 INFO - 'MOZ_NO_REMOTE': '1', 11:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:34 INFO - 'NO_EM_RESTART': '1', 11:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:34 INFO - 'PWD': '/builds/slave/test', 11:10:34 INFO - 'SHELL': '/bin/bash', 11:10:34 INFO - 'SHLVL': '1', 11:10:34 INFO - 'TERM': 'linux', 11:10:34 INFO - 'TMOUT': '86400', 11:10:34 INFO - 'USER': 'cltbld', 11:10:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', 11:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:34 INFO - '_': '/tools/buildbot/bin/python'} 11:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:34 INFO - Downloading/unpacking jsonschema==2.5.1 11:10:34 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 11:10:34 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 11:10:34 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 11:10:34 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 11:10:34 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 11:10:34 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 11:11:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:11:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:11:07 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 11:11:07 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 11:11:07 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 11:11:07 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 11:11:07 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 11:11:07 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 11:11:07 INFO - Downloading functools32-3.2.3-2.tar.gz 11:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:11:08 INFO - warning: no files found matching '*.txt' 11:11:08 INFO - no previously-included directories found matching 'build' 11:11:08 INFO - no previously-included directories found matching 'dist' 11:11:08 INFO - no previously-included directories found matching '.git*' 11:11:08 INFO - Installing collected packages: jsonschema, functools32 11:11:08 INFO - Running setup.py install for functools32 11:11:08 INFO - warning: no files found matching '*.txt' 11:11:08 INFO - no previously-included directories found matching 'build' 11:11:08 INFO - no previously-included directories found matching 'dist' 11:11:08 INFO - no previously-included directories found matching '.git*' 11:11:08 INFO - Successfully installed jsonschema functools32 11:11:08 INFO - Cleaning up... 11:11:08 INFO - Return code: 0 11:11:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:11:08 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')]} 11:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:08 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')]} 11:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:08 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c850>, '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 0x20816d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081b60>, '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': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', '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 11:11:08 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 11:11:08 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 11:11:08 INFO - Using env: {'DISPLAY': ':0', 11:11:08 INFO - 'HOME': '/home/cltbld', 11:11:08 INFO - 'LANG': 'en_US.UTF-8', 11:11:08 INFO - 'LANGUAGE': 'en_US:en', 11:11:08 INFO - 'LOGNAME': 'cltbld', 11:11:08 INFO - 'MAIL': '/var/mail/cltbld', 11:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:08 INFO - 'MOZ_NO_REMOTE': '1', 11:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:08 INFO - 'NO_EM_RESTART': '1', 11:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:08 INFO - 'PWD': '/builds/slave/test', 11:11:08 INFO - 'SHELL': '/bin/bash', 11:11:08 INFO - 'SHLVL': '1', 11:11:08 INFO - 'TERM': 'linux', 11:11:08 INFO - 'TMOUT': '86400', 11:11:08 INFO - 'USER': 'cltbld', 11:11:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', 11:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:08 INFO - '_': '/tools/buildbot/bin/python'} 11:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:11:08 INFO - Cleaning up... 11:11:08 INFO - Return code: 0 11:11:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:11:08 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')]} 11:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:08 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')]} 11:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:08 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c850>, '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 0x20816d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081b60>, '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': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', '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 11:11:08 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 11:11:08 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 11:11:08 INFO - Using env: {'DISPLAY': ':0', 11:11:08 INFO - 'HOME': '/home/cltbld', 11:11:08 INFO - 'LANG': 'en_US.UTF-8', 11:11:08 INFO - 'LANGUAGE': 'en_US:en', 11:11:08 INFO - 'LOGNAME': 'cltbld', 11:11:08 INFO - 'MAIL': '/var/mail/cltbld', 11:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:08 INFO - 'MOZ_NO_REMOTE': '1', 11:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:08 INFO - 'NO_EM_RESTART': '1', 11:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:08 INFO - 'PWD': '/builds/slave/test', 11:11:08 INFO - 'SHELL': '/bin/bash', 11:11:08 INFO - 'SHLVL': '1', 11:11:08 INFO - 'TERM': 'linux', 11:11:08 INFO - 'TMOUT': '86400', 11:11:08 INFO - 'USER': 'cltbld', 11:11:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', 11:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:08 INFO - '_': '/tools/buildbot/bin/python'} 11:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:08 INFO - Downloading/unpacking blobuploader==1.2.4 11:11:08 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 11:11:08 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 11:11:08 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 11:11:08 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 11:11:08 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 11:11:08 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 11:11:10 INFO - Downloading blobuploader-1.2.4.tar.gz 11:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:11:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:11:10 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 11:11:10 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 11:11:10 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 11:11:10 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 11:11:10 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 11:11:10 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 11:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:11:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:11 INFO - Downloading docopt-0.6.1.tar.gz 11:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:11:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:11:11 INFO - Running setup.py install for blobuploader 11:11:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:11:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:11:11 INFO - Running setup.py install for requests 11:11:11 INFO - Running setup.py install for docopt 11:11:12 INFO - Successfully installed blobuploader requests docopt 11:11:12 INFO - Cleaning up... 11:11:12 INFO - Return code: 0 11:11:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:12 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')]} 11:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:12 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')]} 11:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:12 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c850>, '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 0x20816d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081b60>, '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': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', '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 11:11:12 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 11:11:12 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 11:11:12 INFO - Using env: {'DISPLAY': ':0', 11:11:12 INFO - 'HOME': '/home/cltbld', 11:11:12 INFO - 'LANG': 'en_US.UTF-8', 11:11:12 INFO - 'LANGUAGE': 'en_US:en', 11:11:12 INFO - 'LOGNAME': 'cltbld', 11:11:12 INFO - 'MAIL': '/var/mail/cltbld', 11:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:12 INFO - 'MOZ_NO_REMOTE': '1', 11:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:12 INFO - 'NO_EM_RESTART': '1', 11:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:12 INFO - 'PWD': '/builds/slave/test', 11:11:12 INFO - 'SHELL': '/bin/bash', 11:11:12 INFO - 'SHLVL': '1', 11:11:12 INFO - 'TERM': 'linux', 11:11:12 INFO - 'TMOUT': '86400', 11:11:12 INFO - 'USER': 'cltbld', 11:11:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', 11:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:12 INFO - '_': '/tools/buildbot/bin/python'} 11:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:12 INFO - Running setup.py (path:/tmp/pip-Vd4jsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:12 INFO - Running setup.py (path:/tmp/pip-JAyjvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:12 INFO - Running setup.py (path:/tmp/pip-voPvC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:11:12 INFO - Running setup.py (path:/tmp/pip-wVEqA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:11:12 INFO - Running setup.py (path:/tmp/pip-aJVZ2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:11:12 INFO - Running setup.py (path:/tmp/pip-1e9G_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:11:12 INFO - Running setup.py (path:/tmp/pip-Z8U16o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:11:12 INFO - Running setup.py (path:/tmp/pip-r_g97A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:12 INFO - Running setup.py (path:/tmp/pip-Mub5KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:13 INFO - Running setup.py (path:/tmp/pip-UgSIYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:13 INFO - Running setup.py (path:/tmp/pip-FhrOt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:13 INFO - Running setup.py (path:/tmp/pip-Isp4mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:13 INFO - Running setup.py (path:/tmp/pip-pnRk_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:13 INFO - Running setup.py (path:/tmp/pip-fCaCkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:13 INFO - Running setup.py (path:/tmp/pip-vOHfHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:13 INFO - Running setup.py (path:/tmp/pip-OWsQKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:13 INFO - Running setup.py (path:/tmp/pip-18ixsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:11:13 INFO - Running setup.py install for manifestparser 11:11:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:11:13 INFO - Running setup.py install for mozcrash 11:11:13 INFO - Running setup.py install for mozdebug 11:11:13 INFO - Running setup.py install for mozdevice 11:11:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:11:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:11:14 INFO - Running setup.py install for mozfile 11:11:14 INFO - Running setup.py install for mozhttpd 11:11:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:11:14 INFO - Running setup.py install for mozinfo 11:11:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:11:14 INFO - Running setup.py install for mozInstall 11:11:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:11:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:11:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:11:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:11:14 INFO - Running setup.py install for mozleak 11:11:14 INFO - Running setup.py install for mozlog 11:11:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:11:14 INFO - Running setup.py install for moznetwork 11:11:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:11:14 INFO - Running setup.py install for mozprocess 11:11:14 INFO - Running setup.py install for mozprofile 11:11:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:11:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:11:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:11:14 INFO - Running setup.py install for mozrunner 11:11:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:11:15 INFO - Running setup.py install for mozscreenshot 11:11:15 INFO - Running setup.py install for moztest 11:11:15 INFO - Running setup.py install for mozversion 11:11:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:11:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:11:15 INFO - Cleaning up... 11:11:15 INFO - Return code: 0 11:11:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:15 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c850>, '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 0x20816d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081b60>, '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': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', '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 11:11:15 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 11:11:15 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 11:11:15 INFO - Using env: {'DISPLAY': ':0', 11:11:15 INFO - 'HOME': '/home/cltbld', 11:11:15 INFO - 'LANG': 'en_US.UTF-8', 11:11:15 INFO - 'LANGUAGE': 'en_US:en', 11:11:15 INFO - 'LOGNAME': 'cltbld', 11:11:15 INFO - 'MAIL': '/var/mail/cltbld', 11:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:15 INFO - 'MOZ_NO_REMOTE': '1', 11:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:15 INFO - 'NO_EM_RESTART': '1', 11:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:15 INFO - 'PWD': '/builds/slave/test', 11:11:15 INFO - 'SHELL': '/bin/bash', 11:11:15 INFO - 'SHLVL': '1', 11:11:15 INFO - 'TERM': 'linux', 11:11:15 INFO - 'TMOUT': '86400', 11:11:15 INFO - 'USER': 'cltbld', 11:11:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', 11:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:15 INFO - '_': '/tools/buildbot/bin/python'} 11:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:15 INFO - Running setup.py (path:/tmp/pip-MtXqpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:15 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)) 11:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:15 INFO - Running setup.py (path:/tmp/pip-zgglic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:15 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)) 11:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:15 INFO - Running setup.py (path:/tmp/pip-5mUhbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:11:15 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)) 11:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:11:15 INFO - Running setup.py (path:/tmp/pip-oSvw0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:11:15 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)) 11:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:11:15 INFO - Running setup.py (path:/tmp/pip-1hey6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:11:15 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)) 11:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:11:15 INFO - Running setup.py (path:/tmp/pip-vuxMnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:11:16 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)) 11:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:11:16 INFO - Running setup.py (path:/tmp/pip-OebX6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:11:16 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)) 11:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:11:16 INFO - Running setup.py (path:/tmp/pip-7HUe2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:16 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)) 11:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:16 INFO - Running setup.py (path:/tmp/pip-05q2_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:16 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)) 11:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:16 INFO - Running setup.py (path:/tmp/pip-FAgPh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:16 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)) 11:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:16 INFO - Running setup.py (path:/tmp/pip-CXKdf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:16 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)) 11:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:16 INFO - Running setup.py (path:/tmp/pip-2sILMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:16 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)) 11:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:16 INFO - Running setup.py (path:/tmp/pip-wM_58i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:16 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)) 11:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:16 INFO - Running setup.py (path:/tmp/pip-HTc1cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:16 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)) 11:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:16 INFO - Running setup.py (path:/tmp/pip-573biw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:16 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)) 11:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:16 INFO - Running setup.py (path:/tmp/pip-N7JtGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:16 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)) 11:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:16 INFO - Running setup.py (path:/tmp/pip-_9ebI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:16 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)) 11:11:16 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)) 11:11:16 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)) 11:11:16 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)) 11:11:16 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)) 11:11:16 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)) 11:11:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:11:16 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 11:11:16 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 11:11:16 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 11:11:16 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 11:11:16 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 11:11:16 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 11:11:18 INFO - Downloading blessings-1.6.tar.gz 11:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:11:18 INFO - Installing collected packages: blessings 11:11:18 INFO - Running setup.py install for blessings 11:11:19 INFO - Successfully installed blessings 11:11:19 INFO - Cleaning up... 11:11:19 INFO - Return code: 0 11:11:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:11:19 INFO - Reading from file tmpfile_stdout 11:11:19 INFO - Current package versions: 11:11:19 INFO - argparse == 1.2.1 11:11:19 INFO - blessings == 1.6 11:11:19 INFO - blobuploader == 1.2.4 11:11:19 INFO - docopt == 0.6.1 11:11:19 INFO - functools32 == 3.2.3-2 11:11:19 INFO - jsonschema == 2.5.1 11:11:19 INFO - manifestparser == 1.1 11:11:19 INFO - mozInstall == 1.12 11:11:19 INFO - mozcrash == 1.0 11:11:19 INFO - mozdebug == 0.1 11:11:19 INFO - mozdevice == 0.49 11:11:19 INFO - mozfile == 1.2 11:11:19 INFO - mozhttpd == 0.7 11:11:19 INFO - mozinfo == 0.9 11:11:19 INFO - mozleak == 0.1 11:11:19 INFO - mozlog == 3.4 11:11:19 INFO - moznetwork == 0.27 11:11:19 INFO - mozprocess == 0.24 11:11:19 INFO - mozprofile == 0.28 11:11:19 INFO - mozrunner == 6.13 11:11:19 INFO - mozscreenshot == 0.1 11:11:19 INFO - mozsystemmonitor == 0.3 11:11:19 INFO - moztest == 0.8 11:11:19 INFO - mozversion == 1.4 11:11:19 INFO - psutil == 3.1.1 11:11:19 INFO - requests == 1.2.3 11:11:19 INFO - wsgiref == 0.1.2 11:11:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:19 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c850>, '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 0x20816d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081b60>, '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': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', '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 11:11:19 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 11:11:19 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 11:11:19 INFO - Using env: {'DISPLAY': ':0', 11:11:19 INFO - 'HOME': '/home/cltbld', 11:11:19 INFO - 'LANG': 'en_US.UTF-8', 11:11:19 INFO - 'LANGUAGE': 'en_US:en', 11:11:19 INFO - 'LOGNAME': 'cltbld', 11:11:19 INFO - 'MAIL': '/var/mail/cltbld', 11:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:19 INFO - 'MOZ_NO_REMOTE': '1', 11:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:19 INFO - 'NO_EM_RESTART': '1', 11:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:19 INFO - 'PWD': '/builds/slave/test', 11:11:19 INFO - 'SHELL': '/bin/bash', 11:11:19 INFO - 'SHLVL': '1', 11:11:19 INFO - 'TERM': 'linux', 11:11:19 INFO - 'TMOUT': '86400', 11:11:19 INFO - 'USER': 'cltbld', 11:11:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', 11:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:19 INFO - '_': '/tools/buildbot/bin/python'} 11:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:19 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)) 11:11:19 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)) 11:11:19 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)) 11:11:19 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)) 11:11:19 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)) 11:11:19 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)) 11:11:19 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)) 11:11:19 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)) 11:11:19 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)) 11:11:19 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)) 11:11:19 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)) 11:11:19 INFO - Cleaning up... 11:11:19 INFO - Return code: 0 11:11:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c850>, '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 0x20816d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081b60>, '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': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', '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 11:11:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:11:19 INFO - Using env: {'DISPLAY': ':0', 11:11:19 INFO - 'HOME': '/home/cltbld', 11:11:19 INFO - 'LANG': 'en_US.UTF-8', 11:11:19 INFO - 'LANGUAGE': 'en_US:en', 11:11:19 INFO - 'LOGNAME': 'cltbld', 11:11:19 INFO - 'MAIL': '/var/mail/cltbld', 11:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:19 INFO - 'MOZ_NO_REMOTE': '1', 11:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:19 INFO - 'NO_EM_RESTART': '1', 11:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:19 INFO - 'PWD': '/builds/slave/test', 11:11:19 INFO - 'SHELL': '/bin/bash', 11:11:19 INFO - 'SHLVL': '1', 11:11:19 INFO - 'TERM': 'linux', 11:11:19 INFO - 'TMOUT': '86400', 11:11:19 INFO - 'USER': 'cltbld', 11:11:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', 11:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:19 INFO - '_': '/tools/buildbot/bin/python'} 11:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:11:19 INFO - Cleaning up... 11:11:19 INFO - Return code: 0 11:11:19 INFO - Running post-action listener: _resource_record_post_action 11:11:19 INFO - Running post-action listener: _start_resource_monitoring 11:11:19 INFO - Starting resource monitoring. 11:11:19 INFO - [mozharness: 2017-02-06 19:11:19.811153Z] Finished create-virtualenv step (success) 11:11:19 INFO - [mozharness: 2017-02-06 19:11:19.811674Z] Running install step. 11:11:19 INFO - Running pre-action listener: _resource_record_pre_action 11:11:19 INFO - Running main action method: install 11:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:11:20 INFO - Reading from file tmpfile_stdout 11:11:20 INFO - Detecting whether we're running mozinstall >=1.0... 11:11:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:11:20 INFO - Reading from file tmpfile_stdout 11:11:20 INFO - Output received: 11:11:20 INFO - Usage: mozinstall [options] installer 11:11:20 INFO - Options: 11:11:20 INFO - -h, --help show this help message and exit 11:11:20 INFO - -d DEST, --destination=DEST 11:11:20 INFO - Directory to install application into. [default: 11:11:20 INFO - "/builds/slave/test"] 11:11:20 INFO - --app=APP Application being installed. [default: firefox] 11:11:20 INFO - mkdir: /builds/slave/test/build/application 11:11:20 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'] 11:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:11:36 INFO - Reading from file tmpfile_stdout 11:11:36 INFO - Output received: 11:11:36 INFO - /builds/slave/test/build/application/firefox/firefox 11:11:36 INFO - Running post-action listener: _resource_record_post_action 11:11:36 INFO - [mozharness: 2017-02-06 19:11:36.550119Z] Finished install step (success) 11:11:36 INFO - [mozharness: 2017-02-06 19:11:36.550393Z] Running run-tests step. 11:11:36 INFO - Running pre-action listener: _resource_record_pre_action 11:11:36 INFO - Running main action method: run_tests 11:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:11:36 INFO - Python 2.7.3 11:11:36 INFO - Return code: 0 11:11:36 INFO - grabbing minidump binary from tooltool 11:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:36 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 0x210c850>, '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 0x20816d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:11:36 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 11:11:36 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 11:11:36 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 11:11:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:11:36 INFO - Return code: 0 11:11:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:11:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:11:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:11:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:11:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 11:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 11:11:36 INFO - Using env: {'DISPLAY': ':0', 11:11:36 INFO - 'HOME': '/home/cltbld', 11:11:36 INFO - 'LANG': 'en_US.UTF-8', 11:11:36 INFO - 'LANGUAGE': 'en_US:en', 11:11:36 INFO - 'LOGNAME': 'cltbld', 11:11:36 INFO - 'MAIL': '/var/mail/cltbld', 11:11:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:11:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:36 INFO - 'MOZ_NO_REMOTE': '1', 11:11:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:36 INFO - 'NO_EM_RESTART': '1', 11:11:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:36 INFO - 'PWD': '/builds/slave/test', 11:11:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:11:36 INFO - 'SHELL': '/bin/bash', 11:11:36 INFO - 'SHLVL': '1', 11:11:36 INFO - 'TERM': 'linux', 11:11:36 INFO - 'TMOUT': '86400', 11:11:36 INFO - 'USER': 'cltbld', 11:11:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760', 11:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:36 INFO - '_': '/tools/buildbot/bin/python'} 11:11:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 11:11:36 INFO - mozversion application_buildid: 20170206181422 11:11:36 INFO - mozversion application_changeset: 05fae22830c0365b8173be4a2584ff0375b547a1 11:11:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:11:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:11:36 INFO - mozversion application_name: Firefox 11:11:36 INFO - mozversion application_remotingname: firefox-dev 11:11:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:11:36 INFO - mozversion application_vendor: Mozilla 11:11:36 INFO - mozversion application_version: 53.0a2 11:11:36 INFO - mozversion platform_buildid: 20170206181422 11:11:36 INFO - mozversion platform_changeset: 05fae22830c0365b8173be4a2584ff0375b547a1 11:11:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:11:36 INFO - mozversion platform_version: 53.0a2 11:11:36 INFO - using testdate: 1486408296 11:11:36 INFO - actual date: 1486408296 11:11:36 INFO - starting webserver on 'localhost:50930' 11:11:36 INFO - SUITE-START | Running 2 tests 11:11:36 INFO - TEST-START | dromaeo_css 11:11:36 INFO - operating with platform_type : linux_ 11:11:36 INFO - Initialising browser for dromaeo_css test... 11:11:36 INFO - TEST-INFO | started process 21786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmILmLN/profile http://localhost:50930/getInfo.html) 11:11:41 INFO - PROCESS | 21786 | __metrics Screen width/height:1600/1200 11:11:41 INFO - PROCESS | 21786 | colorDepth:24 11:11:41 INFO - PROCESS | 21786 | Browser inner width/height: 1024/697 11:11:41 INFO - PROCESS | 21786 | __metrics 11:11:42 INFO - PROCESS | 21786 | 1486408302286 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 11:11:42 INFO - PROCESS | 21786 | 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" 11:11:42 INFO - PROCESS | 21786 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:11:43 INFO - PROCESS | 21786 | console.error: PushService: 11:11:43 INFO - PROCESS | 21786 | stateChangeProcessEnqueue: Error transitioning state 11:11:43 INFO - PROCESS | 21786 | UnknownError 11:11:43 INFO - TEST-INFO | 21786: exit 0 11:11:43 INFO - Browser initialized. 11:11:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:11:43 INFO - TEST-INFO | started process 21878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmILmLN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:55 INFO - PROCESS | 21878 | RSS: Main: 141316096 11:11:55 INFO - PROCESS | 21878 | 11:14:56 INFO - PROCESS | 21878 | Cycle 1(1): loaded http://localhost:50930/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50930/tests/dromaeo/cssquery-ext.html) 11:14:57 INFO - PROCESS | 21878 | RSS: Main: 242139136 11:14:57 INFO - PROCESS | 21878 | 11:16:45 INFO - PROCESS | 21878 | ************************* 11:16:45 INFO - PROCESS | 21878 | A coding exception was thrown and uncaught in a Task. 11:16:45 INFO - PROCESS | 21878 | 11:16:45 ERROR - PROCESS | 21878 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:16:45 INFO - PROCESS | 21878 | Full stack: 11:16:45 INFO - PROCESS | 21878 | ************************* 11:17:59 INFO - PROCESS | 21878 | Cycle 1(1): loaded http://localhost:50930/tests/dromaeo/cssquery-ext.html (next: http://localhost:50930/tests/dromaeo/cssquery-jquery.html) 11:18:00 INFO - PROCESS | 21878 | RSS: Main: 229765120 11:18:00 INFO - PROCESS | 21878 | 11:21:02 INFO - PROCESS | 21878 | Cycle 1(1): loaded http://localhost:50930/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50930/tests/dromaeo/cssquery-mootools.html) 11:21:02 INFO - PROCESS | 21878 | RSS: Main: 202674176 11:21:02 INFO - PROCESS | 21878 | 11:24:04 INFO - PROCESS | 21878 | Cycle 1(1): loaded http://localhost:50930/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50930/tests/dromaeo/cssquery-prototype.html) 11:24:05 INFO - PROCESS | 21878 | RSS: Main: 214548480 11:24:05 INFO - PROCESS | 21878 | 11:27:07 INFO - PROCESS | 21878 | Cycle 1(1): loaded http://localhost:50930/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50930/tests/dromaeo/cssquery-yui.html) 11:27:08 INFO - PROCESS | 21878 | RSS: Main: 174669824 11:27:08 INFO - PROCESS | 21878 | 11:30:10 INFO - PROCESS | 21878 | Cycle 1(1): loaded http://localhost:50930/tests/dromaeo/cssquery-yui.html (next: http://localhost:50930/tests/dromaeo/cssquery-dojo.html) 11:30:11 INFO - PROCESS | 21878 | RSS: Main: 265371648 11:30:11 INFO - PROCESS | 21878 | 11:30:11 INFO - PROCESS | 21878 | __start_tp_report 11:30:11 INFO - PROCESS | 21878 | _x_x_mozilla_page_load 11:30:11 INFO - PROCESS | 21878 | _x_x_mozilla_page_load_details 11:30:11 INFO - PROCESS | 21878 | |i|pagename|runs| 11:30:11 INFO - PROCESS | 21878 | |0;dojo.html;3211.598550181226;3254.3653987472444;3263.3962716897377;3275.459549174386;3288.1615188127025;5405.18922161676;5474.917876231854;5491.066518691822;5492.533134683546;5503;5454;5476.616636835423;5484;5487.862803429916;5503.422140675231;4835.6131509479155;4902.264660300948;4933.260010998361;4957.826476073338;5005.749712514378;4861.246506791453;4923.138450771101;4984.526469985346;4993.201087825949;5011.599072074244;4842.080004799094;4867.853964381075;4892.217245240762;4907.6073914086965;4998.175301075336;4966.677165984218;4967.602591792666;5006.1489546776775;5006.2740902569285;5032.924506132411;4892.437369702494;4906.484819094015;4945.505449455061;4967.304577359173;4970.254461830755;5136.357955255593;5253.448387919251;5287.656302340336;5340.813071542478;5345.919811202796;5827.504662103726;5840.8247752567495;5843.8539036524;5849;5863.0325996211;5830.329512106077;5871.089981052901;5874.647521148745;5892.882142357129;5899.203607512974;5294.100002999461;5349.438308977579;5386.542143917772;5410.729463526808;5414.593905457106;5990.580659353804;5998.790042348497;6001.1898393717165;6006.069059295816;6018.15745795589;5723.570732195102;5731.8567035824435;5740.339860915965;5745.454181852718;5745.626534275259;5617.045102332613;5687.232223649837;5729.341125770507;5778.219940308005;5833.50415214703;5744.0522313817755;5790.942090579125;5799.217105690678;5816.12758086282;5832.416758324219;5791.247137872049;5793.420657934173;5795.246617939641;5796.5072968797285;5796.5072968797285;4435;4441.378207051015;4477.597016268552;4524.705894116872;4552.590266875997;4001.8799436016966;4030.556638769733;4048.4129801178665;4056.675465962716;4066.064805094845;5578.63738856973;5580.525655319262;5588.245586845724;5591.189277554813;5592.189132575753;5565.2486914266865;5669.829905102853;5775.335836378787;5794.507466865363;5816.767329306865;5565.3599836019375;5640.097584386561;5643.209950606918;5663.716814159276;5678.858028549319;5024.397072351341;5034.320366750515;5035.546800787946;5039.899202016012;5040.54635082837;5935.347111817697;5996.610220335664;6115.785947491817;6117.296510901214;6125.540584456184;5769.019266724583;5868.67722275279;5869.119632055226;5930.436608522184;5964.135200395832;6154.046122850965;6161.168242287234;6166.568340216142;6167.444929956326;6167.784127555694;5599.916001260066;5779.826605201851;5828.6211396259105;5840.2115714379715;5843.386444423274;5722.7710891563875;5786.161006653927;5793.102069179284;5817.738201781015;5900.586958913007;5679.630823996427;5687.573431992534;5733.483986441241;5734.455226753452;5738.971305143447;5714.628549144292;5723.942760572341;5728.484436400744;5731.942680573141;5733.71331433435;5522.171674248895;5526.889462210653;5646.576506762091;5704.743286552198;5705.144228365778;5783.19035335045;5792.102224155263;5792.82621521355;5803.506701930214;5809.651420914759;5668.603197776116;5669.773209071756;5673.631213971079;5674.148877668217;5677.74450149736 11:30:11 INFO - PROCESS | 21878 | |1;ext.html;560.9427740815172;580.2167074449494;610.5848023344125;629.3643420145652;652.3183273479214;38633.613663863354;48142.75928620357;49927.75036124819;49994.25008624864;50062.24906626395;52950.470495295034;53213.467865321334;53243.46756532433;53418.999999999905;53486.46513534863;9478.28912831537;9668.806623867518;9679.95160024199;9680.080392362714;9684.273679474032;9153.267738580898;9415;11359.659210223706;11617.361045142514;11630.185886987872;11693.064554835593;11798.174127811057;11802.173847830656;11809.881901181006;11810.645680629552;11710.238834475775;11758.470868810924;11784.646460606196;11791.174617776716;11793.469293881795;11635.883641163564;11700.356480393575;11708.53165873364;11712.648620541397;11713;48633.27050094251;49035.75482122602;49051.754741226425;49054.26418603724;49148.262776058385;4332.610065094125;4429.667774916894;4469.284914413678;4507.954920450819;4628.305754136873;32517.349653007044;32585;32763;32998.6700132998;33830.49254261188;4659.62722982164;4680.531946805327;4681.976590117028;4711.175544279738;4724.102420540086;350192;350383;352719;352982.99999999744;354328;63153.36846631475;63451.682741585995;63523.682381587794;63636.36363636304;63674.68162659249;65369;65637.34362656408;65686.67156664282;65757.34242657608;65801.67099164473;19274.80725192758;19787.40637780869;19880.304189353305;19881.701774473393;19895.403137905887;14056.508022219174;14415.135091894519;15456.149911754737;15547.144907030222;15549.533513994598;20267;20823.58352832935;20865.37403877886;20986.160553577687;20997.580048398948;7389.224131466119;7419.220981796833;7537.118384032227;7835.608219588998;7876;1000.5447521377756;1001.0190013786384;1004.3622299839508;1012.2003617142523;1013.3463915774431;35562.28875422477;35568.466473002925;35649.82175089108;35726;35986.820065899505;1103.9668809935715;1171.1626187276138;1184.4847491341122;1206.2882899089404;1219.878012198773;18601.125599460884;18695.439136825917;18701.90649046746;18964.43106706801;19037.714434283498;527535;532721;533223;533982;535678;71038.64480677563;71083;71641.64179179071;71721.64139179271;71739;1541.1215607104068;1575.3541048170196;1576.5664442278464;1584.4375246787456;1605.8153312368993;32555.34889302248;33850.661493385735;33997.66002339945;34348.31303373969;34368.82815585906;59757.701211493666;60309;60443.39556604378;60495;60633.69683151556;316104;316548;318516;318759;319208;28948.42103157967;29663.555046673886;30909.381812364078;31650;32522;53709;53794.462055380514;54373.18440223479;54718.45281547293;55289.17066243929;44687;45691;46087.308690369;46909;47688.2846757292;44014.139080959634;45305.77347113243;45345.55150936273;46367.07265854732;46591.534084660074;44175.77912110419;44646.3303050448;45130;45639.31541026953;45880.31179532243;37500;39295.41056884206;39869;40327.79836100918;40493.59506405016;29103;29195.41609167847;29671.55492667655;29705.702942970292;29738.70261297446 11:30:11 INFO - PROCESS | 21878 | |2;jquery.html;430.6748404954259;434.98384985591775;439.9406080179179;441.7062653335531;443.99112017759626;20151.193952241912;21001.894990525027;21800.3459896203;21967.780322196773;22027.22904698336;21648.2423115191;22548.774512254873;22569;22570.097196112176;22778.65832012521;5882.176495290662;6120.1125836753645;6123.632582045091;6127.5710700251;6129;6048.848778780522;6227.875442491148;6266.091416744569;6339.270983836848;6359.395857393541;6343.143675603804;6357.8410539736415;6363.204599425072;6366.586171898812;6786.253512113663;6920.619365934872;6957.9999999999745;6963.965180174117;6965.129358830146;6965.582065076112;6074.331823499411;6234.220722409699;6273.404026617464;6278.843028924268;6280.246370435531;15634.843651563453;15932.681346373123;23072.76927230723;25515.872420637963;25810.354741131436;2844.8008639395252;2893.1754449981863;2902.8548572571285;2936.9559456608167;2970.1980465274255;11316.755156932732;11549.556305461818;11699;13511.662208444868;15655.982361146604;2069.7102405663218;2125.9222969462244;2136.75427325858;2188.584169007899;2195.110980053081;71439.64280178618;74739.62630186815;74839.25160748378;85817.57091214503;95605;11538.94230528842;11903.285802851857;12042.87957120435;12788.616341509769;12792;17656.117194140243;17674.823251767317;17679.646407071785;17697.93812371236;17737.822621773874;9393.436393816257;9402.623895044258;9471.242300616072;9589.42463452181;9616.278779091595;9074.274058075338;9087.273018158532;9090.90909090914;9139.543022848831;9337.766555836159;5175.844724658266;5188.92216616751;5210.244514545369;5235.895282094413;5480.3971563128025;1948.133080779068;2001.6597178479694;2130.414136112581;2184.4429670433938;2201.1965632544325;954.9188318992824;966.709987003896;966.8259713251541;967.2068903499204;984.0946329376991;19805.801941980397;21093.578128437654;21183.576328473344;21371.67942480864;21429;1034.2036631793628;1084.8860869608736;1086.8315411111291;1106.3085571517802;1122.1920217443428;11293.322400655823;11320.830187547193;11497.482613282422;11593.362365070003;11595.652130436101;742720.145597085;743014;743083;772147;775917;85092;86317;108385.45807271071;109327.45336273267;109701.45149274362;518.5825410544472;1086.1310951239136;1127.2672762704308;1155.7341811383428;1169.1932566529067;11920.880791192323;12045.036397088386;12184.390780461119;12888.677783055498;13120.803187952379;45250.77374613106;46804.06391872212;46867.76566117148;46908.53091469042;48624;62342;66757.33242667705;66781;67875.66062169657;68727;9668.081532254424;9866.950665246628;9878.654247101316;9889.109980101824;9902.158316543175;11741.882581174079;14302.713945721236;14348.139111653334;14420.351084201026;14503.564893053226;12650.936745316214;12754.298513581842;12799.680007999503;12849.807252891027;12862.485500579873;12526.937365313115;12843.807342889677;12985.35073246315;12999.740005200032;13221.801672974721;12659.81010284828;13010.934945325213;13151.934240328737;13229.140105893086;13328.266945317713;9468.905310946802;9568.09103135201;9616;9758.804823903623;10062.195024397884;10017.849732253877;12230.87769122333;12475.438605262967;12613.49546018149;12948.899343555904 11:30:11 INFO - PROCESS | 21878 | |3;mootools.html;1462.122726364181;1467.9559613211607;1476.1438365747867;1499.3178103962705;1505.4429860951445;7995.720149794758;8428.873566896485;8444.155584441552;8452.408331416804;8477.15228477152;7443.478956473049;7686.192949740281;7988.800279993003;8075.232852878967;8132.390070744688;2384.3562238195677;2419.600765873629;2420.987895060522;2428.5021570577987;2431.7203521595065;2354.9411264718347;2410.8915098820507;2415.1909110448023;2423.09134074722;2423.6001059825107;2359.716833979925;2399.808015358767;2414.4808866093786;2429.016248419393;2440.036185706645;2292.381057114578;2292.8280378971644;2317.119494592061;2319.3273950554317;2325.267540724666;2298.023340080476;2327.3832434404894;2335.871527066011;2348.5302939412013;2349.6005679034606;8359.874601880976;8474.74575762728;8480.067192608809;8484.194001569902;8486.618102185417;5013;5143.202803565453;5147.382314122329;5147.639665223436;5148.922766158511;3224.5485632011537;3354.781939173946;3424.74314426419;3479.443289073736;3500.912477188065;1326.6948601821634;1335.6594068512563;1365.8907287417082;1365.9658508537266;1515.2802418851068;10989;11061.834072488919;11074.169437292236;11085.334879907312;11161.38612376319;4363.2800587903275;4398.142362239397;4551.931721024187;4581.106684196549;4615.3077038443835;9269.165775080275;9273.165415112673;9278.304127190488;9279.67521136757;9290.674826381179;5261.684298941999;5265.815696450606;5268.130758424893;5270.657407268515;5273.288106105627;4170.91658166835;4223.260929337353;4823.782929768169;4840.782164802592;4888.315635810989;4005.7796821174534;4006.5192176938954;4063.045184381668;4109.835606575703;4133.379993001014;1271.955481558141;1307.6730817295677;1312.0487646456243;1317.328162637062;1319.142557337719;997.3816233935007;1002.8796544414716;1016.6086056868011;1022.243539780572;1025.8512515685334;5508.20131080991;5666.376698563155;5788.450097240755;5937.346891841894;5996.190514280604;1041.338749893823;1064.4252103863982;1072.962446314391;1078.735709751116;1118.4722527088675;3729.4318147841946;3904.980475097663;3924.7645141291614;3947.6052394760295;3953.940690889639;9808.46053467052;10122.645707400206;10143.036411540892;10194.031567001122;10223.9488802557;9509.714708558755;9612.951935240279;9628.374155679858;9635.951820240994;9637.855432168522;7421.443391745641;7719.073711154698;7727.22727727234;7985.640646170937;8138.064122625974;5827.825165245049;5854.590178687451;5871.647701137946;5881.823545293477;5903.734331955158;8843.557822108998;8888;8958.552072396224;9019;9056.637734490547;9082;9161.633534658538;9280.95359523198;9308.162265396148;9319.16127548524;6765.357291057342;6971.930280697128;7133;7384.224656410999;7536.171021187555;7812.57030863308;8023.6790528378215;8044.2760151586635;8051.959740201261;8059.83880322402;7168.928310716826;7211.278872112747;7244.52910560833;7286.453515986428;7461.365783908212;6919.308069193041;7039.436845052486;7065.82335441618;7185.928140718526;7427.331540161412;6526.923057695427;6534.183227096613;6581.703823327866;6582.506312026521;6583.9465685490095;4935.309056731989;4994.200927851526;5080.187170052774;5091.465396133352;5115.028144652504;5040.546350828443;5090.440051594248;5141.61437892167;5199.4540573239265;5212.374515058217 11:30:11 INFO - PROCESS | 21878 | |4;prototype.html;394.1978074618153;408.62202462721973;410.525842651737;413.06234846897564;414.7428594271551;5253.8949221015555;5385.3268341457315;5429.91855122173;5494.560435165187;5521;5232.770298979737;5353.3843607985;5381.0852155133725;5389.760355118325;5420.756065977031;4257.254980378421;4262;4293.549177336366;4300.290452075412;4311.461067366579;4189.204051230272;4235.364695295715;4247.915041699164;4262.531121576624;4275.294576394891;4205.095904380558;4207.51613564441;4219.21944440278;4234.470691163605;4239.597238262376;4204.159168166364;4223.68322375823;4227.302495088337;4239.597238262391;4242.384854196155;3756.9248615027545;3820.923581528382;3831.5593706723525;3838.0404898775305;3843.442700808395;5265.605079619006;5278.102722537178;5281.445448227958;5301.867453313659;5308.124159513675;4984.127777638899;4992.650514463989;4995.55040046394;4997.275395067732;5004.873903371748;5515.4760297771645;5613.2422123013275;5649.745761440704;5687.601867869251;5693.914591281134;4278.315469524861;4280.122574872144;4280.785960701953;4287.421198138242;4288.678349123797;5848.736806843703;5881.294244690622;5886.470217680429;5889.352171261158;5893.734781934823;4287.892802679958;4362.280223763107;4415.889602759892;4427.247367947457;4427.75647339393;4354.824197466666;4425.601695847325;4428.73427594339;4456.665750068758;4459.308807134899;4895.853124406273;4918.8770280743265;4933.333999910038;4943.357363542788;4954.430240522314;5594.944050559442;5695.202671625976;5717.971410142923;5720.542356611461;5726.599138060379;1500.482333594908;1507.954761357161;1512.2060918018128;1516.354755090717;1522.6802371501888;1072.447689439939;1079.4494807648157;1090.8636420447444;1097.4403054442132;1109.5672687651822;5308.946910530845;5320.308359913264;5329.600279979017;5400.189971504227;5405.621606487587;5534.201384550037;5536.141898005815;5661.179129026351;5665.915011274834;5667.631603945731;5216.1393370094265;5300.867478312995;5319.840404787863;5353;5418.539424148913;3015.577819105327;3027.1826606816476;3027.5004624237195;3038.483457812177;3047.5733397323947;5582.162675598693;5875;5901.0558310670085;5936.00231882905;5959.672218027963;5617.943820561742;5662.971685141548;5724.797792463546;5734.397888221677;5756.740946657411;5836.766529338779;5850.4149585042005;5869;5875.178694604686;5875.853103672357;5566.693831839288;5617.719114044363;5629.915551266652;5800.796972105956;5854.619449735754;5798.246227990334;5811.186433899342;5811.593188476935;5816.3892791258;5835.387284335084;5786.334571524329;6041.33863187627;6074.66357401371;6087.147799308189;6095.3904609538695;4086.6322031017353;4171.83064806293;4189.371594260885;4196.139791342706;4230.196262710076;5746.913796292975;5755.5683323750045;5824.9417505826095;5826.184334193301;5832.754389560135;5654.840757644755;5699.5155411790465;5779.711014449176;5782.8434313136695;5782.913256301074;5660.660360378391;5663.915041274467;5678.290213723285;5687.630304030225;5717.485426311652;5677.602567820213;5684.545236381162;5697.487226149667;5701.287339082614;5717.599768016199;5480.123180291134;5646.209530665792;5666.546676265972;5684.839760890835;5739.512141467855;5572.60991730575;5586.85469478764;5624.943750562442;5635.562931452618;5638.37977822431 11:30:11 INFO - PROCESS | 21878 | |5;yui.html;789.4789438970281;791.8416316736655;820.4420993724269;912.9178373946344;928.7074571509974;16332.836671633295;17641.294348226056;17776.91111544442;17800.64398712025;17801.554961125978;14850.405983760664;14887.925560372183;14914.328855201515;14939.551813445587;14946;701.726326732576;705.0376236437278;810.5217921426357;810.8013536683492;820.3724151024471;828.747232094211;829.2246749289403;829.8423299573092;829.9543525106117;830.0703212402118;876.1151237250359;877.2192748453849;878.8901387326584;882.7042940614901;883.3860466975423;740.0564280542297;743.9516431431939;852.4544291653377;857.2970164465141;864.5029108262775;638.4286063972719;638.7828138432955;639.2871947778241;639.2967735490969;639.3414782773704;15447.768283475756;15976.201189940457;17079.231434585472;17254.223559939834;17256.482305530855;15303.770443443358;15457.536273911688;15804.367825286974;16104.275307611186;16105.597360065974;14183.71632567343;14279.78580321296;14358.928205358907;14380.496682616164;14552.199629020399;4643.071385722835;4666.556677115668;4685.554872287127;4687.789049492781;4868.586170175539;74141.25858741398;74440;75219.24780752177;75704.24295757027;76156;12117.575884843987;12258.938705306595;12342.568010119603;12412.069094817925;12418.379081046092;20278;20347.79652203459;20420.38738837837;20491.4877128073;20553.280635177995;8337.333013359039;8361.874571881426;8556.914430855737;8571.357148213909;8730.781730456662;4574.5425457453985;4590.380298659638;4630.259158534618;4663.090697313991;4696.483386827446;3307.5534802801794;3331.68349006844;3397.7451691123265;3398.966010339914;3401.48977653354;605.4308949587373;607.113614123376;611.669698362888;615.3999850146162;625.8904691678938;716.183550752143;727.6034561164179;732.5055587478431;783.8079670480769;798.2815466080574;10445.11216546587;10720.21142363221;11557.595484158182;11571.710707232387;11882.227655202385;726.4297526441718;776.6349815586665;786.598834594361;795.9283664470225;796;5375.139977603643;5458.399576046631;5512.944870551243;5530.972345138249;5545.1682247663175;80964;81814.59092704498;83534.16465835265;84634.57682711547;85140.06154030282;71397.2860271401;71523;71666.64166679133;71720.64139679268;72060;62839.99999999908;63616;64021.679891600244;64347.150491311324;65424.345756542774;10084.344517606332;10476.895231047592;10591.735206619896;10612;10700.357978521313;42570.93572660708;44332.556674432846;45258.09483810239;45688.31467527923;45742;53716.73141634423;55629.72185139048;57014.42985570091;57064;57306.42693573011;12438.253704777742;12522.436490358137;12563.12058155957;12967.935160324516;13097.869021310045;14113;14836.480723174636;15324.616884577528;15442.382304707686;15453.690926181638;15308;15867.127307998171;16052.518424447286;16791.496255112364;17027.7445838315;14090.859091409366;14912.179830109448;15048.774268386202;15364.923175384052;15429.845701542841;15150.16674082936;15389.84610153929;15871.444499442465;16385.42651007209;16389.754153687467;11951.641450756491;12058.879411205775;12163;12639.1784534005;12869.742605148032;11331.206815522833;11697.2981621103;11912.225705329125;11952.131712491417;12152.635420937386 11:30:11 INFO - PROCESS | 21878 | __end_tp_report 11:30:11 INFO - PROCESS | 21878 | __start_cc_report 11:30:11 INFO - PROCESS | 21878 | _x_x_mozilla_cycle_collect,925 11:30:11 INFO - PROCESS | 21878 | __end_cc_report 11:30:11 INFO - PROCESS | 21878 | __startTimestamp1486409411205__endTimestamp 11:30:11 INFO - PROCESS | 21878 | 11:30:11 INFO - PROCESS | 21878 | ------- Summary: start ------- 11:30:11 INFO - PROCESS | 21878 | Number of tests: 6 11:30:11 INFO - PROCESS | 21878 | 11:30:11 INFO - PROCESS | 21878 | [#0] dojo.html Cycles:165 Average:5426.61 Median:5669.83 stddev:606.95 (10.7%) stddev-sans-first:583.41 11:30:11 INFO - PROCESS | 21878 | Values: 3211.6 3254.4 3263.4 3275.5 3288.2 5405.2 5474.9 5491.1 5492.5 5503.0 5454.0 5476.6 5484.0 5487.9 5503.4 4835.6 4902.3 4933.3 4957.8 5005.7 4861.2 4923.1 4984.5 4993.2 5011.6 4842.1 4867.9 4892.2 4907.6 4998.2 4966.7 4967.6 5006.1 5006.3 5032.9 4892.4 4906.5 4945.5 4967.3 4970.3 5136.4 5253.4 5287.7 5340.8 5345.9 5827.5 5840.8 5843.9 5849.0 5863.0 5830.3 5871.1 5874.6 5892.9 5899.2 5294.1 5349.4 5386.5 5410.7 5414.6 5990.6 5998.8 6001.2 6006.1 6018.2 5723.6 5731.9 5740.3 5745.5 5745.6 5617.0 5687.2 5729.3 5778.2 5833.5 5744.1 5790.9 5799.2 5816.1 5832.4 5791.2 5793.4 5795.2 5796.5 5796.5 4435.0 4441.4 4477.6 4524.7 4552.6 4001.9 4030.6 4048.4 4056.7 4066.1 5578.6 5580.5 5588.2 5591.2 5592.2 5565.2 5669.8 5775.3 5794.5 5816.8 5565.4 5640.1 5643.2 5663.7 5678.9 5024.4 5034.3 5035.5 5039.9 5040.5 5935.3 5996.6 6115.8 6117.3 6125.5 5769.0 5868.7 5869.1 5930.4 5964.1 6154.0 6161.2 6166.6 6167.4 6167.8 5599.9 5779.8 5828.6 5840.2 5843.4 5722.8 5786.2 5793.1 5817.7 5900.6 5679.6 5687.6 5733.5 5734.5 5739.0 5714.6 5723.9 5728.5 5731.9 5733.7 5522.2 5526.9 5646.6 5704.7 5705.1 5783.2 5792.1 5792.8 5803.5 5809.7 5668.6 5669.8 5673.6 5674.1 5677.7 11:30:11 INFO - PROCESS | 21878 | 11:30:11 INFO - PROCESS | 21878 | [#1] ext.html Cycles:180 Average:59929.81 Median:39582.21 stddev:108597.35 (274.4%) stddev-sans-first:108810.51 11:30:11 INFO - PROCESS | 21878 | Values: 560.9 580.2 610.6 629.4 652.3 38633.6 48142.8 49927.8 49994.3 50062.2 52950.5 53213.5 53243.5 53419.0 53486.5 9478.3 9668.8 9680.0 9680.1 9684.3 9153.3 9415.0 11359.7 11617.4 11630.2 11693.1 11798.2 11802.2 11809.9 11810.6 11710.2 11758.5 11784.6 11791.2 11793.5 11635.9 11700.4 11708.5 11712.6 11713.0 48633.3 49035.8 49051.8 49054.3 49148.3 4332.6 4429.7 4469.3 4508.0 4628.3 32517.3 32585.0 32763.0 32998.7 33830.5 4659.6 4680.5 4682.0 4711.2 4724.1 350192.0 350383.0 352719.0 352983.0 354328.0 63153.4 63451.7 63523.7 63636.4 63674.7 65369.0 65637.3 65686.7 65757.3 65801.7 19274.8 19787.4 19880.3 19881.7 19895.4 14056.5 14415.1 15456.1 15547.1 15549.5 20267.0 20823.6 20865.4 20986.2 20997.6 7389.2 7419.2 7537.1 7835.6 7876.0 1000.5 1001.0 1004.4 1012.2 1013.3 35562.3 35568.5 35649.8 35726.0 35986.8 1104.0 1171.2 1184.5 1206.3 1219.9 18601.1 18695.4 18701.9 18964.4 19037.7 527535.0 532721.0 533223.0 533982.0 535678.0 71038.6 71083.0 71641.6 71721.6 71739.0 1541.1 1575.4 1576.6 1584.4 1605.8 32555.3 33850.7 33997.7 34348.3 34368.8 59757.7 60309.0 60443.4 60495.0 60633.7 316104.0 316548.0 318516.0 318759.0 319208.0 28948.4 29663.6 30909.4 31650.0 32522.0 53709.0 53794.5 54373.2 54718.5 55289.2 44687.0 45691.0 46087.3 46909.0 47688.3 44014.1 45305.8 45345.6 46367.1 46591.5 44175.8 44646.3 45130.0 45639.3 45880.3 37500.0 39295.4 39869.0 40327.8 40493.6 29103.0 29195.4 29671.6 29705.7 29738.7 11:30:11 INFO - PROCESS | 21878 | 11:30:11 INFO - PROCESS | 21878 | [#2] jquery.html Cycles:180 Average:37563.12 Median:24294.32 stddev:123671.21 (509.1%) stddev-sans-first:123986.71 11:30:11 INFO - PROCESS | 21878 | Values: 430.7 435.0 439.9 441.7 444.0 20151.2 21001.9 21800.3 21967.8 22027.2 21648.2 22548.8 22569.0 22570.1 22778.7 5882.2 6120.1 6123.6 6127.6 6129.0 6048.8 6227.9 6266.1 6339.3 6359.4 6343.1 6357.8 6363.2 6366.6 6786.3 6920.6 6958.0 6964.0 6965.1 6965.6 6074.3 6234.2 6273.4 6278.8 6280.2 15634.8 15932.7 23072.8 25515.9 25810.4 2844.8 2893.2 2902.9 2937.0 2970.2 11316.8 11549.6 11699.0 13511.7 15656.0 2069.7 2125.9 2136.8 2188.6 2195.1 71439.6 74739.6 74839.3 85817.6 95605.0 11538.9 11903.3 12042.9 12788.6 12792.0 17656.1 17674.8 17679.6 17697.9 17737.8 9393.4 9402.6 9471.2 9589.4 9616.3 9074.3 9087.3 9090.9 9139.5 9337.8 5175.8 5188.9 5210.2 5235.9 5480.4 1948.1 2001.7 2130.4 2184.4 2201.2 954.9 966.7 966.8 967.2 984.1 19805.8 21093.6 21183.6 21371.7 21429.0 1034.2 1084.9 1086.8 1106.3 1122.2 11293.3 11320.8 11497.5 11593.4 11595.7 742720.1 743014.0 743083.0 772147.0 775917.0 85092.0 86317.0 108385.5 109327.5 109701.5 518.6 1086.1 1127.3 1155.7 1169.2 11920.9 12045.0 12184.4 12888.7 13120.8 45250.8 46804.1 46867.8 46908.5 48624.0 62342.0 66757.3 66781.0 67875.7 68727.0 9668.1 9867.0 9878.7 9889.1 9902.2 11741.9 14302.7 14348.1 14420.4 14503.6 12650.9 12754.3 12799.7 12849.8 12862.5 12526.9 12843.8 12985.4 12999.7 13221.8 12659.8 13010.9 13151.9 13229.1 13328.3 9468.9 9568.1 9616.0 9758.8 10062.2 10017.8 12230.9 12475.4 12613.5 12948.9 11:30:11 INFO - PROCESS | 21878 | 11:30:11 INFO - PROCESS | 21878 | [#3] mootools.html Cycles:180 Average:5489.72 Median:5128.32 stddev:2915.59 (56.9%) stddev-sans-first:2908.06 11:30:11 INFO - PROCESS | 21878 | Values: 1462.1 1468.0 1476.1 1499.3 1505.4 7995.7 8428.9 8444.2 8452.4 8477.2 7443.5 7686.2 7988.8 8075.2 8132.4 2384.4 2419.6 2421.0 2428.5 2431.7 2354.9 2410.9 2415.2 2423.1 2423.6 2359.7 2399.8 2414.5 2429.0 2440.0 2292.4 2292.8 2317.1 2319.3 2325.3 2298.0 2327.4 2335.9 2348.5 2349.6 8359.9 8474.7 8480.1 8484.2 8486.6 5013.0 5143.2 5147.4 5147.6 5148.9 3224.5 3354.8 3424.7 3479.4 3500.9 1326.7 1335.7 1365.9 1366.0 1515.3 10989.0 11061.8 11074.2 11085.3 11161.4 4363.3 4398.1 4551.9 4581.1 4615.3 9269.2 9273.2 9278.3 9279.7 9290.7 5261.7 5265.8 5268.1 5270.7 5273.3 4170.9 4223.3 4823.8 4840.8 4888.3 4005.8 4006.5 4063.0 4109.8 4133.4 1272.0 1307.7 1312.0 1317.3 1319.1 997.4 1002.9 1016.6 1022.2 1025.9 5508.2 5666.4 5788.5 5937.3 5996.2 1041.3 1064.4 1073.0 1078.7 1118.5 3729.4 3905.0 3924.8 3947.6 3953.9 9808.5 10122.6 10143.0 10194.0 10223.9 9509.7 9613.0 9628.4 9636.0 9637.9 7421.4 7719.1 7727.2 7985.6 8138.1 5827.8 5854.6 5871.6 5881.8 5903.7 8843.6 8888.0 8958.6 9019.0 9056.6 9082.0 9161.6 9281.0 9308.2 9319.2 6765.4 6971.9 7133.0 7384.2 7536.2 7812.6 8023.7 8044.3 8052.0 8059.8 7168.9 7211.3 7244.5 7286.5 7461.4 6919.3 7039.4 7065.8 7185.9 7427.3 6526.9 6534.2 6581.7 6582.5 6583.9 4935.3 4994.2 5080.2 5091.5 5115.0 5040.5 5090.4 5141.6 5199.5 5212.4 11:30:11 INFO - PROCESS | 21878 | 11:30:11 INFO - PROCESS | 21878 | [#4] prototype.html Cycles:180 Average:4796.76 Median:5383.21 stddev:1361.05 (25.3%) stddev-sans-first:1324.15 11:30:11 INFO - PROCESS | 21878 | Values: 394.2 408.6 410.5 413.1 414.7 5253.9 5385.3 5429.9 5494.6 5521.0 5232.8 5353.4 5381.1 5389.8 5420.8 4257.3 4262.0 4293.5 4300.3 4311.5 4189.2 4235.4 4247.9 4262.5 4275.3 4205.1 4207.5 4219.2 4234.5 4239.6 4204.2 4223.7 4227.3 4239.6 4242.4 3756.9 3820.9 3831.6 3838.0 3843.4 5265.6 5278.1 5281.4 5301.9 5308.1 4984.1 4992.7 4995.6 4997.3 5004.9 5515.5 5613.2 5649.7 5687.6 5693.9 4278.3 4280.1 4280.8 4287.4 4288.7 5848.7 5881.3 5886.5 5889.4 5893.7 4287.9 4362.3 4415.9 4427.2 4427.8 4354.8 4425.6 4428.7 4456.7 4459.3 4895.9 4918.9 4933.3 4943.4 4954.4 5594.9 5695.2 5718.0 5720.5 5726.6 1500.5 1508.0 1512.2 1516.4 1522.7 1072.4 1079.4 1090.9 1097.4 1109.6 5308.9 5320.3 5329.6 5400.2 5405.6 5534.2 5536.1 5661.2 5665.9 5667.6 5216.1 5300.9 5319.8 5353.0 5418.5 3015.6 3027.2 3027.5 3038.5 3047.6 5582.2 5875.0 5901.1 5936.0 5959.7 5617.9 5663.0 5724.8 5734.4 5756.7 5836.8 5850.4 5869.0 5875.2 5875.9 5566.7 5617.7 5629.9 5800.8 5854.6 5798.2 5811.2 5811.6 5816.4 5835.4 5786.3 6041.3 6074.7 6087.1 6095.4 4086.6 4171.8 4189.4 4196.1 4230.2 5746.9 5755.6 5824.9 5826.2 5832.8 5654.8 5699.5 5779.7 5782.8 5782.9 5660.7 5663.9 5678.3 5687.6 5717.5 5677.6 5684.5 5697.5 5701.3 5717.6 5480.1 5646.2 5666.5 5684.8 5739.5 5572.6 5586.9 5624.9 5635.6 5638.4 11:30:11 INFO - PROCESS | 21878 | 11:30:11 INFO - PROCESS | 21878 | [#5] yui.html Cycles:180 Average:18361.65 Median:25166.19 stddev:22717.72 (90.3%) stddev-sans-first:22743.13 11:30:11 INFO - PROCESS | 21878 | Values: 789.5 791.8 820.4 912.9 928.7 16332.8 17641.3 17776.9 17800.6 17801.6 14850.4 14887.9 14914.3 14939.6 14946.0 701.7 705.0 810.5 810.8 820.4 828.7 829.2 829.8 830.0 830.1 876.1 877.2 878.9 882.7 883.4 740.1 744.0 852.5 857.3 864.5 638.4 638.8 639.3 639.3 639.3 15447.8 15976.2 17079.2 17254.2 17256.5 15303.8 15457.5 15804.4 16104.3 16105.6 14183.7 14279.8 14358.9 14380.5 14552.2 4643.1 4666.6 4685.6 4687.8 4868.6 74141.3 74440.0 75219.2 75704.2 76156.0 12117.6 12258.9 12342.6 12412.1 12418.4 20278.0 20347.8 20420.4 20491.5 20553.3 8337.3 8361.9 8556.9 8571.4 8730.8 4574.5 4590.4 4630.3 4663.1 4696.5 3307.6 3331.7 3397.7 3399.0 3401.5 605.4 607.1 611.7 615.4 625.9 716.2 727.6 732.5 783.8 798.3 10445.1 10720.2 11557.6 11571.7 11882.2 726.4 776.6 786.6 795.9 796.0 5375.1 5458.4 5512.9 5531.0 5545.2 80964.0 81814.6 83534.2 84634.6 85140.1 71397.3 71523.0 71666.6 71720.6 72060.0 62840.0 63616.0 64021.7 64347.2 65424.3 10084.3 10476.9 10591.7 10612.0 10700.4 42570.9 44332.6 45258.1 45688.3 45742.0 53716.7 55629.7 57014.4 57064.0 57306.4 12438.3 12522.4 12563.1 12967.9 13097.9 14113.0 14836.5 15324.6 15442.4 15453.7 15308.0 15867.1 16052.5 16791.5 17027.7 14090.9 14912.2 15048.8 15364.9 15429.8 15150.2 15389.8 15871.4 16385.4 16389.8 11951.6 12058.9 12163.0 12639.2 12869.7 11331.2 11697.3 11912.2 11952.1 12152.6 11:30:11 INFO - PROCESS | 21878 | -------- Summary: end -------- 11:30:11 INFO - PROCESS | 21878 | 11:30:12 INFO - TEST-INFO | 21878: exit 0 11:30:12 INFO - TEST-OK | dromaeo_css | took 1115186ms 11:30:12 INFO - TEST-START | kraken 11:30:12 INFO - operating with platform_type : linux_ 11:30:12 INFO - Initialising browser for kraken test... 11:30:12 INFO - TEST-INFO | started process 22196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWDdOF8/profile http://localhost:50930/getInfo.html) 11:30:16 INFO - PROCESS | 22196 | __metrics Screen width/height:1600/1200 11:30:16 INFO - PROCESS | 22196 | colorDepth:24 11:30:16 INFO - PROCESS | 22196 | Browser inner width/height: 1024/697 11:30:16 INFO - PROCESS | 22196 | __metrics 11:30:17 INFO - PROCESS | 22196 | 1486409417329 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 11:30:17 INFO - PROCESS | 22196 | 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" 11:30:17 INFO - PROCESS | 22196 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:30:18 INFO - PROCESS | 22196 | console.error: PushService: 11:30:18 INFO - PROCESS | 22196 | stateChangeProcessEnqueue: Error transitioning state 11:30:18 INFO - PROCESS | 22196 | UnknownError 11:30:18 INFO - TEST-INFO | 22196: exit 0 11:30:18 INFO - Browser initialized. 11:30:18 INFO - Running cycle 1/1 for kraken test... 11:30:18 INFO - TEST-INFO | started process 22287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWDdOF8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:30:30 INFO - PROCESS | 22287 | RSS: Main: 138330112 11:30:30 INFO - PROCESS | 22287 | 11:30:33 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50930/tests/kraken/driver.html?testName=audio-beat-detection) 11:30:33 INFO - PROCESS | 22287 | RSS: Main: 182480896 11:30:33 INFO - PROCESS | 22287 | 11:30:36 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50930/tests/kraken/driver.html?testName=audio-dft) 11:30:37 INFO - PROCESS | 22287 | RSS: Main: 172183552 11:30:37 INFO - PROCESS | 22287 | 11:30:39 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50930/tests/kraken/driver.html?testName=audio-fft) 11:30:40 INFO - PROCESS | 22287 | RSS: Main: 263700480 11:30:40 INFO - PROCESS | 22287 | 11:30:42 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50930/tests/kraken/driver.html?testName=audio-oscillator) 11:30:43 INFO - PROCESS | 22287 | RSS: Main: 169852928 11:30:43 INFO - PROCESS | 22287 | 11:30:45 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50930/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:30:45 INFO - PROCESS | 22287 | RSS: Main: 172564480 11:30:45 INFO - PROCESS | 22287 | 11:30:48 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50930/tests/kraken/driver.html?testName=imaging-darkroom) 11:30:49 INFO - PROCESS | 22287 | RSS: Main: 211382272 11:30:49 INFO - PROCESS | 22287 | 11:30:52 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50930/tests/kraken/driver.html?testName=imaging-desaturate) 11:30:53 INFO - PROCESS | 22287 | RSS: Main: 209408000 11:30:53 INFO - PROCESS | 22287 | 11:30:56 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50930/tests/kraken/driver.html?testName=json-parse-financial) 11:30:56 INFO - PROCESS | 22287 | RSS: Main: 207814656 11:30:56 INFO - PROCESS | 22287 | 11:30:58 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50930/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:30:58 INFO - PROCESS | 22287 | RSS: Main: 170283008 11:30:58 INFO - PROCESS | 22287 | 11:31:00 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50930/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:31:01 INFO - PROCESS | 22287 | RSS: Main: 177725440 11:31:01 INFO - PROCESS | 22287 | 11:31:03 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50930/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:31:03 INFO - PROCESS | 22287 | RSS: Main: 187146240 11:31:03 INFO - PROCESS | 22287 | 11:31:06 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50930/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:31:06 INFO - PROCESS | 22287 | RSS: Main: 196255744 11:31:06 INFO - PROCESS | 22287 | 11:31:09 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50930/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:31:10 INFO - PROCESS | 22287 | RSS: Main: 192610304 11:31:10 INFO - PROCESS | 22287 | 11:31:11 INFO - PROCESS | 22287 | Cycle 1(1): loaded http://localhost:50930/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50930/tests/kraken/driver.html?testName=ai-astar) 11:31:12 INFO - PROCESS | 22287 | RSS: Main: 245043200 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | __start_tp_report 11:31:12 INFO - PROCESS | 22287 | _x_x_mozilla_page_load 11:31:12 INFO - PROCESS | 22287 | _x_x_mozilla_page_load_details 11:31:12 INFO - PROCESS | 22287 | |i|pagename|runs| 11:31:12 INFO - PROCESS | 22287 | |0;ai-astar;111;112;111;110;113;111;110;112;111;110 11:31:12 INFO - PROCESS | 22287 | |1;audio-beat-detection;146;118;115;150;118;118;118;117;141;122 11:31:12 INFO - PROCESS | 22287 | |2;audio-dft;160;160;160;160;160;161;159;160;160;161 11:31:12 INFO - PROCESS | 22287 | |3;audio-fft;73;74;76;106;76;75;75;75;91;74 11:31:12 INFO - PROCESS | 22287 | |4;audio-oscillator;81;82;99;83;81;82;95;82;82;108 11:31:12 INFO - PROCESS | 22287 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;117;117;118 11:31:12 INFO - PROCESS | 22287 | |6;imaging-darkroom;146;147;147;146;147;147;147;148;146;146 11:31:12 INFO - PROCESS | 22287 | |7;imaging-desaturate;95;95;95;96;96;96;95;96;96;95 11:31:12 INFO - PROCESS | 22287 | |8;json-parse-financial;50;50;50;49;49;51;51;49;48;50 11:31:12 INFO - PROCESS | 22287 | |9;json-stringify-tinderbox;65;65;65;64;64;64;65;66;64;65 11:31:12 INFO - PROCESS | 22287 | |10;stanford-crypto-aes;75;77;75;76;79;76;75;89;76;75 11:31:12 INFO - PROCESS | 22287 | |11;stanford-crypto-ccm;125;124;138;126;126;120;119;118;173;128 11:31:12 INFO - PROCESS | 22287 | |12;stanford-crypto-pbkdf2;161;154;162;158;156;157;157;159;162;158 11:31:12 INFO - PROCESS | 22287 | |13;stanford-crypto-sha256-iterative;61;59;59;62;59;61;61;60;59;61 11:31:12 INFO - PROCESS | 22287 | __end_tp_report 11:31:12 INFO - PROCESS | 22287 | __start_cc_report 11:31:12 INFO - PROCESS | 22287 | _x_x_mozilla_cycle_collect,1526 11:31:12 INFO - PROCESS | 22287 | __end_cc_report 11:31:12 INFO - PROCESS | 22287 | __startTimestamp1486409472107__endTimestamp 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | ------- Summary: start ------- 11:31:12 INFO - PROCESS | 22287 | Number of tests: 14 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:0.99 (0.9%) stddev-sans-first:1.05 11:31:12 INFO - PROCESS | 22287 | Values: 111.0 112.0 111.0 110.0 113.0 111.0 110.0 112.0 111.0 110.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:120.00 stddev:13.64 (11.4%) stddev-sans-first:12.46 11:31:12 INFO - PROCESS | 22287 | Values: 146.0 118.0 115.0 150.0 118.0 118.0 118.0 117.0 141.0 122.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:31:12 INFO - PROCESS | 22287 | Values: 160.0 160.0 160.0 160.0 160.0 161.0 159.0 160.0 160.0 161.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#3] audio-fft Cycles:10 Average:79.50 Median:75.00 stddev:10.66 (14.2%) stddev-sans-first:11.04 11:31:12 INFO - PROCESS | 22287 | Values: 73.0 74.0 76.0 106.0 76.0 75.0 75.0 75.0 91.0 74.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#4] audio-oscillator Cycles:10 Average:87.50 Median:82.00 stddev:9.63 (11.7%) stddev-sans-first:9.92 11:31:12 INFO - PROCESS | 22287 | Values: 81.0 82.0 99.0 83.0 81.0 82.0 95.0 82.0 82.0 108.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:31:12 INFO - PROCESS | 22287 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 11:31:12 INFO - PROCESS | 22287 | Values: 146.0 147.0 147.0 146.0 147.0 147.0 147.0 148.0 146.0 146.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:31:12 INFO - PROCESS | 22287 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#8] json-parse-financial Cycles:10 Average:49.70 Median:50.00 stddev:0.95 (1.9%) stddev-sans-first:1.00 11:31:12 INFO - PROCESS | 22287 | Values: 50.0 50.0 50.0 49.0 49.0 51.0 51.0 49.0 48.0 50.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 11:31:12 INFO - PROCESS | 22287 | Values: 65.0 65.0 65.0 64.0 64.0 64.0 65.0 66.0 64.0 65.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:76.00 stddev:4.30 (5.7%) stddev-sans-first:4.48 11:31:12 INFO - PROCESS | 22287 | Values: 75.0 77.0 75.0 76.0 79.0 76.0 75.0 89.0 76.0 75.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:126.00 stddev:16.24 (12.9%) stddev-sans-first:17.14 11:31:12 INFO - PROCESS | 22287 | Values: 125.0 124.0 138.0 126.0 126.0 120.0 119.0 118.0 173.0 128.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.50 stddev:2.63 (1.7%) stddev-sans-first:2.62 11:31:12 INFO - PROCESS | 22287 | Values: 161.0 154.0 162.0 158.0 156.0 157.0 157.0 159.0 162.0 158.0 11:31:12 INFO - PROCESS | 22287 | 11:31:12 INFO - PROCESS | 22287 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.20 Median:61.00 stddev:1.14 (1.9%) stddev-sans-first:1.17 11:31:12 INFO - PROCESS | 22287 | Values: 61.0 59.0 59.0 62.0 59.0 61.0 61.0 60.0 59.0 61.0 11:31:12 INFO - PROCESS | 22287 | -------- Summary: end -------- 11:31:12 INFO - PROCESS | 22287 | 11:31:13 INFO - TEST-INFO | 22287: exit 0 11:31:13 INFO - TEST-OK | kraken | took 61197ms 11:31:13 INFO - SUITE-END | took 1176s 11:31:13 INFO - Completed test suite (00:19:36) 11:31:13 INFO - javascript benchmark 11:31:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3211.598550181226, 3254.3653987472444, 3263.3962716897377, 3275.459549174386, 3288.1615188127025, 5405.18922161676, 5474.917876231854, 5491.066518691822, 5492.533134683546, 5503.0, 5454.0, 5476.616636835423, 5484.0, 5487.862803429916, 5503.422140675231, 4835.6131509479155, 4902.264660300948, 4933.260010998361, 4957.826476073338, 5005.749712514378, 4861.246506791453, 4923.138450771101, 4984.526469985346, 4993.201087825949, 5011.599072074244, 4842.080004799094, 4867.853964381075, 4892.217245240762, 4907.6073914086965, 4998.175301075336, 4966.677165984218, 4967.602591792666, 5006.1489546776775, 5006.2740902569285, 5032.924506132411, 4892.437369702494, 4906.484819094015, 4945.505449455061, 4967.304577359173, 4970.254461830755, 5136.357955255593, 5253.448387919251, 5287.656302340336, 5340.813071542478, 5345.919811202796, 5827.504662103726, 5840.8247752567495, 5843.8539036524, 5849.0, 5863.0325996211, 5830.329512106077, 5871.089981052901, 5874.647521148745, 5892.882142357129, 5899.203607512974, 5294.100002999461, 5349.438308977579, 5386.542143917772, 5410.729463526808, 5414.593905457106, 5990.580659353804, 5998.790042348497, 6001.1898393717165, 6006.069059295816, 6018.15745795589, 5723.570732195102, 5731.8567035824435, 5740.339860915965, 5745.454181852718, 5745.626534275259, 5617.045102332613, 5687.232223649837, 5729.341125770507, 5778.219940308005, 5833.50415214703, 5744.0522313817755, 5790.942090579125, 5799.217105690678, 5816.12758086282, 5832.416758324219, 5791.247137872049, 5793.420657934173, 5795.246617939641, 5796.5072968797285, 5796.5072968797285, 4435.0, 4441.378207051015, 4477.597016268552, 4524.705894116872, 4552.590266875997, 4001.8799436016966, 4030.556638769733, 4048.4129801178665, 4056.675465962716, 4066.064805094845, 5578.63738856973, 5580.525655319262, 5588.245586845724, 5591.189277554813, 5592.189132575753, 5565.2486914266865, 5669.829905102853, 5775.335836378787, 5794.507466865363, 5816.767329306865, 5565.3599836019375, 5640.097584386561, 5643.209950606918, 5663.716814159276, 5678.858028549319, 5024.397072351341, 5034.320366750515, 5035.546800787946, 5039.899202016012, 5040.54635082837, 5935.347111817697, 5996.610220335664, 6115.785947491817, 6117.296510901214, 6125.540584456184, 5769.019266724583, 5868.67722275279, 5869.119632055226, 5930.436608522184, 5964.135200395832, 6154.046122850965, 6161.168242287234, 6166.568340216142, 6167.444929956326, 6167.784127555694, 5599.916001260066, 5779.826605201851, 5828.6211396259105, 5840.2115714379715, 5843.386444423274, 5722.7710891563875, 5786.161006653927, 5793.102069179284, 5817.738201781015, 5900.586958913007, 5679.630823996427, 5687.573431992534, 5733.483986441241, 5734.455226753452, 5738.971305143447, 5714.628549144292, 5723.942760572341, 5728.484436400744, 5731.942680573141, 5733.71331433435, 5522.171674248895, 5526.889462210653, 5646.576506762091, 5704.743286552198, 5705.144228365778, 5783.19035335045, 5792.102224155263, 5792.82621521355, 5803.506701930214, 5809.651420914759, 5668.603197776116, 5669.773209071756, 5673.631213971079, 5674.148877668217, 5677.74450149736], "value": 5386.965252354987, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.9427740815172, 580.2167074449494, 610.5848023344125, 629.3643420145652, 652.3183273479214, 38633.613663863354, 48142.75928620357, 49927.75036124819, 49994.25008624864, 50062.24906626395, 52950.470495295034, 53213.467865321334, 53243.46756532433, 53418.999999999905, 53486.46513534863, 9478.28912831537, 9668.806623867518, 9679.95160024199, 9680.080392362714, 9684.273679474032, 9153.267738580898, 9415.0, 11359.659210223706, 11617.361045142514, 11630.185886987872, 11693.064554835593, 11798.174127811057, 11802.173847830656, 11809.881901181006, 11810.645680629552, 11710.238834475775, 11758.470868810924, 11784.646460606196, 11791.174617776716, 11793.469293881795, 11635.883641163564, 11700.356480393575, 11708.53165873364, 11712.648620541397, 11713.0, 48633.27050094251, 49035.75482122602, 49051.754741226425, 49054.26418603724, 49148.262776058385, 4332.610065094125, 4429.667774916894, 4469.284914413678, 4507.954920450819, 4628.305754136873, 32517.349653007044, 32585.0, 32763.0, 32998.6700132998, 33830.49254261188, 4659.62722982164, 4680.531946805327, 4681.976590117028, 4711.175544279738, 4724.102420540086, 350192.0, 350383.0, 352719.0, 352982.99999999744, 354328.0, 63153.36846631475, 63451.682741585995, 63523.682381587794, 63636.36363636304, 63674.68162659249, 65369.0, 65637.34362656408, 65686.67156664282, 65757.34242657608, 65801.67099164473, 19274.80725192758, 19787.40637780869, 19880.304189353305, 19881.701774473393, 19895.403137905887, 14056.508022219174, 14415.135091894519, 15456.149911754737, 15547.144907030222, 15549.533513994598, 20267.0, 20823.58352832935, 20865.37403877886, 20986.160553577687, 20997.580048398948, 7389.224131466119, 7419.220981796833, 7537.118384032227, 7835.608219588998, 7876.0, 1000.5447521377756, 1001.0190013786384, 1004.3622299839508, 1012.2003617142523, 1013.3463915774431, 35562.28875422477, 35568.466473002925, 35649.82175089108, 35726.0, 35986.820065899505, 1103.9668809935715, 1171.1626187276138, 1184.4847491341122, 1206.2882899089404, 1219.878012198773, 18601.125599460884, 18695.439136825917, 18701.90649046746, 18964.43106706801, 19037.714434283498, 527535.0, 532721.0, 533223.0, 533982.0, 535678.0, 71038.64480677563, 71083.0, 71641.64179179071, 71721.64139179271, 71739.0, 1541.1215607104068, 1575.3541048170196, 1576.5664442278464, 1584.4375246787456, 1605.8153312368993, 32555.34889302248, 33850.661493385735, 33997.66002339945, 34348.31303373969, 34368.82815585906, 59757.701211493666, 60309.0, 60443.39556604378, 60495.0, 60633.69683151556, 316104.0, 316548.0, 318516.0, 318759.0, 319208.0, 28948.42103157967, 29663.555046673886, 30909.381812364078, 31650.0, 32522.0, 53709.0, 53794.462055380514, 54373.18440223479, 54718.45281547293, 55289.17066243929, 44687.0, 45691.0, 46087.308690369, 46909.0, 47688.2846757292, 44014.139080959634, 45305.77347113243, 45345.55150936273, 46367.07265854732, 46591.534084660074, 44175.77912110419, 44646.3303050448, 45130.0, 45639.31541026953, 45880.31179532243, 37500.0, 39295.41056884206, 39869.0, 40327.79836100918, 40493.59506405016, 29103.0, 29195.41609167847, 29671.55492667655, 29705.702942970292, 29738.70261297446], "value": 22289.01146401065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.6748404954259, 434.98384985591775, 439.9406080179179, 441.7062653335531, 443.99112017759626, 20151.193952241912, 21001.894990525027, 21800.3459896203, 21967.780322196773, 22027.22904698336, 21648.2423115191, 22548.774512254873, 22569.0, 22570.097196112176, 22778.65832012521, 5882.176495290662, 6120.1125836753645, 6123.632582045091, 6127.5710700251, 6129.0, 6048.848778780522, 6227.875442491148, 6266.091416744569, 6339.270983836848, 6359.395857393541, 6343.143675603804, 6357.8410539736415, 6363.204599425072, 6366.586171898812, 6786.253512113663, 6920.619365934872, 6957.9999999999745, 6963.965180174117, 6965.129358830146, 6965.582065076112, 6074.331823499411, 6234.220722409699, 6273.404026617464, 6278.843028924268, 6280.246370435531, 15634.843651563453, 15932.681346373123, 23072.76927230723, 25515.872420637963, 25810.354741131436, 2844.8008639395252, 2893.1754449981863, 2902.8548572571285, 2936.9559456608167, 2970.1980465274255, 11316.755156932732, 11549.556305461818, 11699.0, 13511.662208444868, 15655.982361146604, 2069.7102405663218, 2125.9222969462244, 2136.75427325858, 2188.584169007899, 2195.110980053081, 71439.64280178618, 74739.62630186815, 74839.25160748378, 85817.57091214503, 95605.0, 11538.94230528842, 11903.285802851857, 12042.87957120435, 12788.616341509769, 12792.0, 17656.117194140243, 17674.823251767317, 17679.646407071785, 17697.93812371236, 17737.822621773874, 9393.436393816257, 9402.623895044258, 9471.242300616072, 9589.42463452181, 9616.278779091595, 9074.274058075338, 9087.273018158532, 9090.90909090914, 9139.543022848831, 9337.766555836159, 5175.844724658266, 5188.92216616751, 5210.244514545369, 5235.895282094413, 5480.3971563128025, 1948.133080779068, 2001.6597178479694, 2130.414136112581, 2184.4429670433938, 2201.1965632544325, 954.9188318992824, 966.709987003896, 966.8259713251541, 967.2068903499204, 984.0946329376991, 19805.801941980397, 21093.578128437654, 21183.576328473344, 21371.67942480864, 21429.0, 1034.2036631793628, 1084.8860869608736, 1086.8315411111291, 1106.3085571517802, 1122.1920217443428, 11293.322400655823, 11320.830187547193, 11497.482613282422, 11593.362365070003, 11595.652130436101, 742720.145597085, 743014.0, 743083.0, 772147.0, 775917.0, 85092.0, 86317.0, 108385.45807271071, 109327.45336273267, 109701.45149274362, 518.5825410544472, 1086.1310951239136, 1127.2672762704308, 1155.7341811383428, 1169.1932566529067, 11920.880791192323, 12045.036397088386, 12184.390780461119, 12888.677783055498, 13120.803187952379, 45250.77374613106, 46804.06391872212, 46867.76566117148, 46908.53091469042, 48624.0, 62342.0, 66757.33242667705, 66781.0, 67875.66062169657, 68727.0, 9668.081532254424, 9866.950665246628, 9878.654247101316, 9889.109980101824, 9902.158316543175, 11741.882581174079, 14302.713945721236, 14348.139111653334, 14420.351084201026, 14503.564893053226, 12650.936745316214, 12754.298513581842, 12799.680007999503, 12849.807252891027, 12862.485500579873, 12526.937365313115, 12843.807342889677, 12985.35073246315, 12999.740005200032, 13221.801672974721, 12659.81010284828, 13010.934945325213, 13151.934240328737, 13229.140105893086, 13328.266945317713, 9468.905310946802, 9568.09103135201, 9616.0, 9758.804823903623, 10062.195024397884, 10017.849732253877, 12230.87769122333, 12475.438605262967, 12613.49546018149, 12948.899343555904], "value": 10133.681760848422, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.122726364181, 1467.9559613211607, 1476.1438365747867, 1499.3178103962705, 1505.4429860951445, 7995.720149794758, 8428.873566896485, 8444.155584441552, 8452.408331416804, 8477.15228477152, 7443.478956473049, 7686.192949740281, 7988.800279993003, 8075.232852878967, 8132.390070744688, 2384.3562238195677, 2419.600765873629, 2420.987895060522, 2428.5021570577987, 2431.7203521595065, 2354.9411264718347, 2410.8915098820507, 2415.1909110448023, 2423.09134074722, 2423.6001059825107, 2359.716833979925, 2399.808015358767, 2414.4808866093786, 2429.016248419393, 2440.036185706645, 2292.381057114578, 2292.8280378971644, 2317.119494592061, 2319.3273950554317, 2325.267540724666, 2298.023340080476, 2327.3832434404894, 2335.871527066011, 2348.5302939412013, 2349.6005679034606, 8359.874601880976, 8474.74575762728, 8480.067192608809, 8484.194001569902, 8486.618102185417, 5013.0, 5143.202803565453, 5147.382314122329, 5147.639665223436, 5148.922766158511, 3224.5485632011537, 3354.781939173946, 3424.74314426419, 3479.443289073736, 3500.912477188065, 1326.6948601821634, 1335.6594068512563, 1365.8907287417082, 1365.9658508537266, 1515.2802418851068, 10989.0, 11061.834072488919, 11074.169437292236, 11085.334879907312, 11161.38612376319, 4363.2800587903275, 4398.142362239397, 4551.931721024187, 4581.106684196549, 4615.3077038443835, 9269.165775080275, 9273.165415112673, 9278.304127190488, 9279.67521136757, 9290.674826381179, 5261.684298941999, 5265.815696450606, 5268.130758424893, 5270.657407268515, 5273.288106105627, 4170.91658166835, 4223.260929337353, 4823.782929768169, 4840.782164802592, 4888.315635810989, 4005.7796821174534, 4006.5192176938954, 4063.045184381668, 4109.835606575703, 4133.379993001014, 1271.955481558141, 1307.6730817295677, 1312.0487646456243, 1317.328162637062, 1319.142557337719, 997.3816233935007, 1002.8796544414716, 1016.6086056868011, 1022.243539780572, 1025.8512515685334, 5508.20131080991, 5666.376698563155, 5788.450097240755, 5937.346891841894, 5996.190514280604, 1041.338749893823, 1064.4252103863982, 1072.962446314391, 1078.735709751116, 1118.4722527088675, 3729.4318147841946, 3904.980475097663, 3924.7645141291614, 3947.6052394760295, 3953.940690889639, 9808.46053467052, 10122.645707400206, 10143.036411540892, 10194.031567001122, 10223.9488802557, 9509.714708558755, 9612.951935240279, 9628.374155679858, 9635.951820240994, 9637.855432168522, 7421.443391745641, 7719.073711154698, 7727.22727727234, 7985.640646170937, 8138.064122625974, 5827.825165245049, 5854.590178687451, 5871.647701137946, 5881.823545293477, 5903.734331955158, 8843.557822108998, 8888.0, 8958.552072396224, 9019.0, 9056.637734490547, 9082.0, 9161.633534658538, 9280.95359523198, 9308.162265396148, 9319.16127548524, 6765.357291057342, 6971.930280697128, 7133.0, 7384.224656410999, 7536.171021187555, 7812.57030863308, 8023.6790528378215, 8044.2760151586635, 8051.959740201261, 8059.83880322402, 7168.928310716826, 7211.278872112747, 7244.52910560833, 7286.453515986428, 7461.365783908212, 6919.308069193041, 7039.436845052486, 7065.82335441618, 7185.928140718526, 7427.331540161412, 6526.923057695427, 6534.183227096613, 6581.703823327866, 6582.506312026521, 6583.9465685490095, 4935.309056731989, 4994.200927851526, 5080.187170052774, 5091.465396133352, 5115.028144652504, 5040.546350828443, 5090.440051594248, 5141.61437892167, 5199.4540573239265, 5212.374515058217], "value": 4525.865048374668, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.1978074618153, 408.62202462721973, 410.525842651737, 413.06234846897564, 414.7428594271551, 5253.8949221015555, 5385.3268341457315, 5429.91855122173, 5494.560435165187, 5521.0, 5232.770298979737, 5353.3843607985, 5381.0852155133725, 5389.760355118325, 5420.756065977031, 4257.254980378421, 4262.0, 4293.549177336366, 4300.290452075412, 4311.461067366579, 4189.204051230272, 4235.364695295715, 4247.915041699164, 4262.531121576624, 4275.294576394891, 4205.095904380558, 4207.51613564441, 4219.21944440278, 4234.470691163605, 4239.597238262376, 4204.159168166364, 4223.68322375823, 4227.302495088337, 4239.597238262391, 4242.384854196155, 3756.9248615027545, 3820.923581528382, 3831.5593706723525, 3838.0404898775305, 3843.442700808395, 5265.605079619006, 5278.102722537178, 5281.445448227958, 5301.867453313659, 5308.124159513675, 4984.127777638899, 4992.650514463989, 4995.55040046394, 4997.275395067732, 5004.873903371748, 5515.4760297771645, 5613.2422123013275, 5649.745761440704, 5687.601867869251, 5693.914591281134, 4278.315469524861, 4280.122574872144, 4280.785960701953, 4287.421198138242, 4288.678349123797, 5848.736806843703, 5881.294244690622, 5886.470217680429, 5889.352171261158, 5893.734781934823, 4287.892802679958, 4362.280223763107, 4415.889602759892, 4427.247367947457, 4427.75647339393, 4354.824197466666, 4425.601695847325, 4428.73427594339, 4456.665750068758, 4459.308807134899, 4895.853124406273, 4918.8770280743265, 4933.333999910038, 4943.357363542788, 4954.430240522314, 5594.944050559442, 5695.202671625976, 5717.971410142923, 5720.542356611461, 5726.599138060379, 1500.482333594908, 1507.954761357161, 1512.2060918018128, 1516.354755090717, 1522.6802371501888, 1072.447689439939, 1079.4494807648157, 1090.8636420447444, 1097.4403054442132, 1109.5672687651822, 5308.946910530845, 5320.308359913264, 5329.600279979017, 5400.189971504227, 5405.621606487587, 5534.201384550037, 5536.141898005815, 5661.179129026351, 5665.915011274834, 5667.631603945731, 5216.1393370094265, 5300.867478312995, 5319.840404787863, 5353.0, 5418.539424148913, 3015.577819105327, 3027.1826606816476, 3027.5004624237195, 3038.483457812177, 3047.5733397323947, 5582.162675598693, 5875.0, 5901.0558310670085, 5936.00231882905, 5959.672218027963, 5617.943820561742, 5662.971685141548, 5724.797792463546, 5734.397888221677, 5756.740946657411, 5836.766529338779, 5850.4149585042005, 5869.0, 5875.178694604686, 5875.853103672357, 5566.693831839288, 5617.719114044363, 5629.915551266652, 5800.796972105956, 5854.619449735754, 5798.246227990334, 5811.186433899342, 5811.593188476935, 5816.3892791258, 5835.387284335084, 5786.334571524329, 6041.33863187627, 6074.66357401371, 6087.147799308189, 6095.3904609538695, 4086.6322031017353, 4171.83064806293, 4189.371594260885, 4196.139791342706, 4230.196262710076, 5746.913796292975, 5755.5683323750045, 5824.9417505826095, 5826.184334193301, 5832.754389560135, 5654.840757644755, 5699.5155411790465, 5779.711014449176, 5782.8434313136695, 5782.913256301074, 5660.660360378391, 5663.915041274467, 5678.290213723285, 5687.630304030225, 5717.485426311652, 5677.602567820213, 5684.545236381162, 5697.487226149667, 5701.287339082614, 5717.599768016199, 5480.123180291134, 5646.209530665792, 5666.546676265972, 5684.839760890835, 5739.512141467855, 5572.60991730575, 5586.85469478764, 5624.943750562442, 5635.562931452618, 5638.37977822431], "value": 4388.358534415833, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.4789438970281, 791.8416316736655, 820.4420993724269, 912.9178373946344, 928.7074571509974, 16332.836671633295, 17641.294348226056, 17776.91111544442, 17800.64398712025, 17801.554961125978, 14850.405983760664, 14887.925560372183, 14914.328855201515, 14939.551813445587, 14946.0, 701.726326732576, 705.0376236437278, 810.5217921426357, 810.8013536683492, 820.3724151024471, 828.747232094211, 829.2246749289403, 829.8423299573092, 829.9543525106117, 830.0703212402118, 876.1151237250359, 877.2192748453849, 878.8901387326584, 882.7042940614901, 883.3860466975423, 740.0564280542297, 743.9516431431939, 852.4544291653377, 857.2970164465141, 864.5029108262775, 638.4286063972719, 638.7828138432955, 639.2871947778241, 639.2967735490969, 639.3414782773704, 15447.768283475756, 15976.201189940457, 17079.231434585472, 17254.223559939834, 17256.482305530855, 15303.770443443358, 15457.536273911688, 15804.367825286974, 16104.275307611186, 16105.597360065974, 14183.71632567343, 14279.78580321296, 14358.928205358907, 14380.496682616164, 14552.199629020399, 4643.071385722835, 4666.556677115668, 4685.554872287127, 4687.789049492781, 4868.586170175539, 74141.25858741398, 74440.0, 75219.24780752177, 75704.24295757027, 76156.0, 12117.575884843987, 12258.938705306595, 12342.568010119603, 12412.069094817925, 12418.379081046092, 20278.0, 20347.79652203459, 20420.38738837837, 20491.4877128073, 20553.280635177995, 8337.333013359039, 8361.874571881426, 8556.914430855737, 8571.357148213909, 8730.781730456662, 4574.5425457453985, 4590.380298659638, 4630.259158534618, 4663.090697313991, 4696.483386827446, 3307.5534802801794, 3331.68349006844, 3397.7451691123265, 3398.966010339914, 3401.48977653354, 605.4308949587373, 607.113614123376, 611.669698362888, 615.3999850146162, 625.8904691678938, 716.183550752143, 727.6034561164179, 732.5055587478431, 783.8079670480769, 798.2815466080574, 10445.11216546587, 10720.21142363221, 11557.595484158182, 11571.710707232387, 11882.227655202385, 726.4297526441718, 776.6349815586665, 786.598834594361, 795.9283664470225, 796.0, 5375.139977603643, 5458.399576046631, 5512.944870551243, 5530.972345138249, 5545.1682247663175, 80964.0, 81814.59092704498, 83534.16465835265, 84634.57682711547, 85140.06154030282, 71397.2860271401, 71523.0, 71666.64166679133, 71720.64139679268, 72060.0, 62839.99999999908, 63616.0, 64021.679891600244, 64347.150491311324, 65424.345756542774, 10084.344517606332, 10476.895231047592, 10591.735206619896, 10612.0, 10700.357978521313, 42570.93572660708, 44332.556674432846, 45258.09483810239, 45688.31467527923, 45742.0, 53716.73141634423, 55629.72185139048, 57014.42985570091, 57064.0, 57306.42693573011, 12438.253704777742, 12522.436490358137, 12563.12058155957, 12967.935160324516, 13097.869021310045, 14113.0, 14836.480723174636, 15324.616884577528, 15442.382304707686, 15453.690926181638, 15308.0, 15867.127307998171, 16052.518424447286, 16791.496255112364, 17027.7445838315, 14090.859091409366, 14912.179830109448, 15048.774268386202, 15364.923175384052, 15429.845701542841, 15150.16674082936, 15389.84610153929, 15871.444499442465, 16385.42651007209, 16389.754153687467, 11951.641450756491, 12058.879411205775, 12163.0, 12639.1784534005, 12869.742605148032, 11331.206815522833, 11697.2981621103, 11912.225705329125, 11952.131712491417, 12152.635420937386], "value": 7661.465638281015, "unit": "score"}], "name": "dromaeo_css", "value": 7549.668257608344, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 110.0, 113.0, 111.0, 110.0, 112.0, 111.0, 110.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 115.0, 150.0, 118.0, 118.0, 118.0, 117.0, 141.0, 122.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 159.0, 160.0, 160.0, 161.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 76.0, 106.0, 76.0, 75.0, 75.0, 75.0, 91.0, 74.0], "value": 79.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 99.0, 83.0, 81.0, 82.0, 95.0, 82.0, 82.0, 108.0], "value": 87.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 49.0, 49.0, 51.0, 51.0, 49.0, 48.0, 50.0], "value": 49.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 66.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 76.0, 79.0, 76.0, 75.0, 89.0, 76.0, 75.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 138.0, 126.0, 126.0, 120.0, 119.0, 118.0, 173.0, 128.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 154.0, 162.0, 158.0, 156.0, 157.0, 157.0, 159.0, 162.0, 158.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 62.0, 59.0, 61.0, 61.0, 60.0, 59.0, 61.0], "value": 60.2, "unit": "score"}], "name": "kraken", "value": 1464.1000000000001, "alertThreshold": 2.0}]} 11:31:13 INFO - Return code: 0 11:31:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:31:13 ERROR - # TBPL SUCCESS # 11:31:13 INFO - Running post-action listener: _resource_record_post_action 11:31:13 INFO - [mozharness: 2017-02-06 19:31:13.438886Z] Finished run-tests step (success) 11:31:13 INFO - Running post-run listener: _resource_record_post_run 11:31:13 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250408960; Read time: 20; Write time: 539576 11:31:13 INFO - TinderboxPrint: CPU usage
13.0% 11:31:13 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 20 11:31:13 INFO - TinderboxPrint: I/O write bytes / time
250,408,960 / 539,576 11:31:13 INFO - TinderboxPrint: CPU idle
8,279.6 (86.9%) 11:31:13 INFO - TinderboxPrint: CPU user
1,192.6 (12.5%) 11:31:13 INFO - TinderboxPrint: Swap in / out
0 / 0 11:31:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 430080; Read time: 0; Write time: 136 11:31:13 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248803328; Read time: 20; Write time: 539380 11:31:14 INFO - Running post-run listener: _upload_blobber_files 11:31:14 INFO - Blob upload gear active. 11:31:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:31:14 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 11:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:31:14 INFO - (blobuploader) - INFO - Open directory for files ... 11:31:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:31:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:31:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:15 INFO - (blobuploader) - INFO - Done attempting. 11:31:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:31:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:31:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:18 INFO - (blobuploader) - INFO - Done attempting. 11:31:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:31:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:31:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:19 INFO - (blobuploader) - INFO - Done attempting. 11:31:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:31:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:31:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:21 INFO - (blobuploader) - INFO - Done attempting. 11:31:21 INFO - (blobuploader) - INFO - Iteration through files over. 11:31:21 INFO - Return code: 0 11:31:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:31:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:31:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/988cbfeba4d44a825f3a5fd16753db5241671c565af4c5212f739d27f542686a3c4a9c5121dccbf44e7bf72bd01453bb2320dc6db6847b91f15d81846b384075", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2435a2acb50850c960bb528f1c3464218014198987d0d71d4fbf9c130da9f2db8ee2fc858b1db0382577add44ec2484715eaca6bdbf1e738ef3172962dd718f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53ac7d91cf6c781f929e76ae3c43f7b9785add58a8055967920eababfe8088390483568146a7775ac7e54593ebf40b46ffae4e74fb9ac8cefa47ec3d523e3ad3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/baecdc3aa5cbe1fc56de07297a9d0ab382f04935dba3e52591157d87739abcaa5c2117717f7ff4a662077bc8e53c74104105f5391d75d8c7e848d29ab5b1dc60"} 11:31:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:31:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:31:21 INFO - Contents: 11:31:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/988cbfeba4d44a825f3a5fd16753db5241671c565af4c5212f739d27f542686a3c4a9c5121dccbf44e7bf72bd01453bb2320dc6db6847b91f15d81846b384075", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2435a2acb50850c960bb528f1c3464218014198987d0d71d4fbf9c130da9f2db8ee2fc858b1db0382577add44ec2484715eaca6bdbf1e738ef3172962dd718f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53ac7d91cf6c781f929e76ae3c43f7b9785add58a8055967920eababfe8088390483568146a7775ac7e54593ebf40b46ffae4e74fb9ac8cefa47ec3d523e3ad3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/baecdc3aa5cbe1fc56de07297a9d0ab382f04935dba3e52591157d87739abcaa5c2117717f7ff4a662077bc8e53c74104105f5391d75d8c7e848d29ab5b1dc60"} 11:31:21 INFO - Running post-run listener: copy_logs_to_upload_dir 11:31:21 INFO - Copying logs to upload dir... 11:31:21 INFO - mkdir: /builds/slave/test/build/upload/logs 11:31:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.713199 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-02-06 11:31:21.222609) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 11:31:21.227051) ========= 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=8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/988cbfeba4d44a825f3a5fd16753db5241671c565af4c5212f739d27f542686a3c4a9c5121dccbf44e7bf72bd01453bb2320dc6db6847b91f15d81846b384075", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2435a2acb50850c960bb528f1c3464218014198987d0d71d4fbf9c130da9f2db8ee2fc858b1db0382577add44ec2484715eaca6bdbf1e738ef3172962dd718f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53ac7d91cf6c781f929e76ae3c43f7b9785add58a8055967920eababfe8088390483568146a7775ac7e54593ebf40b46ffae4e74fb9ac8cefa47ec3d523e3ad3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/baecdc3aa5cbe1fc56de07297a9d0ab382f04935dba3e52591157d87739abcaa5c2117717f7ff4a662077bc8e53c74104105f5391d75d8c7e848d29ab5b1dc60"} build_url:https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/WYWMQ5U2TUKNQ5uJhb0cnA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/988cbfeba4d44a825f3a5fd16753db5241671c565af4c5212f739d27f542686a3c4a9c5121dccbf44e7bf72bd01453bb2320dc6db6847b91f15d81846b384075", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2435a2acb50850c960bb528f1c3464218014198987d0d71d4fbf9c130da9f2db8ee2fc858b1db0382577add44ec2484715eaca6bdbf1e738ef3172962dd718f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53ac7d91cf6c781f929e76ae3c43f7b9785add58a8055967920eababfe8088390483568146a7775ac7e54593ebf40b46ffae4e74fb9ac8cefa47ec3d523e3ad3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/baecdc3aa5cbe1fc56de07297a9d0ab382f04935dba3e52591157d87739abcaa5c2117717f7ff4a662077bc8e53c74104105f5391d75d8c7e848d29ab5b1dc60"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 11:31:21.254883) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:31:21.255253) ========= 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=8783db0840cc980e80bb0bd400000236-1486408204.168956-352774760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:31:21.334534) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 11:31:21.337884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 11:31:21.338196) ========= ========= Total master_lag: 0.17 =========