builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1484010801.12 results: success (0) revision: 845cc4dea57f6cc93f46810d24b1058b640c3b74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 17:13:21.124570) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 17:13:21.125053) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 17:13:21.125349) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 17:13:21.139925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 17:13:21.140287) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 17:13:21-- 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% 42.9M=0s 2017-01-09 17:13:21 (42.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.075230 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 17:13:21.229569) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 17:13:21.229888) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021942 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 17:13:21.279498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 17:13:21.279853) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 845cc4dea57f6cc93f46810d24b1058b640c3b74 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 845cc4dea57f6cc93f46810d24b1058b640c3b74 --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=9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 17:13:21,474 truncating revision to first 12 chars 2017-01-09 17:13:21,474 Setting DEBUG logging. 2017-01-09 17:13:21,474 attempt 1/10 2017-01-09 17:13:21,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/845cc4dea57f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 17:13:22,552 unpacking tar archive at: mozilla-central-845cc4dea57f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.372272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 17:13:22.665381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 17:13:22.665727) ========= script_repo_revision: 845cc4dea57f6cc93f46810d24b1058b640c3b74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 17:13:22.666102) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 17:13:22.666371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 17:13:22.675348) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-09 17:13:22.675750) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:13:22 INFO - MultiFileLogger online at 20170109 17:13:22 in /builds/slave/test 17:13:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:13:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:13:22 INFO - {'append_to_log': False, 17:13:22 INFO - 'base_work_dir': '/builds/slave/test', 17:13:22 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:13:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:13:22 INFO - 'branch': 'Firefox-Non-PGO', 17:13:22 INFO - 'buildbot_json_path': 'buildprops.json', 17:13:22 INFO - 'config_files': ('talos/linux_config.py',), 17:13:22 INFO - 'default_actions': ('clobber', 17:13:22 INFO - 'read-buildbot-config', 17:13:22 INFO - 'download-and-extract', 17:13:22 INFO - 'populate-webroot', 17:13:22 INFO - 'create-virtualenv', 17:13:22 INFO - 'install', 17:13:22 INFO - 'run-tests'), 17:13:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:13:22 INFO - 'download_minidump_stackwalk': True, 17:13:22 INFO - 'download_symbols': 'ondemand', 17:13:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:13:22 INFO - 'tooltool.py': '/tools/tooltool.py', 17:13:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:13:22 INFO - '/tools/misc-python/virtualenv.py')}, 17:13:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:13:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:13:22 INFO - 'installer_path': 'installer.exe', 17:13:22 INFO - 'log_level': 'info', 17:13:22 INFO - 'log_name': 'talos', 17:13:22 INFO - 'log_to_console': True, 17:13:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:13:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:13:22 INFO - 'opt_config_files': (), 17:13:22 INFO - 'pip_index': False, 17:13:22 INFO - 'sps_profile': False, 17:13:22 INFO - 'sps_profile_interval': 0, 17:13:22 INFO - 'suite': 'dromaeojs', 17:13:22 INFO - 'system_bits': '32', 17:13:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:13:22 INFO - 'title': 'talos-linux64-ix-040', 17:13:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:13:22 INFO - 'use_talos_json': True, 17:13:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:13:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:13:22 INFO - 'work_dir': 'build'} 17:13:22 INFO - [mozharness: 2017-01-10 01:13:22.961285Z] Running clobber step. 17:13:22 INFO - Running pre-action listener: _resource_record_pre_action 17:13:22 INFO - Running main action method: clobber 17:13:22 INFO - rmtree: /builds/slave/test/build 17:13:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:13:23 INFO - Running post-action listener: _resource_record_post_action 17:13:23 INFO - [mozharness: 2017-01-10 01:13:23.421155Z] Finished clobber step (success) 17:13:23 INFO - [mozharness: 2017-01-10 01:13:23.421258Z] Running read-buildbot-config step. 17:13:23 INFO - Running pre-action listener: _resource_record_pre_action 17:13:23 INFO - Running main action method: read_buildbot_config 17:13:23 INFO - Using buildbot properties: 17:13:23 INFO - { 17:13:23 INFO - "project": "", 17:13:23 INFO - "product": "firefox", 17:13:23 INFO - "who": "kwierso@gmail.com", 17:13:23 INFO - "installer_path": "public/build/target.tar.bz2", 17:13:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:13:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:13:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:13:23 INFO - "stage_platform": "linux64", 17:13:23 INFO - "basedir": "/builds/slave/test", 17:13:23 INFO - "buildnumber": 908, 17:13:23 INFO - "platform": "ubuntu64_hw", 17:13:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:13:23 INFO - "slavebuilddir": "test", 17:13:23 INFO - "taskId": "aGZN58xIQJ-E4Qyt0VlHCw", 17:13:23 INFO - "branch": "mozilla-central", 17:13:23 INFO - "script_repo_revision": "production", 17:13:23 INFO - "revision": "845cc4dea57f6cc93f46810d24b1058b640c3b74", 17:13:23 INFO - "slavename": "talos-linux64-ix-040", 17:13:23 INFO - "repo_path": "mozilla-central" 17:13:23 INFO - } 17:13:23 INFO - Finding installer, test and symbols from parent task. 17:13:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aGZN58xIQJ-E4Qyt0VlHCw'}, attempt #1 17:13:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aGZN58xIQJ-E4Qyt0VlHCw'}, attempt #1 17:13:24 INFO - Task dependencies: bWldNLtFSU6X_IZiooHesg 17:13:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg'}, attempt #1 17:13:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.tar.bz2 17:13:25 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/test_packages.json 17:13:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.crashreporter-symbols.zip 17:13:25 INFO - Running post-action listener: _resource_record_post_action 17:13:25 INFO - [mozharness: 2017-01-10 01:13:25.006832Z] Finished read-buildbot-config step (success) 17:13:25 INFO - [mozharness: 2017-01-10 01:13:25.007051Z] Running download-and-extract step. 17:13:25 INFO - Running pre-action listener: _resource_record_pre_action 17:13:25 INFO - Running main action method: download_and_extract 17:13:25 INFO - mkdir: /builds/slave/test/build/tests 17:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:25 INFO - trying https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.test_packages.json 17:13:25 INFO - Downloading https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:13:25 INFO - Downloaded 896 bytes. 17:13:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:13:25 INFO - Using the following test package requirements: 17:13:25 INFO - {u'common': [u'target.common.tests.zip'], 17:13:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:13:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:13:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:13:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:13:25 INFO - u'mozbase': [u'target.common.tests.zip'], 17:13:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:13:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:13:25 INFO - u'web-platform': [u'target.common.tests.zip', 17:13:25 INFO - u'target.web-platform.tests.zip'], 17:13:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:13:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:13:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.common.tests.zip 17:13:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:13:25 INFO - Fetch https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.common.tests.zip into memory 17:13:26 INFO - Expected file size: 20252653 17:13:26 INFO - Obtained file size: 20252653 17:13:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:13:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.common.tests.zip 17:13:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:13:30 INFO - Fetch https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.common.tests.zip into memory 17:13:31 INFO - Expected file size: 20252653 17:13:31 INFO - Obtained file size: 20252653 17:13:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.talos.tests.zip 17:13:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:13:35 INFO - Fetch https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.talos.tests.zip into memory 17:13:36 INFO - Expected file size: 14403537 17:13:36 INFO - Obtained file size: 14403537 17:13: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')]} 17:13:36 INFO - trying https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.tar.bz2 17:13:36 INFO - Downloading https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:13:37 INFO - Downloaded 56030255 bytes. 17:13:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.tar.bz2 17:13:37 INFO - mkdir: /builds/slave/test/properties 17:13:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:13:37 INFO - Writing to file /builds/slave/test/properties/build_url 17:13:37 INFO - Contents: 17:13:37 INFO - build_url:https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.tar.bz2 17:13:37 INFO - Running post-action listener: _resource_record_post_action 17:13:37 INFO - Running post-action listener: set_extra_try_arguments 17:13:37 INFO - [mozharness: 2017-01-10 01:13:37.777811Z] Finished download-and-extract step (success) 17:13:37 INFO - [mozharness: 2017-01-10 01:13:37.777909Z] Running populate-webroot step. 17:13:37 INFO - Running pre-action listener: _resource_record_pre_action 17:13:37 INFO - Running main action method: populate_webroot 17:13:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:13:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:13:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:13:37 INFO - '--tppagecycles', 17:13:37 INFO - '7'], 17:13:37 INFO - 'tests': ['tsvgm']}}, 17:13:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:13:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:13:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:13:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:13:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:13:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:13:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:13:37 INFO - 'talos_options': ['--disable-e10s'], 17:13:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:13:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:13:37 INFO - 'talos_options': ['--disable-e10s'], 17:13:37 INFO - 'tests': ['damp', 'tps']}, 17:13:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:13:37 INFO - 'tests': ['damp', 'tps']}, 17:13:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:13:37 INFO - 'tests': ['dromaeo_dom']}, 17:13:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:13:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:13:37 INFO - 'tests': ['basic_compositor_video']}, 17:13:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:13:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:13:37 INFO - 'tests': ['a11yr', 17:13:37 INFO - 'ts_paint', 17:13:37 INFO - 'tpaint', 17:13:37 INFO - 'sessionrestore', 17:13:37 INFO - 'sessionrestore_no_auto_restore', 17:13:37 INFO - 'tabpaint']}, 17:13:37 INFO - 'other-e10s': {'tests': ['a11yr', 17:13:37 INFO - 'ts_paint', 17:13:37 INFO - 'tpaint', 17:13:37 INFO - 'sessionrestore', 17:13:37 INFO - 'sessionrestore_no_auto_restore', 17:13:37 INFO - 'tabpaint']}, 17:13:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:13:37 INFO - 'ts_paint', 17:13:37 INFO - 'tpaint', 17:13:37 INFO - 'sessionrestore', 17:13:37 INFO - 'sessionrestore_no_auto_restore', 17:13:37 INFO - 'tabpaint']}, 17:13:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:13:37 INFO - 'ts_paint', 17:13:37 INFO - 'tpaint', 17:13:37 INFO - 'sessionrestore', 17:13:37 INFO - 'sessionrestore_no_auto_restore', 17:13:37 INFO - 'tabpaint']}, 17:13:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:13:37 INFO - 'tests': ['a11yr', 17:13:37 INFO - 'ts_paint', 17:13:37 INFO - 'tpaint', 17:13:37 INFO - 'sessionrestore', 17:13:37 INFO - 'sessionrestore_no_auto_restore', 17:13:37 INFO - 'tabpaint']}, 17:13:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:13:37 INFO - 'tests': ['a11yr', 17:13:37 INFO - 'ts_paint', 17:13:37 INFO - 'tpaint', 17:13:37 INFO - 'sessionrestore', 17:13:37 INFO - 'sessionrestore_no_auto_restore', 17:13:37 INFO - 'tabpaint']}, 17:13:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:13:37 INFO - 'tests': ['tsvgx', 17:13:37 INFO - 'tsvgr_opacity', 17:13:37 INFO - 'tart', 17:13:37 INFO - 'tscrollx', 17:13:37 INFO - 'cart', 17:13:37 INFO - 'tsvg_static']}, 17:13:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:13:37 INFO - 'tsvgr_opacity', 17:13:37 INFO - 'tart', 17:13:37 INFO - 'tscrollx', 17:13:37 INFO - 'cart', 17:13:37 INFO - 'tsvg_static']}, 17:13:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:13:37 INFO - 'talos_options': ['--disable-e10s'], 17:13:37 INFO - 'tests': ['tp5o']}, 17:13:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:13:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:13:37 INFO - 'talos_options': ['--disable-e10s', 17:13:37 INFO - '--xperf_path', 17:13:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:37 INFO - 'tests': ['tp5n']}, 17:13:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:13:37 INFO - 'talos_options': ['--xperf_path', 17:13:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:37 INFO - 'tests': ['tp5n']}}, 17:13:37 INFO - 'talos.zip': {'path': '', 17:13:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:13:37 INFO - Running post-action listener: _resource_record_post_action 17:13:37 INFO - [mozharness: 2017-01-10 01:13:37.791166Z] Finished populate-webroot step (success) 17:13:37 INFO - [mozharness: 2017-01-10 01:13:37.791260Z] Running create-virtualenv step. 17:13:37 INFO - Running pre-action listener: _resource_record_pre_action 17:13:37 INFO - Running main action method: create_virtualenv 17:13:37 INFO - Creating virtualenv /builds/slave/test/build/venv 17:13:37 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 17:13:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:13:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:13:37 INFO - Using real prefix '/usr' 17:13:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:13:38 INFO - Installing distribute.............................................................................................................................................................................................done. 17:13:40 INFO - Installing pip.................done. 17:13:40 INFO - Return code: 0 17:13:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:13:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:13:40 INFO - Reading from file tmpfile_stdout 17:13:40 INFO - Output received: 17:13:40 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) 17:13:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:13:40 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')]} 17:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:40 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')]} 17:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:40 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 0x193a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35850>, '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 0x1caa6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caab60>, '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': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', '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 17:13:40 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 17:13:40 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 17:13:40 INFO - Using env: {'DISPLAY': ':0', 17:13:40 INFO - 'HOME': '/home/cltbld', 17:13:40 INFO - 'LANG': 'en_US.UTF-8', 17:13:40 INFO - 'LANGUAGE': 'en_US:en', 17:13:40 INFO - 'LOGNAME': 'cltbld', 17:13:40 INFO - 'MAIL': '/var/mail/cltbld', 17:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:40 INFO - 'MOZ_NO_REMOTE': '1', 17:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:40 INFO - 'NO_EM_RESTART': '1', 17:13:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:40 INFO - 'PWD': '/builds/slave/test', 17:13:40 INFO - 'SHELL': '/bin/bash', 17:13:40 INFO - 'SHLVL': '1', 17:13:40 INFO - 'TERM': 'linux', 17:13:40 INFO - 'TMOUT': '86400', 17:13:40 INFO - 'USER': 'cltbld', 17:13:40 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', 17:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:40 INFO - '_': '/tools/buildbot/bin/python'} 17:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:40 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 17:13:40 INFO - Cleaning up... 17:13:40 INFO - Return code: 0 17:13:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:13:40 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')]} 17:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:40 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')]} 17:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:40 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 0x193a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35850>, '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 0x1caa6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caab60>, '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': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', '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 17:13:40 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 17:13:40 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 17:13:40 INFO - Using env: {'DISPLAY': ':0', 17:13:40 INFO - 'HOME': '/home/cltbld', 17:13:40 INFO - 'LANG': 'en_US.UTF-8', 17:13:40 INFO - 'LANGUAGE': 'en_US:en', 17:13:40 INFO - 'LOGNAME': 'cltbld', 17:13:40 INFO - 'MAIL': '/var/mail/cltbld', 17:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:40 INFO - 'MOZ_NO_REMOTE': '1', 17:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:40 INFO - 'NO_EM_RESTART': '1', 17:13:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:40 INFO - 'PWD': '/builds/slave/test', 17:13:40 INFO - 'SHELL': '/bin/bash', 17:13:40 INFO - 'SHLVL': '1', 17:13:40 INFO - 'TERM': 'linux', 17:13:40 INFO - 'TMOUT': '86400', 17:13:40 INFO - 'USER': 'cltbld', 17:13:40 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', 17:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:40 INFO - '_': '/tools/buildbot/bin/python'} 17:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:41 INFO - Downloading/unpacking psutil>=3.1.1 17:13:41 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 17:13:41 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 17:13:41 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 17:13:41 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 17:13:41 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 17:13:41 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 17:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:13:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:43 INFO - Installing collected packages: psutil 17:13:43 INFO - Running setup.py install for psutil 17:13:43 INFO - building 'psutil._psutil_linux' extension 17:13:43 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 17:13:43 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 17:13:43 INFO - building 'psutil._psutil_posix' extension 17:13:43 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 17:13:43 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 17:13:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:43 INFO - Successfully installed psutil 17:13:43 INFO - Cleaning up... 17:13:43 INFO - Return code: 0 17:13:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:43 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 0x193a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35850>, '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 0x1caa6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caab60>, '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': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', '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 17:13:43 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 17:13:43 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 17:13:43 INFO - Using env: {'DISPLAY': ':0', 17:13:43 INFO - 'HOME': '/home/cltbld', 17:13:43 INFO - 'LANG': 'en_US.UTF-8', 17:13:43 INFO - 'LANGUAGE': 'en_US:en', 17:13:43 INFO - 'LOGNAME': 'cltbld', 17:13:43 INFO - 'MAIL': '/var/mail/cltbld', 17:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:43 INFO - 'MOZ_NO_REMOTE': '1', 17:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:43 INFO - 'NO_EM_RESTART': '1', 17:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:43 INFO - 'PWD': '/builds/slave/test', 17:13:43 INFO - 'SHELL': '/bin/bash', 17:13:43 INFO - 'SHLVL': '1', 17:13:43 INFO - 'TERM': 'linux', 17:13:43 INFO - 'TMOUT': '86400', 17:13:43 INFO - 'USER': 'cltbld', 17:13:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', 17:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:43 INFO - '_': '/tools/buildbot/bin/python'} 17:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:13:43 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 17:13:43 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 17:13:43 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 17:13:43 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 17:13:43 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 17:13:43 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 17:13:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:13:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:13:45 INFO - Installing collected packages: mozsystemmonitor 17:13:45 INFO - Running setup.py install for mozsystemmonitor 17:13:46 INFO - Successfully installed mozsystemmonitor 17:13:46 INFO - Cleaning up... 17:13:46 INFO - Return code: 0 17:13:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:13:46 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')]} 17:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:46 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')]} 17:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:46 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 0x193a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35850>, '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 0x1caa6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caab60>, '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': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', '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 17:13:46 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 17:13:46 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 17:13:46 INFO - Using env: {'DISPLAY': ':0', 17:13:46 INFO - 'HOME': '/home/cltbld', 17:13:46 INFO - 'LANG': 'en_US.UTF-8', 17:13:46 INFO - 'LANGUAGE': 'en_US:en', 17:13:46 INFO - 'LOGNAME': 'cltbld', 17:13:46 INFO - 'MAIL': '/var/mail/cltbld', 17:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:46 INFO - 'MOZ_NO_REMOTE': '1', 17:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:46 INFO - 'NO_EM_RESTART': '1', 17:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:46 INFO - 'PWD': '/builds/slave/test', 17:13:46 INFO - 'SHELL': '/bin/bash', 17:13:46 INFO - 'SHLVL': '1', 17:13:46 INFO - 'TERM': 'linux', 17:13:46 INFO - 'TMOUT': '86400', 17:13:46 INFO - 'USER': 'cltbld', 17:13:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', 17:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:46 INFO - '_': '/tools/buildbot/bin/python'} 17:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:46 INFO - Downloading/unpacking jsonschema==2.5.1 17:13:46 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 17:13:46 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 17:13:46 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 17:13:46 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 17:13:46 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 17:13:46 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 17:13:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:13:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:13:48 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 17:13:48 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 17:13:48 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 17:13:48 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 17:13:48 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 17:13:48 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 17:13:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:13:48 INFO - warning: no files found matching '*.txt' 17:13:48 INFO - no previously-included directories found matching 'build' 17:13:48 INFO - no previously-included directories found matching 'dist' 17:13:48 INFO - no previously-included directories found matching '.git*' 17:13:48 INFO - Installing collected packages: jsonschema, functools32 17:13:48 INFO - Running setup.py install for functools32 17:13:48 INFO - warning: no files found matching '*.txt' 17:13:48 INFO - no previously-included directories found matching 'build' 17:13:48 INFO - no previously-included directories found matching 'dist' 17:13:48 INFO - no previously-included directories found matching '.git*' 17:13:48 INFO - Successfully installed jsonschema functools32 17:13:48 INFO - Cleaning up... 17:13:48 INFO - Return code: 0 17:13:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:13:48 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')]} 17:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:48 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')]} 17:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:48 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 0x193a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35850>, '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 0x1caa6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caab60>, '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': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', '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 17:13:48 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 17:13:48 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 17:13:48 INFO - Using env: {'DISPLAY': ':0', 17:13:48 INFO - 'HOME': '/home/cltbld', 17:13:48 INFO - 'LANG': 'en_US.UTF-8', 17:13:48 INFO - 'LANGUAGE': 'en_US:en', 17:13:48 INFO - 'LOGNAME': 'cltbld', 17:13:48 INFO - 'MAIL': '/var/mail/cltbld', 17:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:48 INFO - 'MOZ_NO_REMOTE': '1', 17:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:48 INFO - 'NO_EM_RESTART': '1', 17:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:48 INFO - 'PWD': '/builds/slave/test', 17:13:48 INFO - 'SHELL': '/bin/bash', 17:13:48 INFO - 'SHLVL': '1', 17:13:48 INFO - 'TERM': 'linux', 17:13:48 INFO - 'TMOUT': '86400', 17:13:48 INFO - 'USER': 'cltbld', 17:13:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', 17:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:48 INFO - '_': '/tools/buildbot/bin/python'} 17:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:13:49 INFO - Cleaning up... 17:13:49 INFO - Return code: 0 17:13:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:13:49 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')]} 17:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:49 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')]} 17:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:49 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 0x193a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35850>, '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 0x1caa6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caab60>, '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': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', '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 17:13:49 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 17:13:49 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 17:13:49 INFO - Using env: {'DISPLAY': ':0', 17:13:49 INFO - 'HOME': '/home/cltbld', 17:13:49 INFO - 'LANG': 'en_US.UTF-8', 17:13:49 INFO - 'LANGUAGE': 'en_US:en', 17:13:49 INFO - 'LOGNAME': 'cltbld', 17:13:49 INFO - 'MAIL': '/var/mail/cltbld', 17:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:49 INFO - 'MOZ_NO_REMOTE': '1', 17:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:49 INFO - 'NO_EM_RESTART': '1', 17:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:49 INFO - 'PWD': '/builds/slave/test', 17:13:49 INFO - 'SHELL': '/bin/bash', 17:13:49 INFO - 'SHLVL': '1', 17:13:49 INFO - 'TERM': 'linux', 17:13:49 INFO - 'TMOUT': '86400', 17:13:49 INFO - 'USER': 'cltbld', 17:13:49 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', 17:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:49 INFO - '_': '/tools/buildbot/bin/python'} 17:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:49 INFO - Downloading/unpacking blobuploader==1.2.4 17:13:49 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 17:13:49 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 17:13:49 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 17:13:49 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 17:13:49 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 17:13:49 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 17:13:51 INFO - Downloading blobuploader-1.2.4.tar.gz 17:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:13:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:13:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 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 17:13:52 INFO - Downloading docopt-0.6.1.tar.gz 17:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:13:52 INFO - Installing collected packages: blobuploader, requests, docopt 17:13:52 INFO - Running setup.py install for blobuploader 17:13:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:13:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:13:52 INFO - Running setup.py install for requests 17:13:52 INFO - Running setup.py install for docopt 17:13:52 INFO - Successfully installed blobuploader requests docopt 17:13:52 INFO - Cleaning up... 17:13:52 INFO - Return code: 0 17:13:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:52 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')]} 17:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:52 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')]} 17:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:52 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 0x193a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35850>, '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 0x1caa6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caab60>, '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': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', '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 17:13:52 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 17:13:52 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 17:13:52 INFO - Using env: {'DISPLAY': ':0', 17:13:52 INFO - 'HOME': '/home/cltbld', 17:13:52 INFO - 'LANG': 'en_US.UTF-8', 17:13:52 INFO - 'LANGUAGE': 'en_US:en', 17:13:52 INFO - 'LOGNAME': 'cltbld', 17:13:52 INFO - 'MAIL': '/var/mail/cltbld', 17:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:52 INFO - 'MOZ_NO_REMOTE': '1', 17:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:52 INFO - 'NO_EM_RESTART': '1', 17:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:52 INFO - 'PWD': '/builds/slave/test', 17:13:52 INFO - 'SHELL': '/bin/bash', 17:13:52 INFO - 'SHLVL': '1', 17:13:52 INFO - 'TERM': 'linux', 17:13:52 INFO - 'TMOUT': '86400', 17:13:52 INFO - 'USER': 'cltbld', 17:13:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', 17:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:52 INFO - '_': '/tools/buildbot/bin/python'} 17:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:52 INFO - Running setup.py (path:/tmp/pip-SHzTIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:53 INFO - Running setup.py (path:/tmp/pip-sQowvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:53 INFO - Running setup.py (path:/tmp/pip-bOXEky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:53 INFO - Running setup.py (path:/tmp/pip-YGu2yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:53 INFO - Running setup.py (path:/tmp/pip-GaIImz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:53 INFO - Running setup.py (path:/tmp/pip-yS05ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:53 INFO - Running setup.py (path:/tmp/pip-e_3Fo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:53 INFO - Running setup.py (path:/tmp/pip-AvbpBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:53 INFO - Running setup.py (path:/tmp/pip-aJB2RR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:53 INFO - Running setup.py (path:/tmp/pip-RKAPbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:53 INFO - Running setup.py (path:/tmp/pip-G9xbdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:53 INFO - Running setup.py (path:/tmp/pip-v9nGVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:53 INFO - Running setup.py (path:/tmp/pip-Ur6NpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:53 INFO - Running setup.py (path:/tmp/pip-eJjC7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:53 INFO - Running setup.py (path:/tmp/pip-n1DTTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:54 INFO - Running setup.py (path:/tmp/pip-IkOZDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:54 INFO - Running setup.py (path:/tmp/pip-H5DGZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:13:54 INFO - Running setup.py install for manifestparser 17:13:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:13:54 INFO - Running setup.py install for mozcrash 17:13:54 INFO - Running setup.py install for mozdebug 17:13:54 INFO - Running setup.py install for mozdevice 17:13:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:13:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:13:54 INFO - Running setup.py install for mozfile 17:13:54 INFO - Running setup.py install for mozhttpd 17:13:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:13:54 INFO - Running setup.py install for mozinfo 17:13:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:13:54 INFO - Running setup.py install for mozInstall 17:13:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:13:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:13:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:13:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:13:54 INFO - Running setup.py install for mozleak 17:13:55 INFO - Running setup.py install for mozlog 17:13:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:13:55 INFO - Running setup.py install for moznetwork 17:13:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:13:55 INFO - Running setup.py install for mozprocess 17:13:55 INFO - Running setup.py install for mozprofile 17:13:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:13:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:13:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:13:55 INFO - Running setup.py install for mozrunner 17:13:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:13:55 INFO - Running setup.py install for mozscreenshot 17:13:55 INFO - Running setup.py install for moztest 17:13:55 INFO - Running setup.py install for mozversion 17:13:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:13:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:13:56 INFO - Cleaning up... 17:13:56 INFO - Return code: 0 17:13:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:56 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 0x193a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35850>, '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 0x1caa6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caab60>, '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': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', '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 17:13:56 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 17:13:56 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 17:13:56 INFO - Using env: {'DISPLAY': ':0', 17:13:56 INFO - 'HOME': '/home/cltbld', 17:13:56 INFO - 'LANG': 'en_US.UTF-8', 17:13:56 INFO - 'LANGUAGE': 'en_US:en', 17:13:56 INFO - 'LOGNAME': 'cltbld', 17:13:56 INFO - 'MAIL': '/var/mail/cltbld', 17:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:56 INFO - 'MOZ_NO_REMOTE': '1', 17:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:56 INFO - 'NO_EM_RESTART': '1', 17:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:56 INFO - 'PWD': '/builds/slave/test', 17:13:56 INFO - 'SHELL': '/bin/bash', 17:13:56 INFO - 'SHLVL': '1', 17:13:56 INFO - 'TERM': 'linux', 17:13:56 INFO - 'TMOUT': '86400', 17:13:56 INFO - 'USER': 'cltbld', 17:13:56 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', 17:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:56 INFO - '_': '/tools/buildbot/bin/python'} 17:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:56 INFO - Running setup.py (path:/tmp/pip-Kqoq9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:56 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)) 17:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:56 INFO - Running setup.py (path:/tmp/pip-TehFRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:56 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)) 17:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:56 INFO - Running setup.py (path:/tmp/pip-XcoDQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:56 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)) 17:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:56 INFO - Running setup.py (path:/tmp/pip-7XxFVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:56 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)) 17:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:56 INFO - Running setup.py (path:/tmp/pip-6w3Igs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:56 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)) 17:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:56 INFO - Running setup.py (path:/tmp/pip-gcRRP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:56 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)) 17:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:56 INFO - Running setup.py (path:/tmp/pip-CFP9d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:56 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)) 17:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:56 INFO - Running setup.py (path:/tmp/pip-8fu2gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:56 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)) 17:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:56 INFO - Running setup.py (path:/tmp/pip-8vO31K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:56 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)) 17:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:56 INFO - Running setup.py (path:/tmp/pip-z1990x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:57 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)) 17:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:57 INFO - Running setup.py (path:/tmp/pip-mwIl5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:57 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)) 17:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:57 INFO - Running setup.py (path:/tmp/pip-fwea7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:57 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)) 17:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:57 INFO - Running setup.py (path:/tmp/pip-BvyZOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:57 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)) 17:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:57 INFO - Running setup.py (path:/tmp/pip-CGkhUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:57 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)) 17:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:57 INFO - Running setup.py (path:/tmp/pip-xjeX9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:57 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)) 17:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:57 INFO - Running setup.py (path:/tmp/pip-7wacjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:57 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)) 17:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:57 INFO - Running setup.py (path:/tmp/pip-UH7pmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:57 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)) 17:13:57 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)) 17:13:57 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)) 17:13:57 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)) 17:13:57 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)) 17:13:57 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)) 17:13:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:59 INFO - Downloading blessings-1.6.tar.gz 17:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:13:59 INFO - Installing collected packages: blessings 17:13:59 INFO - Running setup.py install for blessings 17:13:59 INFO - Successfully installed blessings 17:13:59 INFO - Cleaning up... 17:13:59 INFO - Return code: 0 17:13:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:13:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:14:00 INFO - Reading from file tmpfile_stdout 17:14:00 INFO - Current package versions: 17:14:00 INFO - argparse == 1.2.1 17:14:00 INFO - blessings == 1.6 17:14:00 INFO - blobuploader == 1.2.4 17:14:00 INFO - docopt == 0.6.1 17:14:00 INFO - functools32 == 3.2.3-2 17:14:00 INFO - jsonschema == 2.5.1 17:14:00 INFO - manifestparser == 1.1 17:14:00 INFO - mozInstall == 1.12 17:14:00 INFO - mozcrash == 1.0 17:14:00 INFO - mozdebug == 0.1 17:14:00 INFO - mozdevice == 0.49 17:14:00 INFO - mozfile == 1.2 17:14:00 INFO - mozhttpd == 0.7 17:14:00 INFO - mozinfo == 0.9 17:14:00 INFO - mozleak == 0.1 17:14:00 INFO - mozlog == 3.4 17:14:00 INFO - moznetwork == 0.27 17:14:00 INFO - mozprocess == 0.24 17:14:00 INFO - mozprofile == 0.28 17:14:00 INFO - mozrunner == 6.13 17:14:00 INFO - mozscreenshot == 0.1 17:14:00 INFO - mozsystemmonitor == 0.3 17:14:00 INFO - moztest == 0.8 17:14:00 INFO - mozversion == 1.4 17:14:00 INFO - psutil == 3.1.1 17:14:00 INFO - requests == 1.2.3 17:14:00 INFO - wsgiref == 0.1.2 17:14:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:00 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 0x193a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35850>, '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 0x1caa6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caab60>, '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': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', '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 17:14:00 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 17:14:00 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 17:14:00 INFO - Using env: {'DISPLAY': ':0', 17:14:00 INFO - 'HOME': '/home/cltbld', 17:14:00 INFO - 'LANG': 'en_US.UTF-8', 17:14:00 INFO - 'LANGUAGE': 'en_US:en', 17:14:00 INFO - 'LOGNAME': 'cltbld', 17:14:00 INFO - 'MAIL': '/var/mail/cltbld', 17:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:00 INFO - 'MOZ_NO_REMOTE': '1', 17:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:00 INFO - 'NO_EM_RESTART': '1', 17:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:00 INFO - 'PWD': '/builds/slave/test', 17:14:00 INFO - 'SHELL': '/bin/bash', 17:14:00 INFO - 'SHLVL': '1', 17:14:00 INFO - 'TERM': 'linux', 17:14:00 INFO - 'TMOUT': '86400', 17:14:00 INFO - 'USER': 'cltbld', 17:14:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', 17:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:00 INFO - '_': '/tools/buildbot/bin/python'} 17:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:00 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)) 17:14:00 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)) 17:14:00 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)) 17:14:00 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)) 17:14:00 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)) 17:14:00 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)) 17:14:00 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)) 17:14:00 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)) 17:14:00 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)) 17:14:00 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)) 17:14:00 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)) 17:14:00 INFO - Cleaning up... 17:14:00 INFO - Return code: 0 17:14:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35850>, '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 0x1caa6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caab60>, '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': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', '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 17:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:14:00 INFO - Using env: {'DISPLAY': ':0', 17:14:00 INFO - 'HOME': '/home/cltbld', 17:14:00 INFO - 'LANG': 'en_US.UTF-8', 17:14:00 INFO - 'LANGUAGE': 'en_US:en', 17:14:00 INFO - 'LOGNAME': 'cltbld', 17:14:00 INFO - 'MAIL': '/var/mail/cltbld', 17:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:00 INFO - 'MOZ_NO_REMOTE': '1', 17:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:00 INFO - 'NO_EM_RESTART': '1', 17:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:00 INFO - 'PWD': '/builds/slave/test', 17:14:00 INFO - 'SHELL': '/bin/bash', 17:14:00 INFO - 'SHLVL': '1', 17:14:00 INFO - 'TERM': 'linux', 17:14:00 INFO - 'TMOUT': '86400', 17:14:00 INFO - 'USER': 'cltbld', 17:14:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', 17:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:00 INFO - '_': '/tools/buildbot/bin/python'} 17:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:14:00 INFO - Cleaning up... 17:14:00 INFO - Return code: 0 17:14:00 INFO - Running post-action listener: _resource_record_post_action 17:14:00 INFO - Running post-action listener: _start_resource_monitoring 17:14:00 INFO - Starting resource monitoring. 17:14:00 INFO - [mozharness: 2017-01-10 01:14:00.487989Z] Finished create-virtualenv step (success) 17:14:00 INFO - [mozharness: 2017-01-10 01:14:00.488489Z] Running install step. 17:14:00 INFO - Running pre-action listener: _resource_record_pre_action 17:14:00 INFO - Running main action method: install 17:14:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:14:00 INFO - Reading from file tmpfile_stdout 17:14:00 INFO - Detecting whether we're running mozinstall >=1.0... 17:14:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:14:00 INFO - Reading from file tmpfile_stdout 17:14:00 INFO - Output received: 17:14:00 INFO - Usage: mozinstall [options] installer 17:14:00 INFO - Options: 17:14:00 INFO - -h, --help show this help message and exit 17:14:00 INFO - -d DEST, --destination=DEST 17:14:00 INFO - Directory to install application into. [default: 17:14:00 INFO - "/builds/slave/test"] 17:14:00 INFO - --app=APP Application being installed. [default: firefox] 17:14:00 INFO - mkdir: /builds/slave/test/build/application 17:14:00 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'] 17:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:14:16 INFO - Reading from file tmpfile_stdout 17:14:16 INFO - Output received: 17:14:16 INFO - /builds/slave/test/build/application/firefox/firefox 17:14:16 INFO - Running post-action listener: _resource_record_post_action 17:14:16 INFO - [mozharness: 2017-01-10 01:14:16.882293Z] Finished install step (success) 17:14:16 INFO - [mozharness: 2017-01-10 01:14:16.882566Z] Running run-tests step. 17:14:16 INFO - Running pre-action listener: _resource_record_pre_action 17:14:16 INFO - Running main action method: run_tests 17:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:14:16 INFO - Python 2.7.3 17:14:16 INFO - Return code: 0 17:14:16 INFO - grabbing minidump binary from tooltool 17:14:16 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')]} 17:14:16 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 0x1d35850>, '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 0x1caa6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caab60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:14:16 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 17:14:16 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 17:14:16 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 17:14:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:14:16 INFO - Return code: 0 17:14:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:14:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:14:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:14:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:14:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 17:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 17:14:16 INFO - Using env: {'DISPLAY': ':0', 17:14:16 INFO - 'HOME': '/home/cltbld', 17:14:16 INFO - 'LANG': 'en_US.UTF-8', 17:14:16 INFO - 'LANGUAGE': 'en_US:en', 17:14:16 INFO - 'LOGNAME': 'cltbld', 17:14:16 INFO - 'MAIL': '/var/mail/cltbld', 17:14:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:14:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:16 INFO - 'MOZ_NO_REMOTE': '1', 17:14:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:14:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:16 INFO - 'NO_EM_RESTART': '1', 17:14:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:16 INFO - 'PWD': '/builds/slave/test', 17:14:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:14:16 INFO - 'SHELL': '/bin/bash', 17:14:16 INFO - 'SHLVL': '1', 17:14:16 INFO - 'TERM': 'linux', 17:14:16 INFO - 'TMOUT': '86400', 17:14:16 INFO - 'USER': 'cltbld', 17:14:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292', 17:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:16 INFO - '_': '/tools/buildbot/bin/python'} 17:14:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 17:14:17 INFO - mozversion application_buildid: 20170110003450 17:14:17 INFO - mozversion application_changeset: 845cc4dea57f6cc93f46810d24b1058b640c3b74 17:14:17 INFO - mozversion application_display_name: Nightly 17:14:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:14:17 INFO - mozversion application_name: Firefox 17:14:17 INFO - mozversion application_remotingname: firefox 17:14:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:14:17 INFO - mozversion application_vendor: Mozilla 17:14:17 INFO - mozversion application_version: 53.0a1 17:14:17 INFO - mozversion platform_buildid: 20170110003450 17:14:17 INFO - mozversion platform_changeset: 845cc4dea57f6cc93f46810d24b1058b640c3b74 17:14:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:14:17 INFO - mozversion platform_version: 53.0a1 17:14:17 INFO - using testdate: 1484010857 17:14:17 INFO - actual date: 1484010857 17:14:17 INFO - starting webserver on 'localhost:38528' 17:14:17 INFO - SUITE-START | Running 2 tests 17:14:17 INFO - TEST-START | dromaeo_css 17:14:17 INFO - operating with platform_type : linux_ 17:14:17 INFO - Initialising browser for dromaeo_css test... 17:14:17 INFO - TEST-INFO | started process 5850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbC2PRB/profile http://localhost:38528/getInfo.html) 17:14:17 INFO - PROCESS | 5850 | 1484010857637 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 17:14:21 INFO - PROCESS | 5850 | __metrics Screen width/height:1600/1200 17:14:21 INFO - PROCESS | 5850 | colorDepth:24 17:14:21 INFO - PROCESS | 5850 | Browser inner width/height: 1024/697 17:14:21 INFO - PROCESS | 5850 | __metrics 17:14:21 INFO - PROCESS | 5850 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:14:21 INFO - PROCESS | 5850 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:14:22 INFO - PROCESS | 5850 | console.error: PushService: 17:14:22 INFO - PROCESS | 5850 | stateChangeProcessEnqueue: Error transitioning state 17:14:22 INFO - PROCESS | 5850 | UnknownError 17:14:23 INFO - TEST-INFO | 5850: exit 0 17:14:23 INFO - Browser initialized. 17:14:23 INFO - Running cycle 1/1 for dromaeo_css test... 17:14:23 INFO - TEST-INFO | started process 5934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbC2PRB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:35 INFO - PROCESS | 5934 | RSS: Main: 151822336 17:14:35 INFO - PROCESS | 5934 | 17:17:38 INFO - PROCESS | 5934 | Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38528/tests/dromaeo/cssquery-ext.html) 17:17:41 INFO - PROCESS | 5934 | RSS: Main: 335335424 17:17:41 INFO - PROCESS | 5934 | 17:19:24 INFO - PROCESS | 5934 | ************************* 17:19:24 INFO - PROCESS | 5934 | A coding exception was thrown and uncaught in a Task. 17:19:24 INFO - PROCESS | 5934 | 17:19:24 INFO - PROCESS | 5934 | Full message: ReferenceError: fetch is not defined 17:19:24 INFO - PROCESS | 5934 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 17:19:24 INFO - PROCESS | 5934 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 17:19:24 INFO - PROCESS | 5934 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 17:19:24 INFO - PROCESS | 5934 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 17:19:24 INFO - PROCESS | 5934 | TaskImpl@resource://gre/modules/Task.jsm:277:3 17:19:24 INFO - PROCESS | 5934 | asyncFunction@resource://gre/modules/Task.jsm:252:14 17:19:24 INFO - PROCESS | 5934 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 17:19:24 INFO - PROCESS | 5934 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 17:19:24 INFO - PROCESS | 5934 | TaskImpl@resource://gre/modules/Task.jsm:277:3 17:19:24 INFO - PROCESS | 5934 | asyncFunction@resource://gre/modules/Task.jsm:252:14 17:19:24 INFO - PROCESS | 5934 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 17:19:24 INFO - PROCESS | 5934 | 17:19:24 INFO - PROCESS | 5934 | ************************* 17:20:44 INFO - PROCESS | 5934 | Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-ext.html (next: http://localhost:38528/tests/dromaeo/cssquery-jquery.html) 17:20:44 INFO - PROCESS | 5934 | RSS: Main: 242843648 17:20:44 INFO - PROCESS | 5934 | 17:23:46 INFO - PROCESS | 5934 | Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38528/tests/dromaeo/cssquery-mootools.html) 17:23:47 INFO - PROCESS | 5934 | RSS: Main: 184201216 17:23:47 INFO - PROCESS | 5934 | 17:26:49 INFO - PROCESS | 5934 | Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38528/tests/dromaeo/cssquery-prototype.html) 17:26:50 INFO - PROCESS | 5934 | RSS: Main: 184041472 17:26:50 INFO - PROCESS | 5934 | 17:29:53 INFO - PROCESS | 5934 | Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38528/tests/dromaeo/cssquery-yui.html) 17:29:54 INFO - PROCESS | 5934 | RSS: Main: 184266752 17:29:54 INFO - PROCESS | 5934 | 17:32:57 INFO - PROCESS | 5934 | Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-yui.html (next: http://localhost:38528/tests/dromaeo/cssquery-dojo.html) 17:32:57 INFO - PROCESS | 5934 | RSS: Main: 282750976 17:32:57 INFO - PROCESS | 5934 | 17:32:57 INFO - PROCESS | 5934 | __start_tp_report 17:32:57 INFO - PROCESS | 5934 | _x_x_mozilla_page_load 17:32:57 INFO - PROCESS | 5934 | _x_x_mozilla_page_load_details 17:32:57 INFO - PROCESS | 5934 | |i|pagename|runs| 17:32:57 INFO - PROCESS | 5934 | |0;dojo.html;2571.5756900111483;2576.1369941069743;2603.687557493101;2605.4137818990716;2610.960835587466;4673.205555055641;4733.337332773414;4757.904841903164;4758.238681810911;4776.7850446729935;4697.342372067913;4706.199946009178;4746.027064451788;4746.193147164981;4756.977249891282;4358.97820510897;4386.605205531518;4428;4443.822247110112;4494.68537202396;3982.9203415931665;4340.913181736363;4444.622207112399;4471.709338892962;4522.592966633002;4318.3090705486975;4343.847965321199;4378.080603073358;4378.64970802335;4459.955400446002;4340.348947657845;4366.410534577855;4376.993291542963;4391.429114215163;4452.4211852458975;4359.520452750195;4366.08312254427;4366.585174408426;4370;4407.206702793496;4696.600788932945;4720.76396180193;4726.0784147091335;4731.550502702238;4773.80904763809;4980.676256043382;5040.747962601855;5067.214581739836;5109.693418394908;5110.156824124015;5129.948700512984;5133.922991155136;5148.871278218037;5153.2785410042625;5186.0665080285535;4743.241081426955;4744.644151688637;4746.5490778376;4785.856424307276;4807.230843065163;5064.949350506447;5110.591152707774;5138;5170.715610641376;5299.761510732026;4968.080905032581;4971.4282857471135;4973.328600638867;5022.698638081727;5026.623003274769;4970.2793095001025;5001.4998500149695;5036.320096786887;5038.470960549163;5085.186370180753;5019.648624596316;5019.949800502021;5022.096022715946;5026.572741316956;5038.697678139323;4876.487968763229;4916.434610019822;4923.163062279421;4941.876453088702;4983.377077865267;4261.765602891809;4266.743995360288;4274.615284624399;4280.293751530962;4310.353446982977;3716.6840818530727;3765.3787125124595;3766.472693822867;3774.094217387807;3779.093017675738;4341.153475072394;4361.062371590124;4371.825126994948;4384;4388.692791504628;5085.211792172219;5087.796488140507;5091.490850914879;5107.361579802525;5131.923021154686;4379;4381.16757816014;4383.408239887638;4421.756803375845;4424.535423780521;4468.977655111704;4511.88720281989;4527.049319642846;4596.264597664358;4599.2871104978785;4692.718436893729;4716;4721.032188401438;4762.547557981986;4765.26138448541;4996.625253105959;5030.874228144179;5041.924371134362;5042.823501177441;5075.87310317245;4660.161170989254;4686.648501362343;4706.411698537683;4724.433068031858;4758.214894542501;4929.088118698052;4972.9254061188385;4974.676646017997;4978.726170060681;4980.078685443204;5043.2435134730085;5048.570871475966;5050.090983622983;5052.494750525065;5055;4918.311436398979;4928.654994150375;4933.925991110064;4938.728369939688;4939.53074457926;4904.705717656952;4937.432195297587;4940.777665005012;4948.2082866742585;4953.504649535162;4893.828715994923;4895.314655948241;4898;4900.1424750667775;4907.460179380194;4895.996320754166;4934.777934992862;4971.676841005323;4989.226669866177;4997.0505603935135;4861.6596838220985;4863.90272194547;4866.099771542276;4868.2210846264425;4913.975430122827 17:32:57 INFO - PROCESS | 5934 | |1;ext.html;531.7394476706413;568.3407247592793;573.9713014349283;590.2179612014082;607.8085403098027;34757.826210868945;38269;38276.425853612185;38311.61688383122;38413.42379864301;38611;39182.80408597953;39227.80386098065;39229.80385098071;39259.80370098146;7525.397968162534;7585.7344992925255;7721.613919304041;7779.18318576547;7785.026871641045;9965.701028969142;10255.743606409826;10274.280800343979;10539.104176145036;10541.78916421671;10235.897641023606;10306.381617102961;10314.329568578018;10319.277650564425;10321.948390258076;9768.316217864753;9810.65662701802;9821.607135714563;9823.066808653166;9827.4103553787;10055.446950417723;10124.94937525315;10126.240531960133;10128.189744820396;10128.54421551032;38412.80793596014;38714;38725.22549549022;38748.80625596854;38806;3709.610490898444;3771.3211621908044;3780.130569968895;3818.5417749869916;3838.7888666123354;28169;28360.858195709097;28971.56542651862;29107.56338654922;29163.270918227;3528.700060494861;3533.6466353364717;3652.7443078984215;3710.9628903710886;3723.2925744108534;230624;235851;236031;236369;236518;53028.46971530235;53167.20249196265;53285;53345.46654533405;53474.73262633662;56774.71612641993;56837.43162568404;56949;56996;57045.714771426705;12783.296918669377;13210.603681889559;13263.867361326264;13265.867341326657;13320.733585328433;8923;9368.812623747486;9567.234621230285;9846.507674616241;9945.403275803475;16498.83501164973;17042.914785425994;17127.82872171287;17165.914170429067;17210.39763608268;5915.438033386821;5949.345571987078;6004.699765011732;6076.301225359052;6098.420650038239;808.2644793238125;818.4843548564367;824.2046425199711;826.4132465949123;846.9407141500036;24488.387790305027;25389.87305063463;25709.228723138334;25730.6140407894;25754.35614109662;950.3015283766426;960.841461158901;986.063239922077;994.8906968729814;1001.8948010458943;12810.80783788244;13449.932750336382;13684.973626978017;13693.794593081111;13701;123055;123105;123159.38420307841;123307.38346308211;123363;50851;51012.74493627508;51012.74493627508;51013;51022.234666480035;1206.5294535131306;1231.605886116452;1253.5487224598955;1255.5919326218832;1256.2399748152418;24132.638010429506;24205.273841784776;26296.737032630193;26440.206793796217;28495.43009139847;40441;40626.39060414037;40885.59114408937;40915.181696366504;40934;316586;321003;321085;321097.80788361473;321118;20554.79445205529;23049;39017.41473877951;39743.403848942864;42790.35814462723;41752.3737143937;41992.580074198864;42212.366814497196;43080.38392321485;43588;36362.8181859089;36986;37132.25735485329;38039;38406.23187536289;35560.46659300061;36214.63785362113;36298.09254768546;36655.26689466142;36726.26547468982;34766.82616586901;34914.30171396609;35078.64921350754;35208.823955880056;35550.46674299939;31044.394123439903;32524.51213231851;33010.504842426904;33345.499817503245;33392.33215335728;22538.323850284516;22613.66079508776;22819;22837.429064273525;22887.65668515007 17:32:57 INFO - PROCESS | 5934 | |2;jquery.html;336.12439594855385;336.16295424393263;342.8440059772803;350.15961691939344;355.43308423065236;16509.917450412748;17882.821171788277;17915.641687166248;17955.102244887737;18211;16484.175791210422;17293.30826766931;18065.36771213008;18234;18269.725954110698;4898.5101489850995;5124.871878203037;5145.0481660892665;5148.665336753118;5167.509086636783;3894.941575876364;4060.045889216032;5060.367454068241;5092.414372347172;5771.769129234846;5961.5230781537375;6041.1844401005965;6046.941785187597;6056.848578785543;6065.332813390523;5857.062869940789;5926.614770039933;5980.491658209057;5984.162217289583;6083.726232319534;5210.97394513025;5220.765065572058;5223.947760522384;5226;5271.578273738091;21658.35024949238;22062;22096.226632067963;22305.888470557704;22455.326340209656;2183.7379514458207;2223.132978138527;2228.977710222893;2256.5035692147867;2262.3439202631216;13610.251436171007;13623.863761362358;13889.513867014606;14187.64530886736;14222.644433889132;1759.6216813385056;1791.4715159028117;1815.0471002723543;1826.1508398594717;1852.7220916862443;77815.83276250861;77940.22059779386;79439;80480.59759701164;81348;9393.62425502986;9524.571394287274;9567.952160239294;9584.424934503813;9604.807903841884;12678.492860285669;12710.364481775874;12736.681582960315;12750.362481875869;12764.042696797776;6604.86790264192;6681.632510211985;6884.965575172092;6938.236793952661;6972.1981972072845;6365.236171659338;6373.808785736435;6512.185976752906;6521.9673901630185;6528.67356632176;6239.344868788802;6386.489080873519;6430.131932189188;6439.5170362223025;6487.513436492282;1534.1792141204403;1606.8955517891534;1668.7580300856307;1707.7096893527882;1717.604950861309;781.8709912864314;860.9483430994161;894.2354287084579;895.91936725695;905.62869223618;17841.286348545913;18273.451796446127;18748.437546873614;18834.434966951012;19176.137073831713;896.7489103051156;913.7624217703445;917.7017469322496;918.2057520245073;921.8432866412726;10583.62957296491;10716.048151932837;10783.594663706439;10805.227823461664;10807.911232082031;480030;491571;529597;536055;537483;78485;79219;79233.60383198163;79267;79808;955.8231727130503;986.9457179855033;996.6163027234422;1005.7737009172878;1007.9496025198711;14832.406703732162;15624.765628515353;15721.371145154524;16008.759868602214;16399.91800040992;35767.28465430729;36876.26247475089;37810.81094594509;37963.43054854124;38558.80720596379;53755.19367209417;54001.18998215108;55604.72197638986;56179.71910140587;56464.717676413;7151.8569628608175;7480.177180510248;7501.1373692023935;7687.308142267223;8094.069182044141;9704.563294651616;11825.70435739079;11912.583059592873;12451.813222801846;12523.74952500963;9866.506674666382;9943.502824858873;9987.350822196535;10044.748881278027;10708.625198118028;10463.895361046596;10609.89390106089;10899.346039237671;10908.181886358396;11334.376609286568;10354.326968747007;10493.108085812486;10600.46997650099;10610.522526486173;11055.447227638746;7667.121555219007;7710.498817576839;7792.220777922163;7913.881291780513;8140.959295203486;7497.062867141607;10056.64801731936;10121.898781012096;10221.591136354462;10844.67465976022 17:32:57 INFO - PROCESS | 5934 | |3;mootools.html;1315.5264104922226;1325.3572017571482;1328.2229895511125;1331.7336532693462;1333.63991722235;6366.363363663631;6692.096566963464;6704.463642908568;6704.5306828522025;6730.495212859037;5874.970625146868;6002.579819412632;6040.758369665219;6121.357257487966;6585.769498067569;1827.3878250786004;1964.666006778844;2006.0972562346928;2014.29499675114;2030.370585118618;2029.5433527456278;2038.1745393115739;2042.7038079478466;2047.2220556188702;2055.537504061582;1861.795202527721;1942.2619404626294;1959.5590992026823;1959.9706004409945;1962.038601085465;1805.1064722962153;1848.7966323704381;1977.5847072114873;2026.6554685703466;2028.503016760903;2026.2604149485478;2038.3375402994086;2040.6122836660986;2041.8162365387186;2044.7444069491314;6655.534112612119;6691.3308669133185;6715.2277488089;6716.664166791641;6725.159355080615;3942.3692209246383;4057.5536690963972;4069.511658600957;4077.3068578341754;4082.326416141333;2551.9234422967343;2604.8249711490926;2731.549294366427;2734.3437574981863;2746.6841313248833;1071.4589132488122;1086.7717779266363;1090.0462095666292;1104.7072525780675;1115.4868760370239;8016.358691304682;8262.586870656443;8330.750077497685;8456.8731469028;8568.143185681445;3480.7215422766117;3523.788572685647;3591.712662986955;3605.441156620728;3610.368185567515;7051.858962820817;7076.716931322792;7079.681414336367;7082.681279342339;7117.537360071578;3861.691064714816;3867.41988701697;3874.8837534873437;3876.5154355705536;3877.6703980161437;3597.4963505109304;3598.7480876338404;3605.531280933462;3614.7288953328607;3615.3311637347174;3057.9541306880415;3078.338157296192;3089.58290630762;3111.393278310753;3183.6179658440674;913.5888850017519;917.2936838634214;923.0677016213539;924.2513564013171;926.1016813690709;777.9572123533147;806.7418426103591;811.4522697179498;818.0551463060175;819.8893149424752;4302.139572085595;4317.395564620955;4437.2234858899565;4452.755098469615;4557.703749256288;466.3936882053317;483.7387810582246;491.268010664115;493.93331900193016;500.7246014691905;2980.344324248662;3159.6682348353092;3166.3825554016744;3179.1257404213566;3231.8384080795868;7357.668904899292;7662.540247585162;7758.3017528422715;7774.1837107104075;7864.960675196702;7666.3866890648615;7675.15573286938;7732.188120247405;7743.845123097619;7851.411144164096;6135.662538560422;6235.906461403082;6239.157713708682;6239.844003899939;6243.8126856195295;4402.053558484941;4417.491988421372;4451.265541185668;4478.126765280739;4496.662750293675;6922.376986071277;6971.79084627462;6973.546719463218;6994.475414343843;7020.859582808213;7097.219305876246;7146.785596432115;7193.892091618734;7213.819654508679;7256.310650488195;5555.472230138131;5589.329280486205;5592.972035139798;5595.328560572757;5599.804006859903;6178.5366097543765;6179.196704428396;6189.164462797465;6223.471004964629;6231.563790534619;5696.943030569641;5714.342840576186;5746.5402767779315;5762.250907382014;5892.263467066617;5252.107141785829;5284.319356691649;5293.470652934676;5320.361556613231;5448.972755136199;5146.533238027144;5210.791568337224;5212.635115541876;5221.712805795718;5226.790928362823;3271.8854840081435;3966.8809935701975;4040.3333449980423;4071.0840060986043;4177.436046133855;4056.513218413809;4062.688908539531;4069.7354671947414;4140.979295103505;4196.979015104905 17:32:57 INFO - PROCESS | 5934 | |4;prototype.html;312.1151535397149;312.88110518003157;318.51903625525455;327.2865153964357;327.4237342277594;4811.855644330667;4859.659823812334;4886.462489126193;4902.2891680706325;4977.477364876681;4856.882916929099;4879.316375993199;4892.5596696297325;4903.82836600719;4906.509349065101;3688.5758137814228;3773.8490460381554;3816.255830113129;3860.8455661773637;3916.3929590913453;3894.9805250973704;3902.6292502212245;3910.159315747114;3913.31516984528;3922.62681077948;3852.4397618964363;3861.8455261789495;3874.767513949172;3880.4866102220158;3916.608339166075;3726.6956565202236;3807.6382743639588;3827.655511004009;3875.9418608720894;3887.067103895073;3439.4152993991083;3449.9655003449893;3455.8963231102857;3457.239407330383;3460.3079384123275;4756.9286460703115;4772.284157376422;4775.2598347256235;4787.635523875679;4811.8075276988875;4299.161663475624;4358.629516491102;4375.431193944767;4398.194383413895;4442.689011769177;5061.609386003931;5069.264956581275;5077.873053173664;5082.974585127051;5116.769745361467;3739.8967304645194;3741;3743.529270681337;3748.100455890594;3749.137698329372;5230.947690523084;5331.466853314715;5348.946510534884;5353.598480114007;5373.9731301343245;3803.3154032274456;3816.923661526754;3819.4461803038403;3826.693864490834;3841.4634146341687;3877.554081280689;3888.669463095612;3889.7860617665733;3899.668528175137;3903.2974064668065;4353.194658988034;4397.714148580396;4401.955980440219;4423.982484028691;4426.004149066434;4813.927791083137;5057.317262169634;5070.391553013588;5075.796968121308;5100.6684565503865;1219.384315781593;1220.8962238209851;1225.5342969671647;1227.6623928419756;1234.7900856854176;782.1396463889675;794.3168874767695;829.9128591497806;842.5366048673205;842.877782721502;4228.77365563983;4308.3968244445805;4429.313456414261;4435.913201265646;4448.822047118144;5182.4299327073995;5201.817936372285;5205.271262023244;5209.6353255272525;5213.661112027706;4435.6895017349125;4457.398251236042;4469.324003498688;4476.440444944382;4489.371487991683;2584.5218634552293;2719.9528181650207;2721.18364490652;2721.3060669529145;2723.9591406128925;4766.926387021656;4781.784819683123;4791.425028996543;4801.68789028719;4815.542523460265;5101.648063263238;5175.024360992445;5250.606204534675;5255.474452554714;5272;4910.410750709938;4916.385451818451;4922.483139270396;4928.088303663833;4966.850994470172;5244.816431424882;5254.97372513135;5266.86832829167;5282.4944890705965;5299.205119232146;4940.802367905244;5189.884174902414;5194.766235519335;5209.619450845453;5225.947740522698;4899.730514821719;4900.921797204609;4906.165951788276;4911.091448082117;4940.901181976412;3576.159602493464;3589.6410358963894;3617.6744093031753;3627.383344831332;3628.546431696038;5103.489651034867;5199.74001299941;5230.8169214077325;5233.502817232356;5251.684898906078;5052.8484145475695;5071.923921141112;5073.3325340685915;5075.1625981712605;5087.135187018142;5054.69671819692;5083.517065878736;5102.413222479314;5140.742962851918;5156.381234251764;4779.689320194177;4992.825251116194;5033.446320904624;5049.995252824563;5060.569851562511;4897.681650692693;4935.580475659609;5032.748362581783;5097.464766199644;5120.385553733576;4984.775685094252;4987.750612469435;4995.425526064549;5027.522385373383;5037.0681423936685 17:32:57 INFO - PROCESS | 5934 | |5;yui.html;642.2036674523592;653.8888388973877;728.4427413029031;770.4144849914065;775.9961200194;12491.812622810654;13620.114692545003;13640.795388069162;13647.795283070736;13652.863471365295;13003.154794938322;13076.476940922352;13130.671733206651;13142.948564114871;13189.340532973338;658.8517583543688;676.4520738202073;789.2423273657296;795.1055063054064;802.3260461212581;812.3460614205562;812.6018251056969;813.4631143445328;813.9674413023472;814.2102160903943;849.6346570974479;857.7855536115972;857.8884744983144;857.9356548258875;858.4934888415834;687.0518684215775;706.5019161491163;913.2009491694768;937.2408349237139;942.4675058591873;613.7176898626637;613.9723712432951;614.2935624032353;614.7633161232912;615.1388056720582;12843.550475733398;12852.228866268053;12876.678083047906;12896;12898.935505322506;14322.57032289033;14323.856761432357;14365.353559089866;14453.205073720941;14464.349104290332;10453.738656533571;10546;10666.306690065121;10715.571377144905;10766.24636275461;3387.8644854205804;3413.0784688134313;3415.1462134466383;3428.9142771430916;3472.4444088945647;60245;60984.39015609876;61084.694576527276;61341;61975.6901215491;9873.60505579783;9894.455804930798;10339.172866170687;10360.844587331196;10892.673219803419;19398.538336182755;20031.799682002995;20089.09599068016;20289.59420811605;20464.897675511525;7014.614196219155;7076.8278560875215;7183.138023437221;7195.280471952763;7320.853582928418;3774.9811250944117;3781.962180378216;3829.808509574566;3856.9614303857165;3863.613638636114;3034.9529412352704;3078.492048811921;3099.860506277223;3101.8368111958016;3105.4410206162656;517.5006119095091;524.9553787928069;526.9394019687709;531.2880739808675;538.9571179767084;657.3163909534127;664.8470851704135;674.689642764324;675.7161991963387;696.3663066609463;8899.243564296978;9393.671221507215;9534.809303813885;9629.518524073768;9647.372920760128;658.9077529145924;665.4842497064814;674.3020973292716;678.8574399376088;679.1103654212997;4462.843800466968;4520.186366454004;4520.932186017212;4524.796384162721;4527.1172121436;51012.74493627508;52967.735161323944;53136.202956955676;70968.64515677492;72708.63645681844;45225.321620175724;47810.521894780606;53334.46665533295;56005.719971399885;57357.13964290539;49189.754051229516;49496.75251623719;50104;50173;52861.99999999923;9069.727908162766;9490;9499.335046546676;9513.096255855682;9517.286203534624;30799;32585.674143258264;33325;34388.70141232346;36232.45651315285;42296.1540769189;45558.49428281476;47015.294770577784;47331;48050.759746201045;11238.213325067167;11824.763504729684;11871.643850684493;12051.879481205076;12178.08664350195;12032;12453.813192802296;13036.543720969721;13074.215547067206;13946.930265349014;10436.895631043591;11904.880951190376;12134.817977730518;12428.192167509083;13251.469941202244;12187.329696866758;12456.252624842538;13025.739485210432;13222.206667599974;13570.59288221355;12208.45061972231;12262.754744904874;12420.565280215511;13105.427348718214;13131.277779722206;10505.15958723285;10714.30357026822;10943.513159604523;10998.780024399308;11144.164187686118;10057.899421005697;10238.92491288404;10334.224933130195;10366.637167699095;10487.423191724529 17:32:57 INFO - PROCESS | 5934 | __end_tp_report 17:32:57 INFO - PROCESS | 5934 | __start_cc_report 17:32:57 INFO - PROCESS | 5934 | _x_x_mozilla_cycle_collect,2577 17:32:57 INFO - PROCESS | 5934 | __end_cc_report 17:32:57 INFO - PROCESS | 5934 | __startTimestamp1484011977578__endTimestamp 17:32:57 INFO - PROCESS | 5934 | 17:32:57 INFO - PROCESS | 5934 | ------- Summary: start ------- 17:32:57 INFO - PROCESS | 5934 | Number of tests: 6 17:32:57 INFO - PROCESS | 5934 | 17:32:57 INFO - PROCESS | 5934 | [#0] dojo.html Cycles:165 Average:4677.34 Median:4776.79 stddev:490.76 (10.3%) stddev-sans-first:463.63 17:32:57 INFO - PROCESS | 5934 | Values: 2571.6 2576.1 2603.7 2605.4 2611.0 4673.2 4733.3 4757.9 4758.2 4776.8 4697.3 4706.2 4746.0 4746.2 4757.0 4359.0 4386.6 4428.0 4443.8 4494.7 3982.9 4340.9 4444.6 4471.7 4522.6 4318.3 4343.8 4378.1 4378.6 4460.0 4340.3 4366.4 4377.0 4391.4 4452.4 4359.5 4366.1 4366.6 4370.0 4407.2 4696.6 4720.8 4726.1 4731.6 4773.8 4980.7 5040.7 5067.2 5109.7 5110.2 5129.9 5133.9 5148.9 5153.3 5186.1 4743.2 4744.6 4746.5 4785.9 4807.2 5064.9 5110.6 5138.0 5170.7 5299.8 4968.1 4971.4 4973.3 5022.7 5026.6 4970.3 5001.5 5036.3 5038.5 5085.2 5019.6 5019.9 5022.1 5026.6 5038.7 4876.5 4916.4 4923.2 4941.9 4983.4 4261.8 4266.7 4274.6 4280.3 4310.4 3716.7 3765.4 3766.5 3774.1 3779.1 4341.2 4361.1 4371.8 4384.0 4388.7 5085.2 5087.8 5091.5 5107.4 5131.9 4379.0 4381.2 4383.4 4421.8 4424.5 4469.0 4511.9 4527.0 4596.3 4599.3 4692.7 4716.0 4721.0 4762.5 4765.3 4996.6 5030.9 5041.9 5042.8 5075.9 4660.2 4686.6 4706.4 4724.4 4758.2 4929.1 4972.9 4974.7 4978.7 4980.1 5043.2 5048.6 5050.1 5052.5 5055.0 4918.3 4928.7 4933.9 4938.7 4939.5 4904.7 4937.4 4940.8 4948.2 4953.5 4893.8 4895.3 4898.0 4900.1 4907.5 4896.0 4934.8 4971.7 4989.2 4997.1 4861.7 4863.9 4866.1 4868.2 4914.0 17:32:57 INFO - PROCESS | 5934 | 17:32:57 INFO - PROCESS | 5934 | [#1] ext.html Cycles:180 Average:39833.99 Median:36690.77 stddev:63103.23 (172.0%) stddev-sans-first:63211.25 17:32:57 INFO - PROCESS | 5934 | Values: 531.7 568.3 574.0 590.2 607.8 34757.8 38269.0 38276.4 38311.6 38413.4 38611.0 39182.8 39227.8 39229.8 39259.8 7525.4 7585.7 7721.6 7779.2 7785.0 9965.7 10255.7 10274.3 10539.1 10541.8 10235.9 10306.4 10314.3 10319.3 10321.9 9768.3 9810.7 9821.6 9823.1 9827.4 10055.4 10124.9 10126.2 10128.2 10128.5 38412.8 38714.0 38725.2 38748.8 38806.0 3709.6 3771.3 3780.1 3818.5 3838.8 28169.0 28360.9 28971.6 29107.6 29163.3 3528.7 3533.6 3652.7 3711.0 3723.3 230624.0 235851.0 236031.0 236369.0 236518.0 53028.5 53167.2 53285.0 53345.5 53474.7 56774.7 56837.4 56949.0 56996.0 57045.7 12783.3 13210.6 13263.9 13265.9 13320.7 8923.0 9368.8 9567.2 9846.5 9945.4 16498.8 17042.9 17127.8 17165.9 17210.4 5915.4 5949.3 6004.7 6076.3 6098.4 808.3 818.5 824.2 826.4 846.9 24488.4 25389.9 25709.2 25730.6 25754.4 950.3 960.8 986.1 994.9 1001.9 12810.8 13449.9 13685.0 13693.8 13701.0 123055.0 123105.0 123159.4 123307.4 123363.0 50851.0 51012.7 51012.7 51013.0 51022.2 1206.5 1231.6 1253.5 1255.6 1256.2 24132.6 24205.3 26296.7 26440.2 28495.4 40441.0 40626.4 40885.6 40915.2 40934.0 316586.0 321003.0 321085.0 321097.8 321118.0 20554.8 23049.0 39017.4 39743.4 42790.4 41752.4 41992.6 42212.4 43080.4 43588.0 36362.8 36986.0 37132.3 38039.0 38406.2 35560.5 36214.6 36298.1 36655.3 36726.3 34766.8 34914.3 35078.6 35208.8 35550.5 31044.4 32524.5 33010.5 33345.5 33392.3 22538.3 22613.7 22819.0 22837.4 22887.7 17:32:57 INFO - PROCESS | 5934 | 17:32:57 INFO - PROCESS | 5934 | [#2] jquery.html Cycles:180 Average:28579.13 Median:248234.76 stddev:84666.42 (34.1%) stddev-sans-first:84877.38 17:32:57 INFO - PROCESS | 5934 | Values: 336.1 336.2 342.8 350.2 355.4 16509.9 17882.8 17915.6 17955.1 18211.0 16484.2 17293.3 18065.4 18234.0 18269.7 4898.5 5124.9 5145.0 5148.7 5167.5 3894.9 4060.0 5060.4 5092.4 5771.8 5961.5 6041.2 6046.9 6056.8 6065.3 5857.1 5926.6 5980.5 5984.2 6083.7 5211.0 5220.8 5223.9 5226.0 5271.6 21658.4 22062.0 22096.2 22305.9 22455.3 2183.7 2223.1 2229.0 2256.5 2262.3 13610.3 13623.9 13889.5 14187.6 14222.6 1759.6 1791.5 1815.0 1826.2 1852.7 77815.8 77940.2 79439.0 80480.6 81348.0 9393.6 9524.6 9568.0 9584.4 9604.8 12678.5 12710.4 12736.7 12750.4 12764.0 6604.9 6681.6 6885.0 6938.2 6972.2 6365.2 6373.8 6512.2 6522.0 6528.7 6239.3 6386.5 6430.1 6439.5 6487.5 1534.2 1606.9 1668.8 1707.7 1717.6 781.9 860.9 894.2 895.9 905.6 17841.3 18273.5 18748.4 18834.4 19176.1 896.7 913.8 917.7 918.2 921.8 10583.6 10716.0 10783.6 10805.2 10807.9 480030.0 491571.0 529597.0 536055.0 537483.0 78485.0 79219.0 79233.6 79267.0 79808.0 955.8 986.9 996.6 1005.8 1007.9 14832.4 15624.8 15721.4 16008.8 16399.9 35767.3 36876.3 37810.8 37963.4 38558.8 53755.2 54001.2 55604.7 56179.7 56464.7 7151.9 7480.2 7501.1 7687.3 8094.1 9704.6 11825.7 11912.6 12451.8 12523.7 9866.5 9943.5 9987.4 10044.7 10708.6 10463.9 10609.9 10899.3 10908.2 11334.4 10354.3 10493.1 10600.5 10610.5 11055.4 7667.1 7710.5 7792.2 7913.9 8141.0 7497.1 10056.6 10121.9 10221.6 10844.7 17:32:57 INFO - PROCESS | 5934 | 17:32:57 INFO - PROCESS | 5934 | [#3] mootools.html Cycles:180 Average:4282.84 Median:475.07 stddev:2251.56 (473.9%) stddev-sans-first:2246.83 17:32:57 INFO - PROCESS | 5934 | Values: 1315.5 1325.4 1328.2 1331.7 1333.6 6366.4 6692.1 6704.5 6704.5 6730.5 5875.0 6002.6 6040.8 6121.4 6585.8 1827.4 1964.7 2006.1 2014.3 2030.4 2029.5 2038.2 2042.7 2047.2 2055.5 1861.8 1942.3 1959.6 1960.0 1962.0 1805.1 1848.8 1977.6 2026.7 2028.5 2026.3 2038.3 2040.6 2041.8 2044.7 6655.5 6691.3 6715.2 6716.7 6725.2 3942.4 4057.6 4069.5 4077.3 4082.3 2551.9 2604.8 2731.5 2734.3 2746.7 1071.5 1086.8 1090.0 1104.7 1115.5 8016.4 8262.6 8330.8 8456.9 8568.1 3480.7 3523.8 3591.7 3605.4 3610.4 7051.9 7076.7 7079.7 7082.7 7117.5 3861.7 3867.4 3874.9 3876.5 3877.7 3597.5 3598.7 3605.5 3614.7 3615.3 3058.0 3078.3 3089.6 3111.4 3183.6 913.6 917.3 923.1 924.3 926.1 778.0 806.7 811.5 818.1 819.9 4302.1 4317.4 4437.2 4452.8 4557.7 466.4 483.7 491.3 493.9 500.7 2980.3 3159.7 3166.4 3179.1 3231.8 7357.7 7662.5 7758.3 7774.2 7865.0 7666.4 7675.2 7732.2 7743.8 7851.4 6135.7 6235.9 6239.2 6239.8 6243.8 4402.1 4417.5 4451.3 4478.1 4496.7 6922.4 6971.8 6973.5 6994.5 7020.9 7097.2 7146.8 7193.9 7213.8 7256.3 5555.5 5589.3 5593.0 5595.3 5599.8 6178.5 6179.2 6189.2 6223.5 6231.6 5696.9 5714.3 5746.5 5762.3 5892.3 5252.1 5284.3 5293.5 5320.4 5449.0 5146.5 5210.8 5212.6 5221.7 5226.8 3271.9 3966.9 4040.3 4071.1 4177.4 4056.5 4062.7 4069.7 4141.0 4197.0 17:32:57 INFO - PROCESS | 5934 | 17:32:57 INFO - PROCESS | 5934 | [#4] prototype.html Cycles:180 Average:4234.89 Median:4812.89 stddev:1224.20 (25.4%) stddev-sans-first:1191.70 17:32:57 INFO - PROCESS | 5934 | Values: 312.1 312.9 318.5 327.3 327.4 4811.9 4859.7 4886.5 4902.3 4977.5 4856.9 4879.3 4892.6 4903.8 4906.5 3688.6 3773.8 3816.3 3860.8 3916.4 3895.0 3902.6 3910.2 3913.3 3922.6 3852.4 3861.8 3874.8 3880.5 3916.6 3726.7 3807.6 3827.7 3875.9 3887.1 3439.4 3450.0 3455.9 3457.2 3460.3 4756.9 4772.3 4775.3 4787.6 4811.8 4299.2 4358.6 4375.4 4398.2 4442.7 5061.6 5069.3 5077.9 5083.0 5116.8 3739.9 3741.0 3743.5 3748.1 3749.1 5230.9 5331.5 5348.9 5353.6 5374.0 3803.3 3816.9 3819.4 3826.7 3841.5 3877.6 3888.7 3889.8 3899.7 3903.3 4353.2 4397.7 4402.0 4424.0 4426.0 4813.9 5057.3 5070.4 5075.8 5100.7 1219.4 1220.9 1225.5 1227.7 1234.8 782.1 794.3 829.9 842.5 842.9 4228.8 4308.4 4429.3 4435.9 4448.8 5182.4 5201.8 5205.3 5209.6 5213.7 4435.7 4457.4 4469.3 4476.4 4489.4 2584.5 2720.0 2721.2 2721.3 2724.0 4766.9 4781.8 4791.4 4801.7 4815.5 5101.6 5175.0 5250.6 5255.5 5272.0 4910.4 4916.4 4922.5 4928.1 4966.9 5244.8 5255.0 5266.9 5282.5 5299.2 4940.8 5189.9 5194.8 5209.6 5225.9 4899.7 4900.9 4906.2 4911.1 4940.9 3576.2 3589.6 3617.7 3627.4 3628.5 5103.5 5199.7 5230.8 5233.5 5251.7 5052.8 5071.9 5073.3 5075.2 5087.1 5054.7 5083.5 5102.4 5140.7 5156.4 4779.7 4992.8 5033.4 5050.0 5060.6 4897.7 4935.6 5032.7 5097.5 5120.4 4984.8 4987.8 4995.4 5027.5 5037.1 17:32:57 INFO - PROCESS | 5934 | 17:32:57 INFO - PROCESS | 5934 | [#5] yui.html Cycles:180 Average:14682.99 Median:4520.56 stddev:17394.06 (384.8%) stddev-sans-first:17410.89 17:32:57 INFO - PROCESS | 5934 | Values: 642.2 653.9 728.4 770.4 776.0 12491.8 13620.1 13640.8 13647.8 13652.9 13003.2 13076.5 13130.7 13142.9 13189.3 658.9 676.5 789.2 795.1 802.3 812.3 812.6 813.5 814.0 814.2 849.6 857.8 857.9 857.9 858.5 687.1 706.5 913.2 937.2 942.5 613.7 614.0 614.3 614.8 615.1 12843.6 12852.2 12876.7 12896.0 12898.9 14322.6 14323.9 14365.4 14453.2 14464.3 10453.7 10546.0 10666.3 10715.6 10766.2 3387.9 3413.1 3415.1 3428.9 3472.4 60245.0 60984.4 61084.7 61341.0 61975.7 9873.6 9894.5 10339.2 10360.8 10892.7 19398.5 20031.8 20089.1 20289.6 20464.9 7014.6 7076.8 7183.1 7195.3 7320.9 3775.0 3782.0 3829.8 3857.0 3863.6 3035.0 3078.5 3099.9 3101.8 3105.4 517.5 525.0 526.9 531.3 539.0 657.3 664.8 674.7 675.7 696.4 8899.2 9393.7 9534.8 9629.5 9647.4 658.9 665.5 674.3 678.9 679.1 4462.8 4520.2 4520.9 4524.8 4527.1 51012.7 52967.7 53136.2 70968.6 72708.6 45225.3 47810.5 53334.5 56005.7 57357.1 49189.8 49496.8 50104.0 50173.0 52862.0 9069.7 9490.0 9499.3 9513.1 9517.3 30799.0 32585.7 33325.0 34388.7 36232.5 42296.2 45558.5 47015.3 47331.0 48050.8 11238.2 11824.8 11871.6 12051.9 12178.1 12032.0 12453.8 13036.5 13074.2 13946.9 10436.9 11904.9 12134.8 12428.2 13251.5 12187.3 12456.3 13025.7 13222.2 13570.6 12208.5 12262.8 12420.6 13105.4 13131.3 10505.2 10714.3 10943.5 10998.8 11144.2 10057.9 10238.9 10334.2 10366.6 10487.4 17:32:57 INFO - PROCESS | 5934 | -------- Summary: end -------- 17:32:57 INFO - PROCESS | 5934 | 17:32:58 INFO - TEST-INFO | 5934: exit 0 17:32:58 INFO - TEST-OK | dromaeo_css | took 1121263ms 17:32:58 INFO - TEST-START | kraken 17:32:58 INFO - operating with platform_type : linux_ 17:32:58 INFO - Initialising browser for kraken test... 17:32:58 INFO - TEST-INFO | started process 6234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6iRaPM/profile http://localhost:38528/getInfo.html) 17:32:58 INFO - PROCESS | 6234 | 1484011978915 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 17:33:02 INFO - PROCESS | 6234 | __metrics Screen width/height:1600/1200 17:33:02 INFO - PROCESS | 6234 | colorDepth:24 17:33:02 INFO - PROCESS | 6234 | Browser inner width/height: 1024/697 17:33:02 INFO - PROCESS | 6234 | __metrics 17:33:03 INFO - PROCESS | 6234 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:33:03 INFO - PROCESS | 6234 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:33:03 INFO - PROCESS | 6234 | console.error: PushService: 17:33:03 INFO - PROCESS | 6234 | stateChangeProcessEnqueue: Error transitioning state 17:33:03 INFO - PROCESS | 6234 | UnknownError 17:33:04 INFO - TEST-INFO | 6234: exit 0 17:33:04 INFO - Browser initialized. 17:33:04 INFO - Running cycle 1/1 for kraken test... 17:33:04 INFO - TEST-INFO | started process 6314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6iRaPM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:33:16 INFO - PROCESS | 6314 | RSS: Main: 151949312 17:33:16 INFO - PROCESS | 6314 | 17:33:19 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38528/tests/kraken/driver.html?testName=audio-beat-detection) 17:33:20 INFO - PROCESS | 6314 | RSS: Main: 205791232 17:33:20 INFO - PROCESS | 6314 | 17:33:22 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38528/tests/kraken/driver.html?testName=audio-dft) 17:33:23 INFO - PROCESS | 6314 | RSS: Main: 185765888 17:33:23 INFO - PROCESS | 6314 | 17:33:26 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38528/tests/kraken/driver.html?testName=audio-fft) 17:33:27 INFO - PROCESS | 6314 | RSS: Main: 268152832 17:33:27 INFO - PROCESS | 6314 | 17:33:29 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38528/tests/kraken/driver.html?testName=audio-oscillator) 17:33:29 INFO - PROCESS | 6314 | RSS: Main: 179326976 17:33:29 INFO - PROCESS | 6314 | 17:33:32 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38528/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:33:32 INFO - PROCESS | 6314 | RSS: Main: 182534144 17:33:32 INFO - PROCESS | 6314 | 17:33:35 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38528/tests/kraken/driver.html?testName=imaging-darkroom) 17:33:36 INFO - PROCESS | 6314 | RSS: Main: 222101504 17:33:36 INFO - PROCESS | 6314 | 17:33:39 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38528/tests/kraken/driver.html?testName=imaging-desaturate) 17:33:40 INFO - PROCESS | 6314 | RSS: Main: 221900800 17:33:40 INFO - PROCESS | 6314 | 17:33:43 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38528/tests/kraken/driver.html?testName=json-parse-financial) 17:33:43 INFO - PROCESS | 6314 | RSS: Main: 220127232 17:33:43 INFO - PROCESS | 6314 | 17:33:45 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38528/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:33:46 INFO - PROCESS | 6314 | RSS: Main: 183140352 17:33:46 INFO - PROCESS | 6314 | 17:33:48 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:33:48 INFO - PROCESS | 6314 | RSS: Main: 190361600 17:33:48 INFO - PROCESS | 6314 | 17:33:51 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:33:51 INFO - PROCESS | 6314 | RSS: Main: 198651904 17:33:51 INFO - PROCESS | 6314 | 17:33:54 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:33:55 INFO - PROCESS | 6314 | RSS: Main: 201924608 17:33:55 INFO - PROCESS | 6314 | 17:33:58 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:33:58 INFO - PROCESS | 6314 | RSS: Main: 203309056 17:33:58 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38528/tests/kraken/driver.html?testName=ai-astar) 17:34:00 INFO - PROCESS | 6314 | RSS: Main: 253415424 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | __start_tp_report 17:34:00 INFO - PROCESS | 6314 | _x_x_mozilla_page_load 17:34:00 INFO - PROCESS | 6314 | _x_x_mozilla_page_load_details 17:34:00 INFO - PROCESS | 6314 | |i|pagename|runs| 17:34:00 INFO - PROCESS | 6314 | |0;ai-astar;107;116;116;116;114;117;116;114;115;114 17:34:00 INFO - PROCESS | 6314 | |1;audio-beat-detection;150;125;131;163;127;124;125;125;144;123 17:34:00 INFO - PROCESS | 6314 | |2;audio-dft;160;162;161;163;162;162;162;162;160;160 17:34:00 INFO - PROCESS | 6314 | |3;audio-fft;77;79;77;113;77;76;76;76;93;76 17:34:00 INFO - PROCESS | 6314 | |4;audio-oscillator;86;84;106;84;85;85;97;85;84;115 17:34:00 INFO - PROCESS | 6314 | |5;imaging-gaussian-blur;117;117;116;117;117;117;118;118;117;117 17:34:00 INFO - PROCESS | 6314 | |6;imaging-darkroom;150;150;151;148;149;149;149;149;149;149 17:34:00 INFO - PROCESS | 6314 | |7;imaging-desaturate;96;95;95;95;95;96;95;96;95;95 17:34:00 INFO - PROCESS | 6314 | |8;json-parse-financial;58;58;59;59;61;60;62;59;61;61 17:34:00 INFO - PROCESS | 6314 | |9;json-stringify-tinderbox;67;68;69;67;68;67;69;68;67;67 17:34:00 INFO - PROCESS | 6314 | |10;stanford-crypto-aes;85;84;83;94;93;87;84;94;83;83 17:34:00 INFO - PROCESS | 6314 | |11;stanford-crypto-ccm;147;145;130;140;136;137;138;130;216;139 17:34:00 INFO - PROCESS | 6314 | |12;stanford-crypto-pbkdf2;175;179;181;178;182;184;185;179;176;180 17:34:00 INFO - PROCESS | 6314 | |13;stanford-crypto-sha256-iterative;68;73;68;68;68;68;67;67;67;67 17:34:00 INFO - PROCESS | 6314 | __end_tp_report 17:34:00 INFO - PROCESS | 6314 | __start_cc_report 17:34:00 INFO - PROCESS | 6314 | _x_x_mozilla_cycle_collect,1844 17:34:00 INFO - PROCESS | 6314 | __end_cc_report 17:34:00 INFO - PROCESS | 6314 | __startTimestamp1484012040857__endTimestamp 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | ------- Summary: start ------- 17:34:00 INFO - PROCESS | 6314 | Number of tests: 14 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#0] ai-astar Cycles:10 Average:114.50 Median:116.00 stddev:2.84 (2.4%) stddev-sans-first:1.12 17:34:00 INFO - PROCESS | 6314 | Values: 107.0 116.0 116.0 116.0 114.0 117.0 116.0 114.0 115.0 114.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:129.00 stddev:13.82 (10.7%) stddev-sans-first:13.34 17:34:00 INFO - PROCESS | 6314 | Values: 150.0 125.0 131.0 163.0 127.0 124.0 125.0 125.0 144.0 123.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.01 17:34:00 INFO - PROCESS | 6314 | Values: 160.0 162.0 161.0 163.0 162.0 162.0 162.0 162.0 160.0 160.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.00 stddev:12.06 (15.7%) stddev-sans-first:12.66 17:34:00 INFO - PROCESS | 6314 | Values: 77.0 79.0 77.0 113.0 77.0 76.0 76.0 76.0 93.0 76.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:85.00 stddev:11.14 (13.1%) stddev-sans-first:11.66 17:34:00 INFO - PROCESS | 6314 | Values: 86.0 84.0 106.0 84.0 85.0 85.0 97.0 85.0 84.0 115.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:34:00 INFO - PROCESS | 6314 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 17:34:00 INFO - PROCESS | 6314 | Values: 150.0 150.0 151.0 148.0 149.0 149.0 149.0 149.0 149.0 149.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 17:34:00 INFO - PROCESS | 6314 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.50 stddev:1.40 (2.3%) stddev-sans-first:1.32 17:34:00 INFO - PROCESS | 6314 | Values: 58.0 58.0 59.0 59.0 61.0 60.0 62.0 59.0 61.0 61.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 17:34:00 INFO - PROCESS | 6314 | Values: 67.0 68.0 69.0 67.0 68.0 67.0 69.0 68.0 67.0 67.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.00 stddev:4.76 (5.5%) stddev-sans-first:4.99 17:34:00 INFO - PROCESS | 6314 | Values: 85.0 84.0 83.0 94.0 93.0 87.0 84.0 94.0 83.0 83.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:139.50 stddev:25.26 (18.1%) stddev-sans-first:26.79 17:34:00 INFO - PROCESS | 6314 | Values: 147.0 145.0 130.0 140.0 136.0 137.0 138.0 130.0 216.0 139.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.90 Median:180.50 stddev:3.21 (1.8%) stddev-sans-first:2.88 17:34:00 INFO - PROCESS | 6314 | Values: 175.0 179.0 181.0 178.0 182.0 184.0 185.0 179.0 176.0 180.0 17:34:00 INFO - PROCESS | 6314 | 17:34:00 INFO - PROCESS | 6314 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.79 (2.6%) stddev-sans-first:1.90 17:34:00 INFO - PROCESS | 6314 | Values: 68.0 73.0 68.0 68.0 68.0 68.0 67.0 67.0 67.0 67.0 17:34:00 INFO - PROCESS | 6314 | -------- Summary: end -------- 17:34:00 INFO - PROCESS | 6314 | 17:34:01 INFO - TEST-INFO | 6314: exit 0 17:34:02 INFO - TEST-OK | kraken | took 63623ms 17:34:02 INFO - SUITE-END | took 1184s 17:34:02 INFO - Completed test suite (00:19:45) 17:34:02 INFO - javascript benchmark 17:34:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2571.5756900111483, 2576.1369941069743, 2603.687557493101, 2605.4137818990716, 2610.960835587466, 4673.205555055641, 4733.337332773414, 4757.904841903164, 4758.238681810911, 4776.7850446729935, 4697.342372067913, 4706.199946009178, 4746.027064451788, 4746.193147164981, 4756.977249891282, 4358.97820510897, 4386.605205531518, 4428.0, 4443.822247110112, 4494.68537202396, 3982.9203415931665, 4340.913181736363, 4444.622207112399, 4471.709338892962, 4522.592966633002, 4318.3090705486975, 4343.847965321199, 4378.080603073358, 4378.64970802335, 4459.955400446002, 4340.348947657845, 4366.410534577855, 4376.993291542963, 4391.429114215163, 4452.4211852458975, 4359.520452750195, 4366.08312254427, 4366.585174408426, 4370.0, 4407.206702793496, 4696.600788932945, 4720.76396180193, 4726.0784147091335, 4731.550502702238, 4773.80904763809, 4980.676256043382, 5040.747962601855, 5067.214581739836, 5109.693418394908, 5110.156824124015, 5129.948700512984, 5133.922991155136, 5148.871278218037, 5153.2785410042625, 5186.0665080285535, 4743.241081426955, 4744.644151688637, 4746.5490778376, 4785.856424307276, 4807.230843065163, 5064.949350506447, 5110.591152707774, 5138.0, 5170.715610641376, 5299.761510732026, 4968.080905032581, 4971.4282857471135, 4973.328600638867, 5022.698638081727, 5026.623003274769, 4970.2793095001025, 5001.4998500149695, 5036.320096786887, 5038.470960549163, 5085.186370180753, 5019.648624596316, 5019.949800502021, 5022.096022715946, 5026.572741316956, 5038.697678139323, 4876.487968763229, 4916.434610019822, 4923.163062279421, 4941.876453088702, 4983.377077865267, 4261.765602891809, 4266.743995360288, 4274.615284624399, 4280.293751530962, 4310.353446982977, 3716.6840818530727, 3765.3787125124595, 3766.472693822867, 3774.094217387807, 3779.093017675738, 4341.153475072394, 4361.062371590124, 4371.825126994948, 4384.0, 4388.692791504628, 5085.211792172219, 5087.796488140507, 5091.490850914879, 5107.361579802525, 5131.923021154686, 4379.0, 4381.16757816014, 4383.408239887638, 4421.756803375845, 4424.535423780521, 4468.977655111704, 4511.88720281989, 4527.049319642846, 4596.264597664358, 4599.2871104978785, 4692.718436893729, 4716.0, 4721.032188401438, 4762.547557981986, 4765.26138448541, 4996.625253105959, 5030.874228144179, 5041.924371134362, 5042.823501177441, 5075.87310317245, 4660.161170989254, 4686.648501362343, 4706.411698537683, 4724.433068031858, 4758.214894542501, 4929.088118698052, 4972.9254061188385, 4974.676646017997, 4978.726170060681, 4980.078685443204, 5043.2435134730085, 5048.570871475966, 5050.090983622983, 5052.494750525065, 5055.0, 4918.311436398979, 4928.654994150375, 4933.925991110064, 4938.728369939688, 4939.53074457926, 4904.705717656952, 4937.432195297587, 4940.777665005012, 4948.2082866742585, 4953.504649535162, 4893.828715994923, 4895.314655948241, 4898.0, 4900.1424750667775, 4907.460179380194, 4895.996320754166, 4934.777934992862, 4971.676841005323, 4989.226669866177, 4997.0505603935135, 4861.6596838220985, 4863.90272194547, 4866.099771542276, 4868.2210846264425, 4913.975430122827], "value": 4645.474482566821, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.7394476706413, 568.3407247592793, 573.9713014349283, 590.2179612014082, 607.8085403098027, 34757.826210868945, 38269.0, 38276.425853612185, 38311.61688383122, 38413.42379864301, 38611.0, 39182.80408597953, 39227.80386098065, 39229.80385098071, 39259.80370098146, 7525.397968162534, 7585.7344992925255, 7721.613919304041, 7779.18318576547, 7785.026871641045, 9965.701028969142, 10255.743606409826, 10274.280800343979, 10539.104176145036, 10541.78916421671, 10235.897641023606, 10306.381617102961, 10314.329568578018, 10319.277650564425, 10321.948390258076, 9768.316217864753, 9810.65662701802, 9821.607135714563, 9823.066808653166, 9827.4103553787, 10055.446950417723, 10124.94937525315, 10126.240531960133, 10128.189744820396, 10128.54421551032, 38412.80793596014, 38714.0, 38725.22549549022, 38748.80625596854, 38806.0, 3709.610490898444, 3771.3211621908044, 3780.130569968895, 3818.5417749869916, 3838.7888666123354, 28169.0, 28360.858195709097, 28971.56542651862, 29107.56338654922, 29163.270918227, 3528.700060494861, 3533.6466353364717, 3652.7443078984215, 3710.9628903710886, 3723.2925744108534, 230624.0, 235851.0, 236031.0, 236369.0, 236518.0, 53028.46971530235, 53167.20249196265, 53285.0, 53345.46654533405, 53474.73262633662, 56774.71612641993, 56837.43162568404, 56949.0, 56996.0, 57045.714771426705, 12783.296918669377, 13210.603681889559, 13263.867361326264, 13265.867341326657, 13320.733585328433, 8923.0, 9368.812623747486, 9567.234621230285, 9846.507674616241, 9945.403275803475, 16498.83501164973, 17042.914785425994, 17127.82872171287, 17165.914170429067, 17210.39763608268, 5915.438033386821, 5949.345571987078, 6004.699765011732, 6076.301225359052, 6098.420650038239, 808.2644793238125, 818.4843548564367, 824.2046425199711, 826.4132465949123, 846.9407141500036, 24488.387790305027, 25389.87305063463, 25709.228723138334, 25730.6140407894, 25754.35614109662, 950.3015283766426, 960.841461158901, 986.063239922077, 994.8906968729814, 1001.8948010458943, 12810.80783788244, 13449.932750336382, 13684.973626978017, 13693.794593081111, 13701.0, 123055.0, 123105.0, 123159.38420307841, 123307.38346308211, 123363.0, 50851.0, 51012.74493627508, 51012.74493627508, 51013.0, 51022.234666480035, 1206.5294535131306, 1231.605886116452, 1253.5487224598955, 1255.5919326218832, 1256.2399748152418, 24132.638010429506, 24205.273841784776, 26296.737032630193, 26440.206793796217, 28495.43009139847, 40441.0, 40626.39060414037, 40885.59114408937, 40915.181696366504, 40934.0, 316586.0, 321003.0, 321085.0, 321097.80788361473, 321118.0, 20554.79445205529, 23049.0, 39017.41473877951, 39743.403848942864, 42790.35814462723, 41752.3737143937, 41992.580074198864, 42212.366814497196, 43080.38392321485, 43588.0, 36362.8181859089, 36986.0, 37132.25735485329, 38039.0, 38406.23187536289, 35560.46659300061, 36214.63785362113, 36298.09254768546, 36655.26689466142, 36726.26547468982, 34766.82616586901, 34914.30171396609, 35078.64921350754, 35208.823955880056, 35550.46674299939, 31044.394123439903, 32524.51213231851, 33010.504842426904, 33345.499817503245, 33392.33215335728, 22538.323850284516, 22613.66079508776, 22819.0, 22837.429064273525, 22887.65668515007], "value": 17267.774324099526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.12439594855385, 336.16295424393263, 342.8440059772803, 350.15961691939344, 355.43308423065236, 16509.917450412748, 17882.821171788277, 17915.641687166248, 17955.102244887737, 18211.0, 16484.175791210422, 17293.30826766931, 18065.36771213008, 18234.0, 18269.725954110698, 4898.5101489850995, 5124.871878203037, 5145.0481660892665, 5148.665336753118, 5167.509086636783, 3894.941575876364, 4060.045889216032, 5060.367454068241, 5092.414372347172, 5771.769129234846, 5961.5230781537375, 6041.1844401005965, 6046.941785187597, 6056.848578785543, 6065.332813390523, 5857.062869940789, 5926.614770039933, 5980.491658209057, 5984.162217289583, 6083.726232319534, 5210.97394513025, 5220.765065572058, 5223.947760522384, 5226.0, 5271.578273738091, 21658.35024949238, 22062.0, 22096.226632067963, 22305.888470557704, 22455.326340209656, 2183.7379514458207, 2223.132978138527, 2228.977710222893, 2256.5035692147867, 2262.3439202631216, 13610.251436171007, 13623.863761362358, 13889.513867014606, 14187.64530886736, 14222.644433889132, 1759.6216813385056, 1791.4715159028117, 1815.0471002723543, 1826.1508398594717, 1852.7220916862443, 77815.83276250861, 77940.22059779386, 79439.0, 80480.59759701164, 81348.0, 9393.62425502986, 9524.571394287274, 9567.952160239294, 9584.424934503813, 9604.807903841884, 12678.492860285669, 12710.364481775874, 12736.681582960315, 12750.362481875869, 12764.042696797776, 6604.86790264192, 6681.632510211985, 6884.965575172092, 6938.236793952661, 6972.1981972072845, 6365.236171659338, 6373.808785736435, 6512.185976752906, 6521.9673901630185, 6528.67356632176, 6239.344868788802, 6386.489080873519, 6430.131932189188, 6439.5170362223025, 6487.513436492282, 1534.1792141204403, 1606.8955517891534, 1668.7580300856307, 1707.7096893527882, 1717.604950861309, 781.8709912864314, 860.9483430994161, 894.2354287084579, 895.91936725695, 905.62869223618, 17841.286348545913, 18273.451796446127, 18748.437546873614, 18834.434966951012, 19176.137073831713, 896.7489103051156, 913.7624217703445, 917.7017469322496, 918.2057520245073, 921.8432866412726, 10583.62957296491, 10716.048151932837, 10783.594663706439, 10805.227823461664, 10807.911232082031, 480030.0, 491571.0, 529597.0, 536055.0, 537483.0, 78485.0, 79219.0, 79233.60383198163, 79267.0, 79808.0, 955.8231727130503, 986.9457179855033, 996.6163027234422, 1005.7737009172878, 1007.9496025198711, 14832.406703732162, 15624.765628515353, 15721.371145154524, 16008.759868602214, 16399.91800040992, 35767.28465430729, 36876.26247475089, 37810.81094594509, 37963.43054854124, 38558.80720596379, 53755.19367209417, 54001.18998215108, 55604.72197638986, 56179.71910140587, 56464.717676413, 7151.8569628608175, 7480.177180510248, 7501.1373692023935, 7687.308142267223, 8094.069182044141, 9704.563294651616, 11825.70435739079, 11912.583059592873, 12451.813222801846, 12523.74952500963, 9866.506674666382, 9943.502824858873, 9987.350822196535, 10044.748881278027, 10708.625198118028, 10463.895361046596, 10609.89390106089, 10899.346039237671, 10908.181886358396, 11334.376609286568, 10354.326968747007, 10493.108085812486, 10600.46997650099, 10610.522526486173, 11055.447227638746, 7667.121555219007, 7710.498817576839, 7792.220777922163, 7913.881291780513, 8140.959295203486, 7497.062867141607, 10056.64801731936, 10121.898781012096, 10221.591136354462, 10844.67465976022], "value": 8606.523607597643, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.5264104922226, 1325.3572017571482, 1328.2229895511125, 1331.7336532693462, 1333.63991722235, 6366.363363663631, 6692.096566963464, 6704.463642908568, 6704.5306828522025, 6730.495212859037, 5874.970625146868, 6002.579819412632, 6040.758369665219, 6121.357257487966, 6585.769498067569, 1827.3878250786004, 1964.666006778844, 2006.0972562346928, 2014.29499675114, 2030.370585118618, 2029.5433527456278, 2038.1745393115739, 2042.7038079478466, 2047.2220556188702, 2055.537504061582, 1861.795202527721, 1942.2619404626294, 1959.5590992026823, 1959.9706004409945, 1962.038601085465, 1805.1064722962153, 1848.7966323704381, 1977.5847072114873, 2026.6554685703466, 2028.503016760903, 2026.2604149485478, 2038.3375402994086, 2040.6122836660986, 2041.8162365387186, 2044.7444069491314, 6655.534112612119, 6691.3308669133185, 6715.2277488089, 6716.664166791641, 6725.159355080615, 3942.3692209246383, 4057.5536690963972, 4069.511658600957, 4077.3068578341754, 4082.326416141333, 2551.9234422967343, 2604.8249711490926, 2731.549294366427, 2734.3437574981863, 2746.6841313248833, 1071.4589132488122, 1086.7717779266363, 1090.0462095666292, 1104.7072525780675, 1115.4868760370239, 8016.358691304682, 8262.586870656443, 8330.750077497685, 8456.8731469028, 8568.143185681445, 3480.7215422766117, 3523.788572685647, 3591.712662986955, 3605.441156620728, 3610.368185567515, 7051.858962820817, 7076.716931322792, 7079.681414336367, 7082.681279342339, 7117.537360071578, 3861.691064714816, 3867.41988701697, 3874.8837534873437, 3876.5154355705536, 3877.6703980161437, 3597.4963505109304, 3598.7480876338404, 3605.531280933462, 3614.7288953328607, 3615.3311637347174, 3057.9541306880415, 3078.338157296192, 3089.58290630762, 3111.393278310753, 3183.6179658440674, 913.5888850017519, 917.2936838634214, 923.0677016213539, 924.2513564013171, 926.1016813690709, 777.9572123533147, 806.7418426103591, 811.4522697179498, 818.0551463060175, 819.8893149424752, 4302.139572085595, 4317.395564620955, 4437.2234858899565, 4452.755098469615, 4557.703749256288, 466.3936882053317, 483.7387810582246, 491.268010664115, 493.93331900193016, 500.7246014691905, 2980.344324248662, 3159.6682348353092, 3166.3825554016744, 3179.1257404213566, 3231.8384080795868, 7357.668904899292, 7662.540247585162, 7758.3017528422715, 7774.1837107104075, 7864.960675196702, 7666.3866890648615, 7675.15573286938, 7732.188120247405, 7743.845123097619, 7851.411144164096, 6135.662538560422, 6235.906461403082, 6239.157713708682, 6239.844003899939, 6243.8126856195295, 4402.053558484941, 4417.491988421372, 4451.265541185668, 4478.126765280739, 4496.662750293675, 6922.376986071277, 6971.79084627462, 6973.546719463218, 6994.475414343843, 7020.859582808213, 7097.219305876246, 7146.785596432115, 7193.892091618734, 7213.819654508679, 7256.310650488195, 5555.472230138131, 5589.329280486205, 5592.972035139798, 5595.328560572757, 5599.804006859903, 6178.5366097543765, 6179.196704428396, 6189.164462797465, 6223.471004964629, 6231.563790534619, 5696.943030569641, 5714.342840576186, 5746.5402767779315, 5762.250907382014, 5892.263467066617, 5252.107141785829, 5284.319356691649, 5293.470652934676, 5320.361556613231, 5448.972755136199, 5146.533238027144, 5210.791568337224, 5212.635115541876, 5221.712805795718, 5226.790928362823, 3271.8854840081435, 3966.8809935701975, 4040.3333449980423, 4071.0840060986043, 4177.436046133855, 4056.513218413809, 4062.688908539531, 4069.7354671947414, 4140.979295103505, 4196.979015104905], "value": 3512.9530775194626, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.1151535397149, 312.88110518003157, 318.51903625525455, 327.2865153964357, 327.4237342277594, 4811.855644330667, 4859.659823812334, 4886.462489126193, 4902.2891680706325, 4977.477364876681, 4856.882916929099, 4879.316375993199, 4892.5596696297325, 4903.82836600719, 4906.509349065101, 3688.5758137814228, 3773.8490460381554, 3816.255830113129, 3860.8455661773637, 3916.3929590913453, 3894.9805250973704, 3902.6292502212245, 3910.159315747114, 3913.31516984528, 3922.62681077948, 3852.4397618964363, 3861.8455261789495, 3874.767513949172, 3880.4866102220158, 3916.608339166075, 3726.6956565202236, 3807.6382743639588, 3827.655511004009, 3875.9418608720894, 3887.067103895073, 3439.4152993991083, 3449.9655003449893, 3455.8963231102857, 3457.239407330383, 3460.3079384123275, 4756.9286460703115, 4772.284157376422, 4775.2598347256235, 4787.635523875679, 4811.8075276988875, 4299.161663475624, 4358.629516491102, 4375.431193944767, 4398.194383413895, 4442.689011769177, 5061.609386003931, 5069.264956581275, 5077.873053173664, 5082.974585127051, 5116.769745361467, 3739.8967304645194, 3741.0, 3743.529270681337, 3748.100455890594, 3749.137698329372, 5230.947690523084, 5331.466853314715, 5348.946510534884, 5353.598480114007, 5373.9731301343245, 3803.3154032274456, 3816.923661526754, 3819.4461803038403, 3826.693864490834, 3841.4634146341687, 3877.554081280689, 3888.669463095612, 3889.7860617665733, 3899.668528175137, 3903.2974064668065, 4353.194658988034, 4397.714148580396, 4401.955980440219, 4423.982484028691, 4426.004149066434, 4813.927791083137, 5057.317262169634, 5070.391553013588, 5075.796968121308, 5100.6684565503865, 1219.384315781593, 1220.8962238209851, 1225.5342969671647, 1227.6623928419756, 1234.7900856854176, 782.1396463889675, 794.3168874767695, 829.9128591497806, 842.5366048673205, 842.877782721502, 4228.77365563983, 4308.3968244445805, 4429.313456414261, 4435.913201265646, 4448.822047118144, 5182.4299327073995, 5201.817936372285, 5205.271262023244, 5209.6353255272525, 5213.661112027706, 4435.6895017349125, 4457.398251236042, 4469.324003498688, 4476.440444944382, 4489.371487991683, 2584.5218634552293, 2719.9528181650207, 2721.18364490652, 2721.3060669529145, 2723.9591406128925, 4766.926387021656, 4781.784819683123, 4791.425028996543, 4801.68789028719, 4815.542523460265, 5101.648063263238, 5175.024360992445, 5250.606204534675, 5255.474452554714, 5272.0, 4910.410750709938, 4916.385451818451, 4922.483139270396, 4928.088303663833, 4966.850994470172, 5244.816431424882, 5254.97372513135, 5266.86832829167, 5282.4944890705965, 5299.205119232146, 4940.802367905244, 5189.884174902414, 5194.766235519335, 5209.619450845453, 5225.947740522698, 4899.730514821719, 4900.921797204609, 4906.165951788276, 4911.091448082117, 4940.901181976412, 3576.159602493464, 3589.6410358963894, 3617.6744093031753, 3627.383344831332, 3628.546431696038, 5103.489651034867, 5199.74001299941, 5230.8169214077325, 5233.502817232356, 5251.684898906078, 5052.8484145475695, 5071.923921141112, 5073.3325340685915, 5075.1625981712605, 5087.135187018142, 5054.69671819692, 5083.517065878736, 5102.413222479314, 5140.742962851918, 5156.381234251764, 4779.689320194177, 4992.825251116194, 5033.446320904624, 5049.995252824563, 5060.569851562511, 4897.681650692693, 4935.580475659609, 5032.748362581783, 5097.464766199644, 5120.385553733576, 4984.775685094252, 4987.750612469435, 4995.425526064549, 5027.522385373383, 5037.0681423936685], "value": 3842.947213255708, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.2036674523592, 653.8888388973877, 728.4427413029031, 770.4144849914065, 775.9961200194, 12491.812622810654, 13620.114692545003, 13640.795388069162, 13647.795283070736, 13652.863471365295, 13003.154794938322, 13076.476940922352, 13130.671733206651, 13142.948564114871, 13189.340532973338, 658.8517583543688, 676.4520738202073, 789.2423273657296, 795.1055063054064, 802.3260461212581, 812.3460614205562, 812.6018251056969, 813.4631143445328, 813.9674413023472, 814.2102160903943, 849.6346570974479, 857.7855536115972, 857.8884744983144, 857.9356548258875, 858.4934888415834, 687.0518684215775, 706.5019161491163, 913.2009491694768, 937.2408349237139, 942.4675058591873, 613.7176898626637, 613.9723712432951, 614.2935624032353, 614.7633161232912, 615.1388056720582, 12843.550475733398, 12852.228866268053, 12876.678083047906, 12896.0, 12898.935505322506, 14322.57032289033, 14323.856761432357, 14365.353559089866, 14453.205073720941, 14464.349104290332, 10453.738656533571, 10546.0, 10666.306690065121, 10715.571377144905, 10766.24636275461, 3387.8644854205804, 3413.0784688134313, 3415.1462134466383, 3428.9142771430916, 3472.4444088945647, 60245.0, 60984.39015609876, 61084.694576527276, 61341.0, 61975.6901215491, 9873.60505579783, 9894.455804930798, 10339.172866170687, 10360.844587331196, 10892.673219803419, 19398.538336182755, 20031.799682002995, 20089.09599068016, 20289.59420811605, 20464.897675511525, 7014.614196219155, 7076.8278560875215, 7183.138023437221, 7195.280471952763, 7320.853582928418, 3774.9811250944117, 3781.962180378216, 3829.808509574566, 3856.9614303857165, 3863.613638636114, 3034.9529412352704, 3078.492048811921, 3099.860506277223, 3101.8368111958016, 3105.4410206162656, 517.5006119095091, 524.9553787928069, 526.9394019687709, 531.2880739808675, 538.9571179767084, 657.3163909534127, 664.8470851704135, 674.689642764324, 675.7161991963387, 696.3663066609463, 8899.243564296978, 9393.671221507215, 9534.809303813885, 9629.518524073768, 9647.372920760128, 658.9077529145924, 665.4842497064814, 674.3020973292716, 678.8574399376088, 679.1103654212997, 4462.843800466968, 4520.186366454004, 4520.932186017212, 4524.796384162721, 4527.1172121436, 51012.74493627508, 52967.735161323944, 53136.202956955676, 70968.64515677492, 72708.63645681844, 45225.321620175724, 47810.521894780606, 53334.46665533295, 56005.719971399885, 57357.13964290539, 49189.754051229516, 49496.75251623719, 50104.0, 50173.0, 52861.99999999923, 9069.727908162766, 9490.0, 9499.335046546676, 9513.096255855682, 9517.286203534624, 30799.0, 32585.674143258264, 33325.0, 34388.70141232346, 36232.45651315285, 42296.1540769189, 45558.49428281476, 47015.294770577784, 47331.0, 48050.759746201045, 11238.213325067167, 11824.763504729684, 11871.643850684493, 12051.879481205076, 12178.08664350195, 12032.0, 12453.813192802296, 13036.543720969721, 13074.215547067206, 13946.930265349014, 10436.895631043591, 11904.880951190376, 12134.817977730518, 12428.192167509083, 13251.469941202244, 12187.329696866758, 12456.252624842538, 13025.739485210432, 13222.206667599974, 13570.59288221355, 12208.45061972231, 12262.754744904874, 12420.565280215511, 13105.427348718214, 13131.277779722206, 10505.15958723285, 10714.30357026822, 10943.513159604523, 10998.780024399308, 11144.164187686118, 10057.899421005697, 10238.92491288404, 10334.224933130195, 10366.637167699095, 10487.423191724529], "value": 6503.679398340626, "unit": "score"}], "name": "dromaeo_css", "value": 6267.694331445615, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 116.0, 116.0, 114.0, 117.0, 116.0, 114.0, 115.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 131.0, 163.0, 127.0, 124.0, 125.0, 125.0, 144.0, 123.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 163.0, 162.0, 162.0, 162.0, 162.0, 160.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 77.0, 113.0, 77.0, 76.0, 76.0, 76.0, 93.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 106.0, 84.0, 85.0, 85.0, 97.0, 85.0, 84.0, 115.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 148.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 59.0, 61.0, 60.0, 62.0, 59.0, 61.0, 61.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 67.0, 68.0, 67.0, 69.0, 68.0, 67.0, 67.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 94.0, 93.0, 87.0, 84.0, 94.0, 83.0, 83.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 130.0, 140.0, 136.0, 137.0, 138.0, 130.0, 216.0, 139.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 181.0, 178.0, 182.0, 184.0, 185.0, 179.0, 176.0, 180.0], "value": 179.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1552.7, "alertThreshold": 2.0}]} 17:34:02 INFO - Return code: 0 17:34:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:34:02 INFO - # TBPL SUCCESS # 17:34:02 INFO - Running post-action listener: _resource_record_post_action 17:34:02 INFO - [mozharness: 2017-01-10 01:34:02.674972Z] Finished run-tests step (success) 17:34:02 INFO - Running post-run listener: _resource_record_post_run 17:34:02 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 384499712; Read time: 16; Write time: 269452 17:34:02 INFO - TinderboxPrint: CPU usage
13.1% 17:34:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:34:02 INFO - TinderboxPrint: I/O write bytes / time
384,499,712 / 269,452 17:34:02 INFO - TinderboxPrint: CPU idle
8,337.7 (86.9%) 17:34:02 INFO - TinderboxPrint: CPU user
1,212.6 (12.6%) 17:34:02 INFO - TinderboxPrint: Swap in / out
0 / 0 17:34:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100048896; Read time: 0; Write time: 90796 17:34:02 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 284450816; Read time: 0; Write time: 178656 17:34:03 INFO - Running post-run listener: _upload_blobber_files 17:34:03 INFO - Blob upload gear active. 17:34:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:34:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:34:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:34:03 INFO - (blobuploader) - INFO - Open directory for files ... 17:34:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:34:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:34:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:04 INFO - (blobuploader) - INFO - Done attempting. 17:34:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:34:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:34:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:08 INFO - (blobuploader) - INFO - Done attempting. 17:34:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:34:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:34:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:09 INFO - (blobuploader) - INFO - Done attempting. 17:34:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:34:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:34:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:10 INFO - (blobuploader) - INFO - Done attempting. 17:34:10 INFO - (blobuploader) - INFO - Iteration through files over. 17:34:10 INFO - Return code: 0 17:34:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:34:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:34:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee3cd3bdbd3ff303b12dcfe1aeb5c7edecbd2d2c0079ff21177de26ea7d8016430e7f3a571b6afd3de6c6f9d15d2b1f0726f0888ebf8b159b0c4edad337be416", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5b5b3567f92d274c702d8b813a3eb202c0e33daf39196dcf22817ce7326e3a29abc26c2ce790be02102de4740fbbc7d6113f859d638fb45a90db51110893f76", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/106de2addf67b71904d6627abe566029f13b7734a71d4168e16f96a248dc9dc421e0e43274528d857037d1bb676a77d2faae0a0d45a7c437646a5d73ea266835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5465b3dacfd0fae46f4ef71571322713babd9fb6d45af57f1f03f9d9e3decee85f535534c3b6376c4c647eec0b54f6e78f266c8b7e574c01f1b5e2cd979cdb87"} 17:34:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:34:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:34:10 INFO - Contents: 17:34:10 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee3cd3bdbd3ff303b12dcfe1aeb5c7edecbd2d2c0079ff21177de26ea7d8016430e7f3a571b6afd3de6c6f9d15d2b1f0726f0888ebf8b159b0c4edad337be416", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5b5b3567f92d274c702d8b813a3eb202c0e33daf39196dcf22817ce7326e3a29abc26c2ce790be02102de4740fbbc7d6113f859d638fb45a90db51110893f76", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/106de2addf67b71904d6627abe566029f13b7734a71d4168e16f96a248dc9dc421e0e43274528d857037d1bb676a77d2faae0a0d45a7c437646a5d73ea266835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5465b3dacfd0fae46f4ef71571322713babd9fb6d45af57f1f03f9d9e3decee85f535534c3b6376c4c647eec0b54f6e78f266c8b7e574c01f1b5e2cd979cdb87"} 17:34:10 INFO - Running post-run listener: copy_logs_to_upload_dir 17:34:10 INFO - Copying logs to upload dir... 17:34:10 INFO - mkdir: /builds/slave/test/build/upload/logs 17:34:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.604809 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-09 17:34:10.291675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 17:34:10.294948) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee3cd3bdbd3ff303b12dcfe1aeb5c7edecbd2d2c0079ff21177de26ea7d8016430e7f3a571b6afd3de6c6f9d15d2b1f0726f0888ebf8b159b0c4edad337be416", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5b5b3567f92d274c702d8b813a3eb202c0e33daf39196dcf22817ce7326e3a29abc26c2ce790be02102de4740fbbc7d6113f859d638fb45a90db51110893f76", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/106de2addf67b71904d6627abe566029f13b7734a71d4168e16f96a248dc9dc421e0e43274528d857037d1bb676a77d2faae0a0d45a7c437646a5d73ea266835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5465b3dacfd0fae46f4ef71571322713babd9fb6d45af57f1f03f9d9e3decee85f535534c3b6376c4c647eec0b54f6e78f266c8b7e574c01f1b5e2cd979cdb87"} build_url:https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011651 build_url: 'https://queue.taskcluster.net/v1/task/bWldNLtFSU6X_IZiooHesg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee3cd3bdbd3ff303b12dcfe1aeb5c7edecbd2d2c0079ff21177de26ea7d8016430e7f3a571b6afd3de6c6f9d15d2b1f0726f0888ebf8b159b0c4edad337be416", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5b5b3567f92d274c702d8b813a3eb202c0e33daf39196dcf22817ce7326e3a29abc26c2ce790be02102de4740fbbc7d6113f859d638fb45a90db51110893f76", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/106de2addf67b71904d6627abe566029f13b7734a71d4168e16f96a248dc9dc421e0e43274528d857037d1bb676a77d2faae0a0d45a7c437646a5d73ea266835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5465b3dacfd0fae46f4ef71571322713babd9fb6d45af57f1f03f9d9e3decee85f535534c3b6376c4c647eec0b54f6e78f266c8b7e574c01f1b5e2cd979cdb87"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 17:34:10.320499) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 17:34:10.320838) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1484010800.639305-279833292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 17:34:10.406523) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 17:34:10.406832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 17:34:10.407122) ========= ========= Total master_lag: 0.16 =========