builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1480951028.94 results: success (0) buildid: 20161205062638 builduid: dcef06edb97944b0b0f367b97ac45429 revision: 1a5b8398168cee2ce43f4a946f58d15681d0d604 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:08.942209) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:08.942712) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:08.942997) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:08.968487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:08.968854) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-05 07:17:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.3K=0.2s 2016-12-05 07:17:09 (51.3 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.369314 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:09.352051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:09.352382) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021697 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:09.403700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:09.404138) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1a5b8398168cee2ce43f4a946f58d15681d0d604 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1a5b8398168cee2ce43f4a946f58d15681d0d604 --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=78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-05 07:17:09,684 truncating revision to first 12 chars 2016-12-05 07:17:09,684 Setting DEBUG logging. 2016-12-05 07:17:09,685 attempt 1/10 2016-12-05 07:17:09,685 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1a5b8398168c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-05 07:17:10,003 unpacking tar archive at: mozilla-central-1a5b8398168c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636105 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:10.053811) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:10.054140) ========= script_repo_revision: 1a5b8398168cee2ce43f4a946f58d15681d0d604 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:10.054572) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:10.054841) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-05 07:17:10.063988) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-05 07:17:10.064333) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:17:10 INFO - MultiFileLogger online at 20161205 07:17:10 in /builds/slave/test 07:17:10 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 07:17:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:17:10 INFO - {'append_to_log': False, 07:17:10 INFO - 'base_work_dir': '/builds/slave/test', 07:17:10 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:17:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:17:10 INFO - 'branch': 'Firefox-Non-PGO', 07:17:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:17:10 INFO - 'config_files': ('talos/linux_config.py',), 07:17:10 INFO - 'default_actions': ('clobber', 07:17:10 INFO - 'read-buildbot-config', 07:17:10 INFO - 'download-and-extract', 07:17:10 INFO - 'populate-webroot', 07:17:10 INFO - 'create-virtualenv', 07:17:10 INFO - 'install', 07:17:10 INFO - 'run-tests'), 07:17:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:17:10 INFO - 'download_minidump_stackwalk': True, 07:17:10 INFO - 'download_symbols': 'ondemand', 07:17:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:17:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:17:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:17:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:17:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:17:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:17:10 INFO - 'installer_path': 'installer.exe', 07:17:10 INFO - 'log_level': 'info', 07:17:10 INFO - 'log_name': 'talos', 07:17:10 INFO - 'log_to_console': True, 07:17:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:17:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:17:10 INFO - 'opt_config_files': (), 07:17:10 INFO - 'pip_index': False, 07:17:10 INFO - 'sps_profile': False, 07:17:10 INFO - 'sps_profile_interval': 0, 07:17:10 INFO - 'suite': 'dromaeojs', 07:17:10 INFO - 'system_bits': '32', 07:17:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:17:10 INFO - 'title': 'talos-linux64-ix-019', 07:17:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:17:10 INFO - 'use_talos_json': True, 07:17:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:17:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:17:10 INFO - 'work_dir': 'build'} 07:17:10 INFO - [mozharness: 2016-12-05 15:17:10.443248Z] Running clobber step. 07:17:10 INFO - Running pre-action listener: _resource_record_pre_action 07:17:10 INFO - Running main action method: clobber 07:17:10 INFO - rmtree: /builds/slave/test/build 07:17:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:17:10 INFO - Running post-action listener: _resource_record_post_action 07:17:10 INFO - [mozharness: 2016-12-05 15:17:10.897481Z] Finished clobber step (success) 07:17:10 INFO - [mozharness: 2016-12-05 15:17:10.897581Z] Running read-buildbot-config step. 07:17:10 INFO - Running pre-action listener: _resource_record_pre_action 07:17:10 INFO - Running main action method: read_buildbot_config 07:17:10 INFO - Using buildbot properties: 07:17:10 INFO - { 07:17:10 INFO - "project": "", 07:17:10 INFO - "product": "firefox", 07:17:10 INFO - "script_repo_revision": "production", 07:17:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:17:10 INFO - "repository": "", 07:17:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:17:10 INFO - "buildid": "20161205062638", 07:17:10 INFO - "pgo_build": "False", 07:17:10 INFO - "basedir": "/builds/slave/test", 07:17:10 INFO - "buildnumber": 327, 07:17:10 INFO - "slavename": "talos-linux64-ix-019", 07:17:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:17:10 INFO - "platform": "ubuntu64_hw", 07:17:10 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:17:10 INFO - "branch": "mozilla-central", 07:17:10 INFO - "repo_path": "mozilla-central", 07:17:10 INFO - "revision": "1a5b8398168cee2ce43f4a946f58d15681d0d604", 07:17:10 INFO - "stage_platform": "linux64", 07:17:10 INFO - "builduid": "dcef06edb97944b0b0f367b97ac45429", 07:17:10 INFO - "slavebuilddir": "test" 07:17:10 INFO - } 07:17:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:17:10 INFO - Running post-action listener: _resource_record_post_action 07:17:10 INFO - [mozharness: 2016-12-05 15:17:10.900018Z] Finished read-buildbot-config step (success) 07:17:10 INFO - [mozharness: 2016-12-05 15:17:10.900107Z] Running download-and-extract step. 07:17:10 INFO - Running pre-action listener: _resource_record_pre_action 07:17:10 INFO - Running main action method: download_and_extract 07:17:10 INFO - mkdir: /builds/slave/test/build/tests 07:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:10 INFO - trying https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:17:10 INFO - Downloading https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:17:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:17:11 INFO - Downloaded 1361 bytes. 07:17:11 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:17:11 INFO - Using the following test package requirements: 07:17:11 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:11 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:17:11 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:17:11 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:11 INFO - u'jsshell-linux-x86_64.zip'], 07:17:11 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:17:11 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:11 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:17:11 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:17:11 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:17:11 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:17:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:17:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:17:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:17:11 INFO - Fetch https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:17:12 INFO - Expected file size: 20218591 07:17:12 INFO - Obtained file size: 20218591 07:17:16 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:17:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:17:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:17:16 INFO - Fetch https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:17:17 INFO - Expected file size: 20218591 07:17:17 INFO - Obtained file size: 20218591 07:17:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:17:21 INFO - Fetch https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:17:22 INFO - Expected file size: 14409734 07:17:22 INFO - Obtained file size: 14409734 07:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:22 INFO - trying https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:17:22 INFO - Downloading https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:17:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:17:23 INFO - Downloaded 55714514 bytes. 07:17:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:17:23 INFO - mkdir: /builds/slave/test/properties 07:17:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:17:23 INFO - Writing to file /builds/slave/test/properties/build_url 07:17:23 INFO - Contents: 07:17:23 INFO - build_url:https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:17:24 INFO - Running post-action listener: _resource_record_post_action 07:17:24 INFO - Running post-action listener: set_extra_try_arguments 07:17:24 INFO - [mozharness: 2016-12-05 15:17:24.443903Z] Finished download-and-extract step (success) 07:17:24 INFO - [mozharness: 2016-12-05 15:17:24.444203Z] Running populate-webroot step. 07:17:24 INFO - Running pre-action listener: _resource_record_pre_action 07:17:24 INFO - Running main action method: populate_webroot 07:17:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:17:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:17:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:17:24 INFO - '--tppagecycles', 07:17:24 INFO - '7'], 07:17:24 INFO - 'tests': ['tsvgm']}}, 07:17:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:17:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:17:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:17:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:17:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:17:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:17:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:17:24 INFO - 'talos_options': ['--disable-e10s'], 07:17:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:17:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:17:24 INFO - 'talos_options': ['--disable-e10s'], 07:17:24 INFO - 'tests': ['damp', 'tps']}, 07:17:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:17:24 INFO - 'tests': ['damp', 'tps']}, 07:17:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:17:24 INFO - 'tests': ['dromaeo_dom']}, 07:17:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:17:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:17:24 INFO - 'tests': ['basic_compositor_video']}, 07:17:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:17:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:17:24 INFO - 'tests': ['a11yr', 07:17:24 INFO - 'ts_paint', 07:17:24 INFO - 'tpaint', 07:17:24 INFO - 'sessionrestore', 07:17:24 INFO - 'sessionrestore_no_auto_restore', 07:17:24 INFO - 'tabpaint']}, 07:17:24 INFO - 'other-e10s': {'tests': ['a11yr', 07:17:24 INFO - 'ts_paint', 07:17:24 INFO - 'tpaint', 07:17:24 INFO - 'sessionrestore', 07:17:24 INFO - 'sessionrestore_no_auto_restore', 07:17:24 INFO - 'tabpaint']}, 07:17:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:17:24 INFO - 'ts_paint', 07:17:24 INFO - 'tpaint', 07:17:24 INFO - 'sessionrestore', 07:17:24 INFO - 'sessionrestore_no_auto_restore', 07:17:24 INFO - 'tabpaint']}, 07:17:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:17:24 INFO - 'ts_paint', 07:17:24 INFO - 'tpaint', 07:17:24 INFO - 'sessionrestore', 07:17:24 INFO - 'sessionrestore_no_auto_restore', 07:17:24 INFO - 'tabpaint']}, 07:17:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:17:24 INFO - 'tests': ['a11yr', 07:17:24 INFO - 'ts_paint', 07:17:24 INFO - 'tpaint', 07:17:24 INFO - 'sessionrestore', 07:17:24 INFO - 'sessionrestore_no_auto_restore', 07:17:24 INFO - 'tabpaint']}, 07:17:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:17:24 INFO - 'tests': ['a11yr', 07:17:24 INFO - 'ts_paint', 07:17:24 INFO - 'tpaint', 07:17:24 INFO - 'sessionrestore', 07:17:24 INFO - 'sessionrestore_no_auto_restore', 07:17:24 INFO - 'tabpaint']}, 07:17:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:17:24 INFO - 'tests': ['tsvgx', 07:17:24 INFO - 'tsvgr_opacity', 07:17:24 INFO - 'tart', 07:17:24 INFO - 'tscrollx', 07:17:24 INFO - 'cart', 07:17:24 INFO - 'tsvg_static']}, 07:17:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:17:24 INFO - 'tsvgr_opacity', 07:17:24 INFO - 'tart', 07:17:24 INFO - 'tscrollx', 07:17:24 INFO - 'cart', 07:17:24 INFO - 'tsvg_static']}, 07:17:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:17:24 INFO - 'talos_options': ['--disable-e10s'], 07:17:24 INFO - 'tests': ['tp5o']}, 07:17:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:17:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:17:24 INFO - 'talos_options': ['--disable-e10s', 07:17:24 INFO - '--xperf_path', 07:17:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:24 INFO - 'tests': ['tp5n']}, 07:17:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:17:24 INFO - 'talos_options': ['--xperf_path', 07:17:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:24 INFO - 'tests': ['tp5n']}}, 07:17:24 INFO - 'talos.zip': {'path': '', 07:17:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:17:24 INFO - Running post-action listener: _resource_record_post_action 07:17:24 INFO - [mozharness: 2016-12-05 15:17:24.460870Z] Finished populate-webroot step (success) 07:17:24 INFO - [mozharness: 2016-12-05 15:17:24.460963Z] Running create-virtualenv step. 07:17:24 INFO - Running pre-action listener: _resource_record_pre_action 07:17:24 INFO - Running main action method: create_virtualenv 07:17:24 INFO - Creating virtualenv /builds/slave/test/build/venv 07:17:24 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 07:17:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:17:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:17:24 INFO - Using real prefix '/usr' 07:17:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:17:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:17:27 INFO - Installing pip.................done. 07:17:27 INFO - Return code: 0 07:17:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:17:27 INFO - Reading from file tmpfile_stdout 07:17:27 INFO - Output received: 07:17:27 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) 07:17:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f482578ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3f20>, '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 0x2660c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2660f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', '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 07:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:17:27 INFO - Using env: {'DISPLAY': ':0', 07:17:27 INFO - 'HOME': '/home/cltbld', 07:17:27 INFO - 'LANG': 'en_US.UTF-8', 07:17:27 INFO - 'LANGUAGE': 'en_US:en', 07:17:27 INFO - 'LOGNAME': 'cltbld', 07:17:27 INFO - 'MAIL': '/var/mail/cltbld', 07:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:27 INFO - 'MOZ_NO_REMOTE': '1', 07:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:27 INFO - 'NO_EM_RESTART': '1', 07:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:27 INFO - 'PWD': '/builds/slave/test', 07:17:27 INFO - 'SHELL': '/bin/bash', 07:17:27 INFO - 'SHLVL': '1', 07:17:27 INFO - 'TERM': 'linux', 07:17:27 INFO - 'TMOUT': '86400', 07:17:27 INFO - 'USER': 'cltbld', 07:17:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', 07:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:27 INFO - '_': '/tools/buildbot/bin/python'} 07:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:27 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 07:17:27 INFO - Cleaning up... 07:17:27 INFO - Return code: 0 07:17:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f482578ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3f20>, '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 0x2660c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2660f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', '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 07:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:17:27 INFO - Using env: {'DISPLAY': ':0', 07:17:27 INFO - 'HOME': '/home/cltbld', 07:17:27 INFO - 'LANG': 'en_US.UTF-8', 07:17:27 INFO - 'LANGUAGE': 'en_US:en', 07:17:27 INFO - 'LOGNAME': 'cltbld', 07:17:27 INFO - 'MAIL': '/var/mail/cltbld', 07:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:27 INFO - 'MOZ_NO_REMOTE': '1', 07:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:27 INFO - 'NO_EM_RESTART': '1', 07:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:27 INFO - 'PWD': '/builds/slave/test', 07:17:27 INFO - 'SHELL': '/bin/bash', 07:17:27 INFO - 'SHLVL': '1', 07:17:27 INFO - 'TERM': 'linux', 07:17:27 INFO - 'TMOUT': '86400', 07:17:27 INFO - 'USER': 'cltbld', 07:17:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', 07:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:27 INFO - '_': '/tools/buildbot/bin/python'} 07:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:27 INFO - Downloading/unpacking psutil>=3.1.1 07:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:17:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:29 INFO - Installing collected packages: psutil 07:17:29 INFO - Running setup.py install for psutil 07:17:29 INFO - building 'psutil._psutil_linux' extension 07:17:29 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 07:17:29 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 07:17:30 INFO - building 'psutil._psutil_posix' extension 07:17:30 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 07:17:30 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 07:17:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:30 INFO - Successfully installed psutil 07:17:30 INFO - Cleaning up... 07:17:30 INFO - Return code: 0 07:17:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f482578ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3f20>, '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 0x2660c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2660f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', '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 07:17:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:17:30 INFO - Using env: {'DISPLAY': ':0', 07:17:30 INFO - 'HOME': '/home/cltbld', 07:17:30 INFO - 'LANG': 'en_US.UTF-8', 07:17:30 INFO - 'LANGUAGE': 'en_US:en', 07:17:30 INFO - 'LOGNAME': 'cltbld', 07:17:30 INFO - 'MAIL': '/var/mail/cltbld', 07:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:30 INFO - 'MOZ_NO_REMOTE': '1', 07:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:30 INFO - 'NO_EM_RESTART': '1', 07:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:30 INFO - 'PWD': '/builds/slave/test', 07:17:30 INFO - 'SHELL': '/bin/bash', 07:17:30 INFO - 'SHLVL': '1', 07:17:30 INFO - 'TERM': 'linux', 07:17:30 INFO - 'TMOUT': '86400', 07:17:30 INFO - 'USER': 'cltbld', 07:17:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', 07:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:30 INFO - '_': '/tools/buildbot/bin/python'} 07:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:17:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:17:32 INFO - Installing collected packages: mozsystemmonitor 07:17:32 INFO - Running setup.py install for mozsystemmonitor 07:17:32 INFO - Successfully installed mozsystemmonitor 07:17:32 INFO - Cleaning up... 07:17:32 INFO - Return code: 0 07:17:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f482578ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3f20>, '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 0x2660c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2660f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', '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 07:17:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:17:32 INFO - Using env: {'DISPLAY': ':0', 07:17:32 INFO - 'HOME': '/home/cltbld', 07:17:32 INFO - 'LANG': 'en_US.UTF-8', 07:17:32 INFO - 'LANGUAGE': 'en_US:en', 07:17:32 INFO - 'LOGNAME': 'cltbld', 07:17:32 INFO - 'MAIL': '/var/mail/cltbld', 07:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:32 INFO - 'MOZ_NO_REMOTE': '1', 07:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:32 INFO - 'NO_EM_RESTART': '1', 07:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:32 INFO - 'PWD': '/builds/slave/test', 07:17:32 INFO - 'SHELL': '/bin/bash', 07:17:32 INFO - 'SHLVL': '1', 07:17:32 INFO - 'TERM': 'linux', 07:17:32 INFO - 'TMOUT': '86400', 07:17:32 INFO - 'USER': 'cltbld', 07:17:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', 07:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:32 INFO - '_': '/tools/buildbot/bin/python'} 07:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:32 INFO - Downloading/unpacking jsonschema==2.5.1 07:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:17:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:35 INFO - Downloading functools32-3.2.3-2.tar.gz 07:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:17:35 INFO - warning: no files found matching '*.txt' 07:17:35 INFO - no previously-included directories found matching 'build' 07:17:35 INFO - no previously-included directories found matching 'dist' 07:17:35 INFO - no previously-included directories found matching '.git*' 07:17:35 INFO - Installing collected packages: jsonschema, functools32 07:17:35 INFO - Running setup.py install for functools32 07:17:35 INFO - warning: no files found matching '*.txt' 07:17:35 INFO - no previously-included directories found matching 'build' 07:17:35 INFO - no previously-included directories found matching 'dist' 07:17:35 INFO - no previously-included directories found matching '.git*' 07:17:35 INFO - Successfully installed jsonschema functools32 07:17:35 INFO - Cleaning up... 07:17:35 INFO - Return code: 0 07:17:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:17:35 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')]} 07:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:35 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')]} 07:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:35 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 0x7f482578ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3f20>, '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 0x2660c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2660f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', '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 07:17:35 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 07:17:35 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 07:17:35 INFO - Using env: {'DISPLAY': ':0', 07:17:35 INFO - 'HOME': '/home/cltbld', 07:17:35 INFO - 'LANG': 'en_US.UTF-8', 07:17:35 INFO - 'LANGUAGE': 'en_US:en', 07:17:35 INFO - 'LOGNAME': 'cltbld', 07:17:35 INFO - 'MAIL': '/var/mail/cltbld', 07:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:35 INFO - 'MOZ_NO_REMOTE': '1', 07:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:35 INFO - 'NO_EM_RESTART': '1', 07:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:35 INFO - 'PWD': '/builds/slave/test', 07:17:35 INFO - 'SHELL': '/bin/bash', 07:17:35 INFO - 'SHLVL': '1', 07:17:35 INFO - 'TERM': 'linux', 07:17:35 INFO - 'TMOUT': '86400', 07:17:35 INFO - 'USER': 'cltbld', 07:17:35 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', 07:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:35 INFO - '_': '/tools/buildbot/bin/python'} 07:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:17:35 INFO - Cleaning up... 07:17:35 INFO - Return code: 0 07:17:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:17:35 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')]} 07:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:35 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')]} 07:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:35 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 0x7f482578ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3f20>, '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 0x2660c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2660f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', '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 07:17:35 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 07:17:35 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 07:17:35 INFO - Using env: {'DISPLAY': ':0', 07:17:35 INFO - 'HOME': '/home/cltbld', 07:17:35 INFO - 'LANG': 'en_US.UTF-8', 07:17:35 INFO - 'LANGUAGE': 'en_US:en', 07:17:35 INFO - 'LOGNAME': 'cltbld', 07:17:35 INFO - 'MAIL': '/var/mail/cltbld', 07:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:35 INFO - 'MOZ_NO_REMOTE': '1', 07:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:35 INFO - 'NO_EM_RESTART': '1', 07:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:35 INFO - 'PWD': '/builds/slave/test', 07:17:35 INFO - 'SHELL': '/bin/bash', 07:17:35 INFO - 'SHLVL': '1', 07:17:35 INFO - 'TERM': 'linux', 07:17:35 INFO - 'TMOUT': '86400', 07:17:35 INFO - 'USER': 'cltbld', 07:17:35 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', 07:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:35 INFO - '_': '/tools/buildbot/bin/python'} 07:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:35 INFO - Downloading/unpacking blobuploader==1.2.4 07:17:35 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 07:17:35 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 07:17:35 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 07:17:35 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 07:17:35 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 07:17:35 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 07:17:37 INFO - Downloading blobuploader-1.2.4.tar.gz 07:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:17:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:17:37 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 07:17:37 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 07:17:37 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 07:17:37 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 07:17:37 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 07:17:37 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 07:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:17:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:17:38 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 07:17:38 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 07:17:38 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 07:17:38 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 07:17:38 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 07:17:38 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 07:17:38 INFO - Downloading docopt-0.6.1.tar.gz 07:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:17:38 INFO - Installing collected packages: blobuploader, requests, docopt 07:17:38 INFO - Running setup.py install for blobuploader 07:17:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:17:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:17:38 INFO - Running setup.py install for requests 07:17:39 INFO - Running setup.py install for docopt 07:17:39 INFO - Successfully installed blobuploader requests docopt 07:17:39 INFO - Cleaning up... 07:17:39 INFO - Return code: 0 07:17:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:39 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 0x7f482578ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3f20>, '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 0x2660c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2660f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', '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 07:17:39 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 07:17:39 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 07:17:39 INFO - Using env: {'DISPLAY': ':0', 07:17:39 INFO - 'HOME': '/home/cltbld', 07:17:39 INFO - 'LANG': 'en_US.UTF-8', 07:17:39 INFO - 'LANGUAGE': 'en_US:en', 07:17:39 INFO - 'LOGNAME': 'cltbld', 07:17:39 INFO - 'MAIL': '/var/mail/cltbld', 07:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:39 INFO - 'MOZ_NO_REMOTE': '1', 07:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:39 INFO - 'NO_EM_RESTART': '1', 07:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:39 INFO - 'PWD': '/builds/slave/test', 07:17:39 INFO - 'SHELL': '/bin/bash', 07:17:39 INFO - 'SHLVL': '1', 07:17:39 INFO - 'TERM': 'linux', 07:17:39 INFO - 'TMOUT': '86400', 07:17:39 INFO - 'USER': 'cltbld', 07:17:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', 07:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:39 INFO - '_': '/tools/buildbot/bin/python'} 07:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:39 INFO - Running setup.py (path:/tmp/pip-oV512A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:39 INFO - Running setup.py (path:/tmp/pip-axVKLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:39 INFO - Running setup.py (path:/tmp/pip-mJ9d_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:39 INFO - Running setup.py (path:/tmp/pip-0xFzue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:39 INFO - Running setup.py (path:/tmp/pip-DhnxiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:39 INFO - Running setup.py (path:/tmp/pip-hasS8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:39 INFO - Running setup.py (path:/tmp/pip-W7ZPPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:39 INFO - Running setup.py (path:/tmp/pip-bBUWIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:39 INFO - Running setup.py (path:/tmp/pip-rRusSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:40 INFO - Running setup.py (path:/tmp/pip-3VP9bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:40 INFO - Running setup.py (path:/tmp/pip-Y1lgk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:40 INFO - Running setup.py (path:/tmp/pip-bbpWYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:40 INFO - Running setup.py (path:/tmp/pip-yn7Bz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:40 INFO - Running setup.py (path:/tmp/pip-7wMfnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:40 INFO - Running setup.py (path:/tmp/pip-0_eZg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:17:40 INFO - Running setup.py (path:/tmp/pip-jkR2jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:17:40 INFO - Running setup.py (path:/tmp/pip-ZprMYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:17:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:17:40 INFO - Running setup.py install for manifestparser 07:17:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:17:40 INFO - Running setup.py install for mozcrash 07:17:40 INFO - Running setup.py install for mozdebug 07:17:40 INFO - Running setup.py install for mozdevice 07:17:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Running setup.py install for mozfile 07:17:41 INFO - Running setup.py install for mozhttpd 07:17:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Running setup.py install for mozinfo 07:17:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Running setup.py install for mozInstall 07:17:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Running setup.py install for mozleak 07:17:41 INFO - Running setup.py install for mozlog 07:17:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Running setup.py install for moznetwork 07:17:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Running setup.py install for mozprocess 07:17:41 INFO - Running setup.py install for mozprofile 07:17:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Running setup.py install for mozrunner 07:17:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:17:42 INFO - Running setup.py install for mozscreenshot 07:17:42 INFO - Running setup.py install for moztest 07:17:42 INFO - Running setup.py install for mozversion 07:17:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:17:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:17:42 INFO - Cleaning up... 07:17:42 INFO - Return code: 0 07:17:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:42 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')]} 07:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:42 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')]} 07:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:42 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 0x7f482578ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3f20>, '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 0x2660c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2660f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', '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 07:17:42 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 07:17:42 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 07:17:42 INFO - Using env: {'DISPLAY': ':0', 07:17:42 INFO - 'HOME': '/home/cltbld', 07:17:42 INFO - 'LANG': 'en_US.UTF-8', 07:17:42 INFO - 'LANGUAGE': 'en_US:en', 07:17:42 INFO - 'LOGNAME': 'cltbld', 07:17:42 INFO - 'MAIL': '/var/mail/cltbld', 07:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:42 INFO - 'MOZ_NO_REMOTE': '1', 07:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:42 INFO - 'NO_EM_RESTART': '1', 07:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:42 INFO - 'PWD': '/builds/slave/test', 07:17:42 INFO - 'SHELL': '/bin/bash', 07:17:42 INFO - 'SHLVL': '1', 07:17:42 INFO - 'TERM': 'linux', 07:17:42 INFO - 'TMOUT': '86400', 07:17:42 INFO - 'USER': 'cltbld', 07:17:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', 07:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:42 INFO - '_': '/tools/buildbot/bin/python'} 07:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:42 INFO - Running setup.py (path:/tmp/pip-8hI_DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:42 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)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:42 INFO - Running setup.py (path:/tmp/pip-mmyOnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:42 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)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:42 INFO - Running setup.py (path:/tmp/pip-_r3n7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:42 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)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:42 INFO - Running setup.py (path:/tmp/pip-uDs9eV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:42 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)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:42 INFO - Running setup.py (path:/tmp/pip-8FGjs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:43 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:43 INFO - Running setup.py (path:/tmp/pip-yVK8fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:43 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:43 INFO - Running setup.py (path:/tmp/pip-KyGevd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:43 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:43 INFO - Running setup.py (path:/tmp/pip-aKkfZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:43 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:43 INFO - Running setup.py (path:/tmp/pip-SEwYr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:43 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:43 INFO - Running setup.py (path:/tmp/pip-XYfshl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:43 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:43 INFO - Running setup.py (path:/tmp/pip-OWiLNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:43 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:43 INFO - Running setup.py (path:/tmp/pip-BtT8wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:43 INFO - Running setup.py (path:/tmp/pip-AkUYlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:43 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:43 INFO - Running setup.py (path:/tmp/pip-nNfQxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:43 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:43 INFO - Running setup.py (path:/tmp/pip-AVlLI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:43 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:17:43 INFO - Running setup.py (path:/tmp/pip-u63dVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:17:43 INFO - Running setup.py (path:/tmp/pip-hqEZCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:17:43 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)) 07:17:43 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)) 07:17:43 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)) 07:17:43 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)) 07:17:43 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)) 07:17:43 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)) 07:17:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:17: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 07:17: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 07:17: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 07:17: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 07:17: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 07:17: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 07:17:45 INFO - Downloading blessings-1.6.tar.gz 07:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:17:45 INFO - Installing collected packages: blessings 07:17:45 INFO - Running setup.py install for blessings 07:17:46 INFO - Successfully installed blessings 07:17:46 INFO - Cleaning up... 07:17:46 INFO - Return code: 0 07:17:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:46 INFO - Reading from file tmpfile_stdout 07:17:46 INFO - Current package versions: 07:17:46 INFO - argparse == 1.2.1 07:17:46 INFO - blessings == 1.6 07:17:46 INFO - blobuploader == 1.2.4 07:17:46 INFO - docopt == 0.6.1 07:17:46 INFO - functools32 == 3.2.3-2 07:17:46 INFO - jsonschema == 2.5.1 07:17:46 INFO - manifestparser == 1.1 07:17:46 INFO - mozInstall == 1.12 07:17:46 INFO - mozcrash == 1.0 07:17:46 INFO - mozdebug == 0.1 07:17:46 INFO - mozdevice == 0.49 07:17:46 INFO - mozfile == 1.2 07:17:46 INFO - mozhttpd == 0.7 07:17:46 INFO - mozinfo == 0.9 07:17:46 INFO - mozleak == 0.1 07:17:46 INFO - mozlog == 3.4 07:17:46 INFO - moznetwork == 0.27 07:17:46 INFO - mozprocess == 0.23 07:17:46 INFO - mozprofile == 0.28 07:17:46 INFO - mozrunner == 6.13 07:17:46 INFO - mozscreenshot == 0.1 07:17:46 INFO - mozsystemmonitor == 0.3 07:17:46 INFO - moztest == 0.7 07:17:46 INFO - mozversion == 1.4 07:17:46 INFO - psutil == 3.1.1 07:17:46 INFO - requests == 1.2.3 07:17:46 INFO - wsgiref == 0.1.2 07:17:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17: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')]} 07:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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')]} 07:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:46 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 0x7f482578ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3f20>, '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 0x2660c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2660f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', '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 07:17:46 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 07:17:46 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 07:17:46 INFO - Using env: {'DISPLAY': ':0', 07:17:46 INFO - 'HOME': '/home/cltbld', 07:17:46 INFO - 'LANG': 'en_US.UTF-8', 07:17:46 INFO - 'LANGUAGE': 'en_US:en', 07:17:46 INFO - 'LOGNAME': 'cltbld', 07:17:46 INFO - 'MAIL': '/var/mail/cltbld', 07:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:46 INFO - 'MOZ_NO_REMOTE': '1', 07:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:46 INFO - 'NO_EM_RESTART': '1', 07:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:46 INFO - 'PWD': '/builds/slave/test', 07:17:46 INFO - 'SHELL': '/bin/bash', 07:17:46 INFO - 'SHLVL': '1', 07:17:46 INFO - 'TERM': 'linux', 07:17:46 INFO - 'TMOUT': '86400', 07:17:46 INFO - 'USER': 'cltbld', 07:17:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', 07:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:46 INFO - '_': '/tools/buildbot/bin/python'} 07:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:46 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)) 07:17:46 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)) 07:17:46 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)) 07:17:46 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)) 07:17:46 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)) 07:17:46 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)) 07:17:46 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)) 07:17:46 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)) 07:17:46 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)) 07:17:46 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)) 07:17:46 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)) 07:17:46 INFO - Cleaning up... 07:17:46 INFO - Return code: 0 07:17:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:17: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')]} 07:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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')]} 07:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f482578ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3f20>, '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 0x2660c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2660f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', '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 07:17: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'] in /builds/slave/test/build 07:17: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 07:17:46 INFO - Using env: {'DISPLAY': ':0', 07:17:46 INFO - 'HOME': '/home/cltbld', 07:17:46 INFO - 'LANG': 'en_US.UTF-8', 07:17:46 INFO - 'LANGUAGE': 'en_US:en', 07:17:46 INFO - 'LOGNAME': 'cltbld', 07:17:46 INFO - 'MAIL': '/var/mail/cltbld', 07:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:46 INFO - 'MOZ_NO_REMOTE': '1', 07:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:46 INFO - 'NO_EM_RESTART': '1', 07:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:46 INFO - 'PWD': '/builds/slave/test', 07:17:46 INFO - 'SHELL': '/bin/bash', 07:17:46 INFO - 'SHLVL': '1', 07:17:46 INFO - 'TERM': 'linux', 07:17:46 INFO - 'TMOUT': '86400', 07:17:46 INFO - 'USER': 'cltbld', 07:17:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', 07:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:46 INFO - '_': '/tools/buildbot/bin/python'} 07:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:17:46 INFO - Cleaning up... 07:17:46 INFO - Return code: 0 07:17:46 INFO - Running post-action listener: _resource_record_post_action 07:17:46 INFO - Running post-action listener: _start_resource_monitoring 07:17:46 INFO - Starting resource monitoring. 07:17:46 INFO - [mozharness: 2016-12-05 15:17:46.831654Z] Finished create-virtualenv step (success) 07:17:46 INFO - [mozharness: 2016-12-05 15:17:46.832169Z] Running install step. 07:17:46 INFO - Running pre-action listener: _resource_record_pre_action 07:17:46 INFO - Running main action method: install 07:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:47 INFO - Reading from file tmpfile_stdout 07:17:47 INFO - Detecting whether we're running mozinstall >=1.0... 07:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:17:47 INFO - Reading from file tmpfile_stdout 07:17:47 INFO - Output received: 07:17:47 INFO - Usage: mozinstall [options] installer 07:17:47 INFO - Options: 07:17:47 INFO - -h, --help show this help message and exit 07:17:47 INFO - -d DEST, --destination=DEST 07:17:47 INFO - Directory to install application into. [default: 07:17:47 INFO - "/builds/slave/test"] 07:17:47 INFO - --app=APP Application being installed. [default: firefox] 07:17:47 INFO - mkdir: /builds/slave/test/build/application 07:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:18:03 INFO - Reading from file tmpfile_stdout 07:18:03 INFO - Output received: 07:18:03 INFO - /builds/slave/test/build/application/firefox/firefox 07:18:03 INFO - Running post-action listener: _resource_record_post_action 07:18:03 INFO - [mozharness: 2016-12-05 15:18:03.204609Z] Finished install step (success) 07:18:03 INFO - [mozharness: 2016-12-05 15:18:03.204852Z] Running run-tests step. 07:18:03 INFO - Running pre-action listener: _resource_record_pre_action 07:18:03 INFO - Running main action method: run_tests 07:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:18:03 INFO - Python 2.7.3 07:18:03 INFO - Return code: 0 07:18:03 INFO - grabbing minidump binary from tooltool 07:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:03 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 0x26f3f20>, '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 0x2660c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2660f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:18:03 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 07:18:03 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 07:18:03 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 07:18:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:18:03 INFO - Return code: 0 07:18:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:18:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:18:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:18:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:18:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:18:03 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/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 07:18:03 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/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 07:18:03 INFO - Using env: {'DISPLAY': ':0', 07:18:03 INFO - 'HOME': '/home/cltbld', 07:18:03 INFO - 'LANG': 'en_US.UTF-8', 07:18:03 INFO - 'LANGUAGE': 'en_US:en', 07:18:03 INFO - 'LOGNAME': 'cltbld', 07:18:03 INFO - 'MAIL': '/var/mail/cltbld', 07:18:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:18:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:03 INFO - 'MOZ_NO_REMOTE': '1', 07:18:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:03 INFO - 'NO_EM_RESTART': '1', 07:18:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:03 INFO - 'PWD': '/builds/slave/test', 07:18:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:18:03 INFO - 'SHELL': '/bin/bash', 07:18:03 INFO - 'SHLVL': '1', 07:18:03 INFO - 'TERM': 'linux', 07:18:03 INFO - 'TMOUT': '86400', 07:18:03 INFO - 'USER': 'cltbld', 07:18:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035', 07:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:03 INFO - '_': '/tools/buildbot/bin/python'} 07:18:03 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/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 07:18:03 INFO - mozversion application_buildid: 20161205062638 07:18:03 INFO - mozversion application_changeset: 1a5b8398168cee2ce43f4a946f58d15681d0d604 07:18:03 INFO - mozversion application_display_name: Nightly 07:18:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:18:03 INFO - mozversion application_name: Firefox 07:18:03 INFO - mozversion application_remotingname: firefox 07:18:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:18:03 INFO - mozversion application_vendor: Mozilla 07:18:03 INFO - mozversion application_version: 53.0a1 07:18:03 INFO - mozversion platform_buildid: 20161205062638 07:18:03 INFO - mozversion platform_changeset: 1a5b8398168cee2ce43f4a946f58d15681d0d604 07:18:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:18:03 INFO - mozversion platform_version: 53.0a1 07:18:03 INFO - using testdate: 1480951083 07:18:03 INFO - actual date: 1480951083 07:18:03 INFO - starting webserver on 'localhost:34719' 07:18:03 INFO - SUITE-START | Running 2 tests 07:18:03 INFO - TEST-START | dromaeo_css 07:18:03 INFO - operating with platform_type : linux_ 07:18:03 INFO - Initialising browser for dromaeo_css test... 07:18:03 INFO - TEST-INFO | started process 2207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmput6rUQ/profile http://localhost:34719/getInfo.html) 07:18:08 INFO - PROCESS | 2207 | __metrics Screen width/height:1600/1200 07:18:08 INFO - PROCESS | 2207 | colorDepth:24 07:18:08 INFO - PROCESS | 2207 | Browser inner width/height: 1024/697 07:18:08 INFO - PROCESS | 2207 | __metrics 07:18:08 INFO - PROCESS | 2207 | 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" 07:18:08 INFO - PROCESS | 2207 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:18:09 INFO - PROCESS | 2207 | console.error: PushService: 07:18:09 INFO - PROCESS | 2207 | stateChangeProcessEnqueue: Error transitioning state 07:18:09 INFO - PROCESS | 2207 | UnknownError 07:18:10 INFO - TEST-INFO | 2207: exit 0 07:18:10 INFO - Browser initialized. 07:18:10 INFO - Running cycle 1/1 for dromaeo_css test... 07:18:10 INFO - TEST-INFO | started process 2289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmput6rUQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:22 INFO - PROCESS | 2289 | RSS: Main: 173125632 07:18:22 INFO - PROCESS | 2289 | 07:19:13 INFO - PROCESS | 2289 | 1480951153498 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:21:27 INFO - PROCESS | 2289 | Cycle 1(1): loaded http://localhost:34719/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34719/tests/dromaeo/cssquery-ext.html) 07:21:30 INFO - PROCESS | 2289 | RSS: Main: 417329152 07:21:30 INFO - PROCESS | 2289 | 07:24:33 INFO - PROCESS | 2289 | Cycle 1(1): loaded http://localhost:34719/tests/dromaeo/cssquery-ext.html (next: http://localhost:34719/tests/dromaeo/cssquery-jquery.html) 07:24:33 INFO - PROCESS | 2289 | RSS: Main: 282951680 07:24:33 INFO - PROCESS | 2289 | 07:27:36 INFO - PROCESS | 2289 | Cycle 1(1): loaded http://localhost:34719/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34719/tests/dromaeo/cssquery-mootools.html) 07:27:37 INFO - PROCESS | 2289 | RSS: Main: 221069312 07:27:37 INFO - PROCESS | 2289 | 07:30:39 INFO - PROCESS | 2289 | Cycle 1(1): loaded http://localhost:34719/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34719/tests/dromaeo/cssquery-prototype.html) 07:30:39 INFO - PROCESS | 2289 | RSS: Main: 220950528 07:30:39 INFO - PROCESS | 2289 | 07:33:43 INFO - PROCESS | 2289 | Cycle 1(1): loaded http://localhost:34719/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34719/tests/dromaeo/cssquery-yui.html) 07:33:43 INFO - PROCESS | 2289 | RSS: Main: 223502336 07:33:43 INFO - PROCESS | 2289 | 07:36:47 INFO - PROCESS | 2289 | Cycle 1(1): loaded http://localhost:34719/tests/dromaeo/cssquery-yui.html (next: http://localhost:34719/tests/dromaeo/cssquery-dojo.html) 07:36:47 INFO - PROCESS | 2289 | RSS: Main: 313589760 07:36:47 INFO - PROCESS | 2289 | 07:36:47 INFO - PROCESS | 2289 | __start_tp_report 07:36:47 INFO - PROCESS | 2289 | _x_x_mozilla_page_load 07:36:47 INFO - PROCESS | 2289 | _x_x_mozilla_page_load_details 07:36:47 INFO - PROCESS | 2289 | |i|pagename|runs| 07:36:47 INFO - PROCESS | 2289 | |0;dojo.html;2619.305883940755;2620.7117217106115;2629.2506635608847;2659.188947371051;2670.2656769388414;4579.038401935598;4619.514950930155;4666.533346665332;4684.83603073892;4708.387909571755;4671;4672.415948006499;4736.265878788793;4751.667383283171;4779.402574678165;4265.978670106645;4297.484301883763;4298.312270036795;4310.418093557361;4376.256036473807;4022.0337501092877;4363.301871700529;4417.315316126005;4421.867343979686;4457.465104187486;4169.10364271683;4206.810693518768;4208.85269015583;4349.151915376471;4391.165678521103;4269.914601707979;4272.46594175728;4280.336547835091;4280.507741609693;4283.20760659279;4259.680523960685;4260.893477663052;4266.040140968288;4271.31658934569;4275.230458517465;4611.193041217807;4618.261078227468;4630.143423466636;4633.62930965522;4640.535946405333;4897.534734200245;4938.753062346868;4941.036497882914;4947.109520286347;4948.826791062295;4967.751612419364;4972.03045406146;5029.446760856303;5048.268001139851;5073.771680274396;4764.595009424169;4765.356676848651;4767.308740232716;4810.855674329776;4816.614670826326;5127.128388174019;5192.766325515286;5205.167173252262;5208.348956380452;5209.270702101709;4804.183288840905;4846.030793841246;4858.902821943541;4935.728534930613;5063.367079115111;5008.273800298936;5008.549230569266;5012.072766538202;5015.924761128586;5028.069807085701;4957.182064959314;4967.428745694291;4970.254461830755;4972.279019542146;4973;5024.723640199751;5104;5108.846734597968;5109.616778741535;5113.411957624847;4304.418903447994;4312.202242585132;4313.245182093121;4363.738175709467;4369.781510924441;3731.2164445466215;3827.4258861171047;3843.6348546888003;3850.2876967761053;3869.5743468218475;4174.937375939363;4203.516595591485;4214.557471465513;4307.741535507879;4412.779361031936;4982.626303027215;5071.264666623319;5084.898302033938;5118.692878427306;5145;4357.237483440385;4363.738175709467;4364.62900653448;4364.956350436519;4412.779361031936;4425.889352766142;4457.598816106566;4566.794494247767;4574.313852922021;4611.9077618447445;4709.340692303149;4726.078414709099;4727.810887564459;4728.148933192058;4731.243001119804;4957.281194226744;4985.551300382983;4992.425871024879;5011.072951503984;5025.120603894377;4690.366800482027;4743.644226683082;4755.762211889461;4796.040791841576;4804.8318308859025;4946.307516947702;4947.060058588857;4956.454789973172;4962.851114466572;5009.073321435546;4823.324734537237;4862.708237505761;4981.427135879276;5023.070731914608;5037.462139327165;4796.496367881322;4800.35195248637;4802.471728109975;4804.3273941648895;4816.205326121291;4780.95219047819;4781.378420805273;4784.067106914118;4794.880127996688;4800.903981920273;4708.646851486221;4718.150732868116;4735.502772208868;4748.8100475981955;4761.761911904322;4858.246971719389;4859.246816743411;4868.391451068616;4871.561559459666;4878.512148785235;4773.809047638056;4775.5224477551965;4790.520947905321;4796.160671882337;4797.232442809134 07:36:47 INFO - PROCESS | 2289 | |1;ext.html;555.7110302642626;570.2102587915738;583.1398686936769;584.573261519091;596.826920193144;37135.25729485412;38056.61943380565;38338.23323533531;42124.578754212525;42469.57530424695;39195.412068818994;39696.60303396965;39719.60280397195;39758.60241397585;39823.40264896022;7296.963515182443;7325.853482930338;7489.438292128085;7506.399488040971;7514.173440921521;9314.717894115916;9690.951545242264;9700.466474343908;9951.701448956506;9966.302358834884;9764.755881102994;9855.310128291023;9864.605415783395;9866.556004979757;9868.259880508955;9740.172085372751;9767.023297670212;9792.951035244849;9793.265505087147;9803.362781419184;9575.329726919119;9637.747092877951;9639.42163470187;9641.951790241073;9647;36808.44787328192;37258.44112338317;37304.44043339352;37311.25377492462;37332.81333593342;3040.939181216363;3067;3312.403767321881;3518.190816112283;3564.198055437532;26920.192394228205;27157.728422715914;27364;27501.31246718848;28598.285042873886;3286.4905939579403;3293.226091868409;3332.916677083068;3362.3443428531446;3418.8290585470627;229651;230213;230370;231500;231588;50746;51150.23274650883;51190.48809511932;51207.74396127996;51322.48677513177;53390.19914701283;53599;53710.73144634252;53766.46233537615;53849.73075134599;14020.1587904724;14444.277786110653;14465.92767036179;14482.058666186875;14484.782728259084;10101;10302.227332950059;10341.586336546454;10592.099671528007;11187.105031597453;14620.122792632475;16356.509304720877;16823.32706691743;16832.495025149266;17364.218610162574;5890.823275301748;6049.606775559574;6118.847028824315;6174.104754810527;6349.428551430394;750.1748077115238;821.765796747924;831.3349320543541;932.934694571387;948.2508818033814;24860.751392486207;25982.610260846104;26761.197164085108;26780;26869.731302687112;915.2906497464385;929.1173385283872;937.5078084005816;968.375397868371;983.8819341679044;12831.679208019688;13250.337483125997;13866;13912;13941.302934853216;346080;347509;349862;349937;350041;47069;47207.291890621666;47210.52789472061;47218.29172562414;47234.76382618065;1050.5220124843179;1076.4671487613525;1123;1159.4202898550725;1172.4137931034484;24655.63016554789;28136.57795133034;28335.43329133447;28374.85812570924;28949.7105028947;41216.79391603023;41774.58225417707;41795;41823.58176418197;41888.79055604825;279445;281160;282464;282601;282715;23991.640125397786;24163.758362416855;24565.140220092926;25092.498150037263;34487.65512344945;38009.42985855159;38012.23975520529;38545.807270963465;38889;39108.21783564256;34006;34527;34626.48060279048;34627.826860865534;34904.47643285403;32952.505712414815;33057.66942330546;33320.833395832866;33582.66417335795;34354.82822585871;33592.664073359934;33608.32783344271;33697.83151084229;33878.491822623175;34052;29298.41403171882;30263.243418913822;31484.2128946769;31493.370132597676;31626;23940.52118957646;23976.520469590858;24033.639495407933;24378.878105609358;24394.390140246636 07:36:47 INFO - PROCESS | 2289 | |2;jquery.html;343.9501272315513;356.0653285126541;371.0575139146568;376.8492602958816;382.49892640640763;12396.442160102795;12493.918845126636;13725.107867988574;14063.929680351584;16777.496675099737;16192.83807161928;16366.181690915466;16701.91649041756;16826.915865420655;16829.91585042073;4782.306565547993;4817.903641927168;4921.212605983043;4946.87632809179;4950.727709975949;3665.3035923174643;3855.4602355670227;4908.656394052417;4952.281919121725;4970.179920313144;3828.0812604974744;3849.826757795906;3865.6520913117815;3872.1674839909415;3900.8634697785583;5784.103463963072;5879.353271140171;5886.6173698709445;5887.528997680175;5889.469947704684;4545.840895568639;4785.042991401733;4822.565969062801;5204.219367094928;5207.140821764404;11515.712107197387;11568.01671857893;11632.825507617392;11646.941765291203;11664.241824281395;1702.3786317993968;1764.3119183518438;1811.429399739078;1858.228835033473;1868.0846385271254;8427.789305267355;8564.229219370287;8580.39937204396;8847.77880552985;9093.545322733902;1644.350481559777;1644.740103304354;1651.4880387079922;1677.6812405642888;1690.5604542818833;64521;65018;67339;68013;68165.31834681639;9060.546972651473;9439.575219115157;9907.108360247468;9918.652847150315;10004.599816007278;12601.495940162291;12628.747425051632;12644.241345519298;12644.620661380173;12790.808137877939;5384.91922621161;5440.401555828856;5632.746526406321;6778.661066946633;7004.334588214111;6414.262359828679;6461.095446637474;6556.114924485133;6579.934200657932;6619.238787539494;4204.159168166379;4240.6395456385935;4255.957440425556;4286.7856607169515;4333.306670932636;1679.2359476438191;1704.1905095079737;1734.620084287185;1757.66604345174;1779.1549014218142;785.403093648831;802.3180296747835;843.3674743942044;847.5084451018395;890.3811850763786;15544.222788860512;16691.49925502237;16803.243854026598;16921.492355229362;16991.04169969858;784.5763287824511;817.4278005396128;850.4812064640564;869.0874581689201;897.4974014551872;8667.523286219319;8905.910940890637;9372.282038208843;9417.387869788441;9514.571844267024;335373;354730;357945;359243;360834;53456.73271633617;69261.45908327322;70724;71290.2870971294;73945;768.1281745219217;787.7557957033338;805.9884844520207;807.0355924669963;807.7051876065194;14836.925815370854;14937.253137343307;15504.534863954099;15640.296186671854;15845.286962086504;36810.8159459201;37626;37721.62278377181;38506.229875402896;38565.6143438562;46758;50113;50153.74923125507;50977.745111274206;53156;7104.857902842017;7356.264373562601;7401.259874012556;7447.702091916262;7569.318761311509;6641.667916604247;8188.836223275382;9688.75778105553;11315.69869465022;11363.261388009752;9465.148136667733;9738.951305243429;9778.9022109778;10293.43386113771;10294.337367398954;9915.752106197402;10068.647597334058;10132.696019119438;10276;10402.739931501774;9917.603295868374;10027.649032284127;10078.395296282246;10206.183505319408;10435.895641043797;7166.319199676022;7371.152317483344;7401.7039318428815;7521.323080922743;7569.016027916336;8578.227959483676;9689.982551831956;9764.218862491125;9951.900480995097;10643.148548116287 07:36:47 INFO - PROCESS | 2289 | |3;mootools.html;1313.7175507265938;1357.1517801374143;1379.9379027943742;1579.8578127968494;1637.6315329050965;5909.379515150901;6097.512199024079;6669.666516674165;7023.332783385583;7028.191757947831;6501.512386571002;6662.300458451853;6710.1947766267995;6818.5908845469185;6835.077264569281;2000.5798782255708;2034.1659919433037;2038.6330460517102;2039.377989713137;2039.9592008159827;1745.0838309887283;1806.2504060814747;2030.2285131649953;2061.5361543652707;2071.637463443899;1964.9214031438726;2046.2428901306537;2050.1389416445054;2051.2820512820467;2052.384284714587;2044.0393015282941;2081;2082.6980087887246;2104.715863358442;2104.7579528354204;2048.8463365247517;2096.5597224582857;2098.674705420662;2099.464636517678;2100.4013856051106;6958.965205173992;6981.89527157093;6984.406325462342;7019.929800701979;7026;4101.876943691694;4143.6685065195015;4260.637845783112;4270.658347332206;4287.506936702288;2585.1598230575137;2673.759361657441;2735.5623100303856;2742.2732975761437;2749.8900043998215;796.2316364708026;809.2393150438569;809.9676012959475;811.1726039439739;858.8840506531601;9074.546272686339;9092.318076144249;9107.863382049209;9110.362274640778;9125.771855703593;3550.609432962372;3791.8007555617673;3848.730588858753;3854.229154169121;3932.115274063313;8031;8035.116137224901;8079.676812927534;8088.797780055545;8092.797680058045;4330.58859408362;4330.675199360061;4331.956680433218;4333.544977777351;4337.783110844445;3775.7734535927934;3982.0443093657314;3983.322835118037;3987.401889716508;3987.7407968481957;3295.6436148154185;3313.9171520712175;3360.1431634933424;3432;3446.1212390840174;896.8923729152413;921.6175287255847;1095.8739744929276;1130.1241537808264;1138.1520767028617;702.0872865275122;724.73547155289;736.4550232827776;792.3542313014874;818.1859050245045;4642.65180111493;4706.835260765857;4728.503507131771;4817.470078291385;4873.463918968911;813.5403497024163;843.6077224090827;845.6279237135641;859.1442484234025;873.1661263493476;3170.8256045917233;3262.6574209707637;3324.5678061851804;3343.8829640962936;3439.5872495300223;7685.5004424712215;7823;7971.681132754741;8025.638846251933;8370.665173393118;8218.465799722999;8226;8231.753047408587;8240.83518329642;8253.422260441712;6388.584741991848;6488.545801793829;6551;6594.769183078569;6610.206775187008;4978.975105124451;5084.8220312288895;5119.232115182753;5125.410577783454;5126.641135120506;7514.774556763306;7642.8089297768;7735.497192682457;7739.496932699357;7808;7546.207648196861;7867.213278672087;7900.565468899265;7929.841403172019;7999.6400161994015;5867.6772777497645;6033.909491357721;6036.607620504653;6037.124616930609;6038.788642397495;6482.70827812759;6546.279909209888;6553.344665533599;6554.14796076507;6560.245571759118;5932.317783454785;6036;6092.482139018233;6126.938730612636;6156.07658851158;5997.400259973968;6068.271807383142;6117.082437634391;6205.689715514116;6272.686365681789;5655.717214139194;5756.971215143897;5762.6830524319885;5766.481016708516;5768.394318596487;4293.50624678166;4321.114171594752;4383.890402739957;4457.197704413236;4466;4226.281532139482;4321.7406955582765;4376.387305777257;4398.340248962553;4420.071784925201 07:36:47 INFO - PROCESS | 2289 | |4;prototype.html;276.34919763955884;278.0518432146381;278.23624151703575;286.3985630176629;288.31668944601296;4555.612772914306;4684.484706682262;4730.574248317651;4776.785044672989;4783.712977221365;4542.159700455418;4617.1919914015;4628.490866004737;4633.1891918914225;4657.743824089674;3514.3147086318177;3618.9638103619022;3672.944905826408;3685.244524872395;3688.2623475304913;3553.1472446612756;3655.6344365563364;3659.6340365963456;3661.9084522886874;3678.742488025839;3626.7642603230706;3636.56361236652;3639.8726044588443;3677.558692956849;3688.8893333199912;3676.694773355447;3681.2637472505608;3692.649198326155;3693.076730817296;3697.2605478904325;3121.378042444335;3220.6296275928335;3234.692704193098;3251.9837400812844;3270.721988630969;4552.863414097583;4555.316702494619;4571.2457444521615;4578.404807375054;4580.07636792548;4141.668666506672;4148.751074935513;4148.879802453351;4153.771542565158;4164.312888373414;4704.341392205094;4879.243717223836;4917.286993385975;4937.358143441365;4946.950530494685;3457.913552161191;3496.667816557423;3509.104988384593;3510.6999420544607;3522.577290725104;5099.388073431212;5110.846674599731;5111.207762796773;5112.798492354294;5119.3088932994315;3597.136687195107;3602.7117830573493;3614.29521243355;3622.8007459589976;3623.9456408153897;3567.3935430976794;3611.115276757159;3627.5646922369483;3679.742418030712;3682.49017902664;4119.567445418248;4123.195976784558;4125.1131006833675;4148.771817550003;4151.398047283127;4647.256438969748;4769;4786.401699787527;4792.688475249098;4906.90186196274;1189.2864281431073;1192.4753108632347;1197.1799317467562;1197.383347575999;1223.9510419583116;844.1431946574232;848.3086284677968;850.5407080176759;856.7192047888446;857.6740838481337;4208.873733787991;4208.9789551052045;4210.210660469288;4221.2190744712325;4227.9365809512265;4875.68308059975;5086.847394578169;5111.207762796773;5128.69227846323;5143.974280128576;4421.955780442218;4431.623312018514;4432.623227025674;4434.157510073141;4434.933475997863;2542.758437948392;2604.1666666666483;2607.0093364521363;2621.973780262211;2626.8817903194404;4608.986023074918;4634.397528321297;4666.273478812861;4697.365855609517;4712.81148754046;4985.576226020757;4988.825391111293;5026.220935754964;5043.87390315245;5079.187330027178;4662.717752617989;4666.813327466931;4684.648651351163;4693.366395536627;4694.577488025958;4660.370849935215;4896.2410826321975;4900.803967841389;4903.26451032348;4906.816466672297;4883.291922671122;4896.559309662005;4899.824042229768;4899.828506002273;4933.755141410577;4676.883077923079;4707.364505791675;4722.338872557913;4743.620510359232;4747.810087596457;3333.399988002183;3497.930041399107;3518.683318501347;3522.2779330237754;3522.859085636546;5024.638419942621;5047.924281135713;5052.494750524918;5055.721935293447;5074.112030394593;4917.139500587311;4927.876803079952;4935.136351138464;4937.530934561211;4944.022391043612;4681.274402467623;4941.555260026615;4967.9006419870675;4989.2516122580455;4992.6255530834605;4853.951460485491;4894.632902532253;4907.9263811043575;4909.852704418873;4920.31115643803;5002.724850133278;5003;5008.198688209869;5016.347874776256;5023.497650234947;4769.379980602499;4837.419509658723;4844.394450693663;4854.68444551103;4867.342908707279 07:36:47 INFO - PROCESS | 2289 | |5;yui.html;610.2615834839844;641.4964253061348;651.6904470376571;714.0931017607638;714.1251966341233;12642.557510487135;13671.384787684554;13711.520096796614;13732.382042808073;13745.999999999987;12850.48598056079;12973.675658108552;13009.73980520389;13045.478180872753;13070.607881763563;592.4756590417479;610.6305685060541;727.1165533876339;740.0305599664457;751.0874287740394;741.2402287655169;741.8367959049001;741.9517731347445;742.191011797141;742.6992068212382;784.3215618489994;791.0586402181415;792.9405294602899;792.9762107136795;792.9801754956114;626.242246881272;639.5555089212999;756.9848603027964;792.2552800367694;793.714262865368;582.0919365789382;582.3739480058912;582.5194214772787;582.6329412470159;582.7173820697001;13045.282509461977;13118.409671564803;13123.14699544536;13129.934350328283;13131.671708207276;12062.758744825142;12159;12482.625521234288;12552.560660376934;12657.873421265762;11093.374305354577;11134.610288639858;11189.37592534437;11339.37633430161;11441.370724610144;3984.5417776955733;4001.639852413268;4004.0990777075217;4075.857344992911;4079.5920407959266;60952.695236523534;62453.37546624521;62938;64053.35946640567;64436;9579.233661307078;9732.75668108303;9763.511824408752;9829.361091529028;9898;18061.187246573936;18071;18345.17446714901;18419.72370414445;18632.347867824563;6250.593711408744;6268.310485846553;6268.874622507525;6462.483001359974;6533.216014078341;3423.965760342365;3426.931461370759;3465.4108801503803;3507.877224297137;3518.225990282134;2560.347111486559;2648.576227803542;2652.9469410611678;2657.3755167535614;2659.9202023939315;453.2883373104261;455.12388651845725;463.2379735335422;466.0608873120665;473.02084684702334;512.1344927073234;513.7071869034614;521.8590980435262;538.5476199992025;543.3371287029818;6739.416237184258;6888.483363747739;6932.341427564374;6955.82610434733;7065.467266366816;456.3041361923094;522.8640553456129;533.1549494051972;540.106124364178;543.429399130911;3156.6527681954967;3280.6883346082564;3296.027671836814;3330.467125259947;3330.766846320783;64986.35013649898;68754;70678;73952.63023684848;74157.6292118536;63502;64174.67912660407;65012.674936625015;65231.67384163144;66389;58449;59630;59966.400335996084;61266.38733612696;62421.68789156025;6355.682215889279;6459.773907913201;6516.771912983023;6524.184476940382;6776.728930842908;40160.799196005;40209.39685904772;40762.79618601888;42505.36241956311;43441.56558434375;38330.61669383382;41744;42214.57785422107;42970.57029429666;46554.767226163654;11042.889571104508;11074.612388566362;11082.279651822606;11220.934011268917;11328.433578320886;12254.693632659255;12450.377481125726;12678.239305641691;13022.609321720363;13376.665583360495;8314.127016663164;9376.390534615228;11165.16261280391;11750.412479375826;12509.18690285165;11485.655430337103;11732.94133529327;12019.879801201876;12143.332116733665;12144.574939877062;11821.940890295493;12239.265644061385;12258.816117758062;12429.12996090265;12567.371631418575;8644.481331120152;9211.263098951933;9224.005144386754;9929.65246216379;9954.104130628279;9360.578773955325;10079.143272821892;10245;10270.845937311096;10295.3822770634 07:36:47 INFO - PROCESS | 2289 | __end_tp_report 07:36:47 INFO - PROCESS | 2289 | __start_cc_report 07:36:47 INFO - PROCESS | 2289 | _x_x_mozilla_cycle_collect,2813 07:36:47 INFO - PROCESS | 2289 | __end_cc_report 07:36:47 INFO - PROCESS | 2289 | __startTimestamp1480952207329__endTimestamp 07:36:47 INFO - PROCESS | 2289 | 07:36:47 INFO - PROCESS | 2289 | ------- Summary: start ------- 07:36:47 INFO - PROCESS | 2289 | Number of tests: 6 07:36:47 INFO - PROCESS | 2289 | 07:36:47 INFO - PROCESS | 2289 | [#0] dojo.html Cycles:165 Average:4629.28 Median:4764.60 stddev:475.92 (10.0%) stddev-sans-first:450.50 07:36:47 INFO - PROCESS | 2289 | Values: 2619.3 2620.7 2629.3 2659.2 2670.3 4579.0 4619.5 4666.5 4684.8 4708.4 4671.0 4672.4 4736.3 4751.7 4779.4 4266.0 4297.5 4298.3 4310.4 4376.3 4022.0 4363.3 4417.3 4421.9 4457.5 4169.1 4206.8 4208.9 4349.2 4391.2 4269.9 4272.5 4280.3 4280.5 4283.2 4259.7 4260.9 4266.0 4271.3 4275.2 4611.2 4618.3 4630.1 4633.6 4640.5 4897.5 4938.8 4941.0 4947.1 4948.8 4967.8 4972.0 5029.4 5048.3 5073.8 4764.6 4765.4 4767.3 4810.9 4816.6 5127.1 5192.8 5205.2 5208.3 5209.3 4804.2 4846.0 4858.9 4935.7 5063.4 5008.3 5008.5 5012.1 5015.9 5028.1 4957.2 4967.4 4970.3 4972.3 4973.0 5024.7 5104.0 5108.8 5109.6 5113.4 4304.4 4312.2 4313.2 4363.7 4369.8 3731.2 3827.4 3843.6 3850.3 3869.6 4174.9 4203.5 4214.6 4307.7 4412.8 4982.6 5071.3 5084.9 5118.7 5145.0 4357.2 4363.7 4364.6 4365.0 4412.8 4425.9 4457.6 4566.8 4574.3 4611.9 4709.3 4726.1 4727.8 4728.1 4731.2 4957.3 4985.6 4992.4 5011.1 5025.1 4690.4 4743.6 4755.8 4796.0 4804.8 4946.3 4947.1 4956.5 4962.9 5009.1 4823.3 4862.7 4981.4 5023.1 5037.5 4796.5 4800.4 4802.5 4804.3 4816.2 4781.0 4781.4 4784.1 4794.9 4800.9 4708.6 4718.2 4735.5 4748.8 4761.8 4858.2 4859.2 4868.4 4871.6 4878.5 4773.8 4775.5 4790.5 4796.2 4797.2 07:36:47 INFO - PROCESS | 2289 | 07:36:47 INFO - PROCESS | 2289 | [#1] ext.html Cycles:180 Average:44217.43 Median:349899.50 stddev:76298.67 (21.8%) stddev-sans-first:76442.28 07:36:47 INFO - PROCESS | 2289 | Values: 555.7 570.2 583.1 584.6 596.8 37135.3 38056.6 38338.2 42124.6 42469.6 39195.4 39696.6 39719.6 39758.6 39823.4 7297.0 7325.9 7489.4 7506.4 7514.2 9314.7 9691.0 9700.5 9951.7 9966.3 9764.8 9855.3 9864.6 9866.6 9868.3 9740.2 9767.0 9793.0 9793.3 9803.4 9575.3 9637.7 9639.4 9642.0 9647.0 36808.4 37258.4 37304.4 37311.3 37332.8 3040.9 3067.0 3312.4 3518.2 3564.2 26920.2 27157.7 27364.0 27501.3 28598.3 3286.5 3293.2 3332.9 3362.3 3418.8 229651.0 230213.0 230370.0 231500.0 231588.0 50746.0 51150.2 51190.5 51207.7 51322.5 53390.2 53599.0 53710.7 53766.5 53849.7 14020.2 14444.3 14465.9 14482.1 14484.8 10101.0 10302.2 10341.6 10592.1 11187.1 14620.1 16356.5 16823.3 16832.5 17364.2 5890.8 6049.6 6118.8 6174.1 6349.4 750.2 821.8 831.3 932.9 948.3 24860.8 25982.6 26761.2 26780.0 26869.7 915.3 929.1 937.5 968.4 983.9 12831.7 13250.3 13866.0 13912.0 13941.3 346080.0 347509.0 349862.0 349937.0 350041.0 47069.0 47207.3 47210.5 47218.3 47234.8 1050.5 1076.5 1123.0 1159.4 1172.4 24655.6 28136.6 28335.4 28374.9 28949.7 41216.8 41774.6 41795.0 41823.6 41888.8 279445.0 281160.0 282464.0 282601.0 282715.0 23991.6 24163.8 24565.1 25092.5 34487.7 38009.4 38012.2 38545.8 38889.0 39108.2 34006.0 34527.0 34626.5 34627.8 34904.5 32952.5 33057.7 33320.8 33582.7 34354.8 33592.7 33608.3 33697.8 33878.5 34052.0 29298.4 30263.2 31484.2 31493.4 31626.0 23940.5 23976.5 24033.6 24378.9 24394.4 07:36:47 INFO - PROCESS | 2289 | 07:36:47 INFO - PROCESS | 2289 | [#2] jquery.html Cycles:180 Average:22313.89 Median:4820.23 stddev:58522.95 (1214.1%) stddev-sans-first:58663.87 07:36:47 INFO - PROCESS | 2289 | Values: 344.0 356.1 371.1 376.8 382.5 12396.4 12493.9 13725.1 14063.9 16777.5 16192.8 16366.2 16701.9 16826.9 16829.9 4782.3 4817.9 4921.2 4946.9 4950.7 3665.3 3855.5 4908.7 4952.3 4970.2 3828.1 3849.8 3865.7 3872.2 3900.9 5784.1 5879.4 5886.6 5887.5 5889.5 4545.8 4785.0 4822.6 5204.2 5207.1 11515.7 11568.0 11632.8 11646.9 11664.2 1702.4 1764.3 1811.4 1858.2 1868.1 8427.8 8564.2 8580.4 8847.8 9093.5 1644.4 1644.7 1651.5 1677.7 1690.6 64521.0 65018.0 67339.0 68013.0 68165.3 9060.5 9439.6 9907.1 9918.7 10004.6 12601.5 12628.7 12644.2 12644.6 12790.8 5384.9 5440.4 5632.7 6778.7 7004.3 6414.3 6461.1 6556.1 6579.9 6619.2 4204.2 4240.6 4256.0 4286.8 4333.3 1679.2 1704.2 1734.6 1757.7 1779.2 785.4 802.3 843.4 847.5 890.4 15544.2 16691.5 16803.2 16921.5 16991.0 784.6 817.4 850.5 869.1 897.5 8667.5 8905.9 9372.3 9417.4 9514.6 335373.0 354730.0 357945.0 359243.0 360834.0 53456.7 69261.5 70724.0 71290.3 73945.0 768.1 787.8 806.0 807.0 807.7 14836.9 14937.3 15504.5 15640.3 15845.3 36810.8 37626.0 37721.6 38506.2 38565.6 46758.0 50113.0 50153.7 50977.7 53156.0 7104.9 7356.3 7401.3 7447.7 7569.3 6641.7 8188.8 9688.8 11315.7 11363.3 9465.1 9739.0 9778.9 10293.4 10294.3 9915.8 10068.6 10132.7 10276.0 10402.7 9917.6 10027.6 10078.4 10206.2 10435.9 7166.3 7371.2 7401.7 7521.3 7569.0 8578.2 9690.0 9764.2 9951.9 10643.1 07:36:47 INFO - PROCESS | 2289 | 07:36:47 INFO - PROCESS | 2289 | [#3] mootools.html Cycles:180 Average:4597.01 Median:5764.58 stddev:2443.67 (42.4%) stddev-sans-first:2438.06 07:36:47 INFO - PROCESS | 2289 | Values: 1313.7 1357.2 1379.9 1579.9 1637.6 5909.4 6097.5 6669.7 7023.3 7028.2 6501.5 6662.3 6710.2 6818.6 6835.1 2000.6 2034.2 2038.6 2039.4 2040.0 1745.1 1806.3 2030.2 2061.5 2071.6 1964.9 2046.2 2050.1 2051.3 2052.4 2044.0 2081.0 2082.7 2104.7 2104.8 2048.8 2096.6 2098.7 2099.5 2100.4 6959.0 6981.9 6984.4 7019.9 7026.0 4101.9 4143.7 4260.6 4270.7 4287.5 2585.2 2673.8 2735.6 2742.3 2749.9 796.2 809.2 810.0 811.2 858.9 9074.5 9092.3 9107.9 9110.4 9125.8 3550.6 3791.8 3848.7 3854.2 3932.1 8031.0 8035.1 8079.7 8088.8 8092.8 4330.6 4330.7 4332.0 4333.5 4337.8 3775.8 3982.0 3983.3 3987.4 3987.7 3295.6 3313.9 3360.1 3432.0 3446.1 896.9 921.6 1095.9 1130.1 1138.2 702.1 724.7 736.5 792.4 818.2 4642.7 4706.8 4728.5 4817.5 4873.5 813.5 843.6 845.6 859.1 873.2 3170.8 3262.7 3324.6 3343.9 3439.6 7685.5 7823.0 7971.7 8025.6 8370.7 8218.5 8226.0 8231.8 8240.8 8253.4 6388.6 6488.5 6551.0 6594.8 6610.2 4979.0 5084.8 5119.2 5125.4 5126.6 7514.8 7642.8 7735.5 7739.5 7808.0 7546.2 7867.2 7900.6 7929.8 7999.6 5867.7 6033.9 6036.6 6037.1 6038.8 6482.7 6546.3 6553.3 6554.1 6560.2 5932.3 6036.0 6092.5 6126.9 6156.1 5997.4 6068.3 6117.1 6205.7 6272.7 5655.7 5757.0 5762.7 5766.5 5768.4 4293.5 4321.1 4383.9 4457.2 4466.0 4226.3 4321.7 4376.4 4398.3 4420.1 07:36:47 INFO - PROCESS | 2289 | 07:36:47 INFO - PROCESS | 2289 | [#4] prototype.html Cycles:180 Average:4059.49 Median:4633.79 stddev:1181.36 (25.5%) stddev-sans-first:1150.04 07:36:47 INFO - PROCESS | 2289 | Values: 276.3 278.1 278.2 286.4 288.3 4555.6 4684.5 4730.6 4776.8 4783.7 4542.2 4617.2 4628.5 4633.2 4657.7 3514.3 3619.0 3672.9 3685.2 3688.3 3553.1 3655.6 3659.6 3661.9 3678.7 3626.8 3636.6 3639.9 3677.6 3688.9 3676.7 3681.3 3692.6 3693.1 3697.3 3121.4 3220.6 3234.7 3252.0 3270.7 4552.9 4555.3 4571.2 4578.4 4580.1 4141.7 4148.8 4148.9 4153.8 4164.3 4704.3 4879.2 4917.3 4937.4 4947.0 3457.9 3496.7 3509.1 3510.7 3522.6 5099.4 5110.8 5111.2 5112.8 5119.3 3597.1 3602.7 3614.3 3622.8 3623.9 3567.4 3611.1 3627.6 3679.7 3682.5 4119.6 4123.2 4125.1 4148.8 4151.4 4647.3 4769.0 4786.4 4792.7 4906.9 1189.3 1192.5 1197.2 1197.4 1224.0 844.1 848.3 850.5 856.7 857.7 4208.9 4209.0 4210.2 4221.2 4227.9 4875.7 5086.8 5111.2 5128.7 5144.0 4422.0 4431.6 4432.6 4434.2 4434.9 2542.8 2604.2 2607.0 2622.0 2626.9 4609.0 4634.4 4666.3 4697.4 4712.8 4985.6 4988.8 5026.2 5043.9 5079.2 4662.7 4666.8 4684.6 4693.4 4694.6 4660.4 4896.2 4900.8 4903.3 4906.8 4883.3 4896.6 4899.8 4899.8 4933.8 4676.9 4707.4 4722.3 4743.6 4747.8 3333.4 3497.9 3518.7 3522.3 3522.9 5024.6 5047.9 5052.5 5055.7 5074.1 4917.1 4927.9 4935.1 4937.5 4944.0 4681.3 4941.6 4967.9 4989.3 4992.6 4854.0 4894.6 4907.9 4909.9 4920.3 5002.7 5003.0 5008.2 5016.3 5023.5 4769.4 4837.4 4844.4 4854.7 4867.3 07:36:47 INFO - PROCESS | 2289 | 07:36:47 INFO - PROCESS | 2289 | [#5] yui.html Cycles:180 Average:15299.92 Median:23510.41 stddev:19909.26 (84.7%) stddev-sans-first:19934.55 07:36:47 INFO - PROCESS | 2289 | Values: 610.3 641.5 651.7 714.1 714.1 12642.6 13671.4 13711.5 13732.4 13746.0 12850.5 12973.7 13009.7 13045.5 13070.6 592.5 610.6 727.1 740.0 751.1 741.2 741.8 742.0 742.2 742.7 784.3 791.1 792.9 793.0 793.0 626.2 639.6 757.0 792.3 793.7 582.1 582.4 582.5 582.6 582.7 13045.3 13118.4 13123.1 13129.9 13131.7 12062.8 12159.0 12482.6 12552.6 12657.9 11093.4 11134.6 11189.4 11339.4 11441.4 3984.5 4001.6 4004.1 4075.9 4079.6 60952.7 62453.4 62938.0 64053.4 64436.0 9579.2 9732.8 9763.5 9829.4 9898.0 18061.2 18071.0 18345.2 18419.7 18632.3 6250.6 6268.3 6268.9 6462.5 6533.2 3424.0 3426.9 3465.4 3507.9 3518.2 2560.3 2648.6 2652.9 2657.4 2659.9 453.3 455.1 463.2 466.1 473.0 512.1 513.7 521.9 538.5 543.3 6739.4 6888.5 6932.3 6955.8 7065.5 456.3 522.9 533.2 540.1 543.4 3156.7 3280.7 3296.0 3330.5 3330.8 64986.4 68754.0 70678.0 73952.6 74157.6 63502.0 64174.7 65012.7 65231.7 66389.0 58449.0 59630.0 59966.4 61266.4 62421.7 6355.7 6459.8 6516.8 6524.2 6776.7 40160.8 40209.4 40762.8 42505.4 43441.6 38330.6 41744.0 42214.6 42970.6 46554.8 11042.9 11074.6 11082.3 11220.9 11328.4 12254.7 12450.4 12678.2 13022.6 13376.7 8314.1 9376.4 11165.2 11750.4 12509.2 11485.7 11732.9 12019.9 12143.3 12144.6 11821.9 12239.3 12258.8 12429.1 12567.4 8644.5 9211.3 9224.0 9929.7 9954.1 9360.6 10079.1 10245.0 10270.8 10295.4 07:36:47 INFO - PROCESS | 2289 | -------- Summary: end -------- 07:36:47 INFO - PROCESS | 2289 | 07:36:48 INFO - TEST-INFO | 2289: exit 0 07:36:48 INFO - TEST-OK | dromaeo_css | took 1124804ms 07:36:48 INFO - TEST-START | kraken 07:36:48 INFO - operating with platform_type : linux_ 07:36:48 INFO - Initialising browser for kraken test... 07:36:48 INFO - TEST-INFO | started process 2689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3hXiOT/profile http://localhost:34719/getInfo.html) 07:36:52 INFO - PROCESS | 2689 | __metrics Screen width/height:1600/1200 07:36:52 INFO - PROCESS | 2689 | colorDepth:24 07:36:52 INFO - PROCESS | 2689 | Browser inner width/height: 1024/697 07:36:52 INFO - PROCESS | 2689 | __metrics 07:36:53 INFO - PROCESS | 2689 | 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" 07:36:53 INFO - PROCESS | 2689 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:53 INFO - PROCESS | 2689 | console.error: 07:36:53 INFO - PROCESS | 2689 | Message: Error: Connection closed before committing the transaction. 07:36:53 INFO - PROCESS | 2689 | Stack: 07:36:53 INFO - PROCESS | 2689 | executeTransaction/promise resource://gre/modules/Promise-backend.js:932:23 07:36:53 INFO - PROCESS | 2689 | walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 07:36:53 INFO - PROCESS | 2689 | Promise*scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 07:36:53 INFO - PROCESS | 2689 | schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 07:36:53 INFO - PROCESS | 2689 | completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 07:36:53 INFO - PROCESS | 2689 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 07:36:53 INFO - PROCESS | 2689 | observe@resource://gre/modules/AsyncShutdown.jsm:550:9 07:36:53 INFO - PROCESS | 2689 | addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 07:36:53 INFO - PROCESS | 2689 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:386:5 07:36:53 INFO - PROCESS | 2689 | moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 07:36:53 INFO - PROCESS | 2689 | trigger@resource://gre/modules/AsyncShutdown.jsm:719:23 07:36:53 INFO - PROCESS | 2689 | _wait@resource://gre/modules/AsyncShutdown.jsm:866:7 07:36:53 INFO - PROCESS | 2689 | wait@resource://gre/modules/AsyncShutdown.jsm:850:28 07:36:53 INFO - PROCESS | 2689 | observe@resource://gre/modules/AsyncShutdown.jsm:533:17 07:36:53 INFO - PROCESS | 2689 | 07:36:54 INFO - PROCESS | 2689 | console.error: PushService: 07:36:54 INFO - PROCESS | 2689 | stateChangeProcessEnqueue: Error transitioning state 07:36:54 INFO - PROCESS | 2689 | UnknownError 07:36:55 INFO - TEST-INFO | 2689: exit 0 07:36:55 INFO - Browser initialized. 07:36:55 INFO - Running cycle 1/1 for kraken test... 07:36:55 INFO - TEST-INFO | started process 2838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3hXiOT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:07 INFO - PROCESS | 2838 | RSS: Main: 173891584 07:37:07 INFO - PROCESS | 2838 | 07:37:10 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34719/tests/kraken/driver.html?testName=audio-beat-detection) 07:37:11 INFO - PROCESS | 2838 | RSS: Main: 239964160 07:37:11 INFO - PROCESS | 2838 | 07:37:13 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34719/tests/kraken/driver.html?testName=audio-dft) 07:37:14 INFO - PROCESS | 2838 | RSS: Main: 218071040 07:37:14 INFO - PROCESS | 2838 | 07:37:17 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34719/tests/kraken/driver.html?testName=audio-fft) 07:37:18 INFO - PROCESS | 2838 | RSS: Main: 300515328 07:37:18 INFO - PROCESS | 2838 | 07:37:20 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34719/tests/kraken/driver.html?testName=audio-oscillator) 07:37:20 INFO - PROCESS | 2838 | RSS: Main: 212033536 07:37:20 INFO - PROCESS | 2838 | 07:37:23 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34719/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:37:23 INFO - PROCESS | 2838 | RSS: Main: 215248896 07:37:23 INFO - PROCESS | 2838 | 07:37:26 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34719/tests/kraken/driver.html?testName=imaging-darkroom) 07:37:27 INFO - PROCESS | 2838 | RSS: Main: 254246912 07:37:27 INFO - PROCESS | 2838 | 07:37:31 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34719/tests/kraken/driver.html?testName=imaging-desaturate) 07:37:31 INFO - PROCESS | 2838 | RSS: Main: 248160256 07:37:31 INFO - PROCESS | 2838 | 07:37:34 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34719/tests/kraken/driver.html?testName=json-parse-financial) 07:37:35 INFO - PROCESS | 2838 | RSS: Main: 249315328 07:37:35 INFO - PROCESS | 2838 | 07:37:36 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34719/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:37:37 INFO - PROCESS | 2838 | RSS: Main: 213221376 07:37:37 INFO - PROCESS | 2838 | 07:37:39 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34719/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:37:40 INFO - PROCESS | 2838 | RSS: Main: 220868608 07:37:40 INFO - PROCESS | 2838 | 07:37:42 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34719/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:37:42 INFO - PROCESS | 2838 | RSS: Main: 228720640 07:37:42 INFO - PROCESS | 2838 | 07:37:45 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:37:46 INFO - PROCESS | 2838 | RSS: Main: 237953024 07:37:46 INFO - PROCESS | 2838 | 07:37:49 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:37:50 INFO - PROCESS | 2838 | RSS: Main: 234729472 07:37:50 INFO - PROCESS | 2838 | 07:37:51 INFO - PROCESS | 2838 | Cycle 1(1): loaded http://localhost:34719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34719/tests/kraken/driver.html?testName=ai-astar) 07:37:52 INFO - PROCESS | 2838 | RSS: Main: 286392320 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | __start_tp_report 07:37:52 INFO - PROCESS | 2838 | _x_x_mozilla_page_load 07:37:52 INFO - PROCESS | 2838 | _x_x_mozilla_page_load_details 07:37:52 INFO - PROCESS | 2838 | |i|pagename|runs| 07:37:52 INFO - PROCESS | 2838 | |0;ai-astar;115;116;116;115;117;116;117;114;114;114 07:37:52 INFO - PROCESS | 2838 | |1;audio-beat-detection;164;131;128;168;130;131;132;135;150;130 07:37:52 INFO - PROCESS | 2838 | |2;audio-dft;162;162;163;162;162;163;162;161;163;162 07:37:52 INFO - PROCESS | 2838 | |3;audio-fft;76;78;77;109;76;77;77;77;93;76 07:37:52 INFO - PROCESS | 2838 | |4;audio-oscillator;83;83;103;83;82;84;110;83;83;111 07:37:52 INFO - PROCESS | 2838 | |5;imaging-gaussian-blur;117;117;116;116;117;117;118;116;117;117 07:37:52 INFO - PROCESS | 2838 | |6;imaging-darkroom;148;148;146;146;147;147;146;146;146;146 07:37:52 INFO - PROCESS | 2838 | |7;imaging-desaturate;95;96;95;95;95;95;96;96;95;95 07:37:52 INFO - PROCESS | 2838 | |8;json-parse-financial;65;63;64;63;65;65;64;64;64;65 07:37:52 INFO - PROCESS | 2838 | |9;json-stringify-tinderbox;66;66;66;66;67;65;66;66;67;66 07:37:52 INFO - PROCESS | 2838 | |10;stanford-crypto-aes;86;85;89;91;88;85;84;90;89;84 07:37:52 INFO - PROCESS | 2838 | |11;stanford-crypto-ccm;150;141;141;159;141;159;151;138;196;140 07:37:52 INFO - PROCESS | 2838 | |12;stanford-crypto-pbkdf2;180;183;177;180;181;182;181;180;175;177 07:37:52 INFO - PROCESS | 2838 | |13;stanford-crypto-sha256-iterative;71;71;71;70;72;76;70;70;68;69 07:37:52 INFO - PROCESS | 2838 | __end_tp_report 07:37:52 INFO - PROCESS | 2838 | __start_cc_report 07:37:52 INFO - PROCESS | 2838 | _x_x_mozilla_cycle_collect,1952 07:37:52 INFO - PROCESS | 2838 | __end_cc_report 07:37:52 INFO - PROCESS | 2838 | __startTimestamp1480952272211__endTimestamp 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | ------- Summary: start ------- 07:37:52 INFO - PROCESS | 2838 | Number of tests: 14 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:1.17 (1.0%) stddev-sans-first:1.24 07:37:52 INFO - PROCESS | 2838 | Values: 115.0 116.0 116.0 115.0 117.0 116.0 117.0 114.0 114.0 114.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:133.50 stddev:15.11 (11.3%) stddev-sans-first:13.27 07:37:52 INFO - PROCESS | 2838 | Values: 164.0 131.0 128.0 168.0 130.0 131.0 132.0 135.0 150.0 130.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:37:52 INFO - PROCESS | 2838 | Values: 162.0 162.0 163.0 162.0 162.0 163.0 162.0 161.0 163.0 162.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#3] audio-fft Cycles:10 Average:81.60 Median:77.00 stddev:10.92 (14.2%) stddev-sans-first:11.39 07:37:52 INFO - PROCESS | 2838 | Values: 76.0 78.0 77.0 109.0 76.0 77.0 77.0 77.0 93.0 76.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:83.00 stddev:12.26 (14.8%) stddev-sans-first:12.70 07:37:52 INFO - PROCESS | 2838 | Values: 83.0 83.0 103.0 83.0 82.0 84.0 110.0 83.0 83.0 111.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 07:37:52 INFO - PROCESS | 2838 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 118.0 116.0 117.0 117.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 07:37:52 INFO - PROCESS | 2838 | Values: 148.0 148.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:37:52 INFO - PROCESS | 2838 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 07:37:52 INFO - PROCESS | 2838 | Values: 65.0 63.0 64.0 63.0 65.0 65.0 64.0 64.0 64.0 65.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 07:37:52 INFO - PROCESS | 2838 | Values: 66.0 66.0 66.0 66.0 67.0 65.0 66.0 66.0 67.0 66.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:88.50 stddev:2.60 (2.9%) stddev-sans-first:2.73 07:37:52 INFO - PROCESS | 2838 | Values: 86.0 85.0 89.0 91.0 88.0 85.0 84.0 90.0 89.0 84.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#11] stanford-crypto-ccm Cycles:10 Average:151.60 Median:150.50 stddev:17.45 (11.6%) stddev-sans-first:18.50 07:37:52 INFO - PROCESS | 2838 | Values: 150.0 141.0 141.0 159.0 141.0 159.0 151.0 138.0 196.0 140.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:180.50 stddev:2.50 (1.4%) stddev-sans-first:2.65 07:37:52 INFO - PROCESS | 2838 | Values: 180.0 183.0 177.0 180.0 181.0 182.0 181.0 180.0 175.0 177.0 07:37:52 INFO - PROCESS | 2838 | 07:37:52 INFO - PROCESS | 2838 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:2.15 (3.0%) stddev-sans-first:2.28 07:37:52 INFO - PROCESS | 2838 | Values: 71.0 71.0 71.0 70.0 72.0 76.0 70.0 70.0 68.0 69.0 07:37:52 INFO - PROCESS | 2838 | -------- Summary: end -------- 07:37:52 INFO - PROCESS | 2838 | 07:37:53 INFO - TEST-INFO | 2838: exit 0 07:37:53 INFO - TEST-OK | kraken | took 65254ms 07:37:53 INFO - SUITE-END | took 1190s 07:37:53 INFO - Completed test suite (00:19:50) 07:37:53 INFO - javascript benchmark 07:37:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.305883940755, 2620.7117217106115, 2629.2506635608847, 2659.188947371051, 2670.2656769388414, 4579.038401935598, 4619.514950930155, 4666.533346665332, 4684.83603073892, 4708.387909571755, 4671.0, 4672.415948006499, 4736.265878788793, 4751.667383283171, 4779.402574678165, 4265.978670106645, 4297.484301883763, 4298.312270036795, 4310.418093557361, 4376.256036473807, 4022.0337501092877, 4363.301871700529, 4417.315316126005, 4421.867343979686, 4457.465104187486, 4169.10364271683, 4206.810693518768, 4208.85269015583, 4349.151915376471, 4391.165678521103, 4269.914601707979, 4272.46594175728, 4280.336547835091, 4280.507741609693, 4283.20760659279, 4259.680523960685, 4260.893477663052, 4266.040140968288, 4271.31658934569, 4275.230458517465, 4611.193041217807, 4618.261078227468, 4630.143423466636, 4633.62930965522, 4640.535946405333, 4897.534734200245, 4938.753062346868, 4941.036497882914, 4947.109520286347, 4948.826791062295, 4967.751612419364, 4972.03045406146, 5029.446760856303, 5048.268001139851, 5073.771680274396, 4764.595009424169, 4765.356676848651, 4767.308740232716, 4810.855674329776, 4816.614670826326, 5127.128388174019, 5192.766325515286, 5205.167173252262, 5208.348956380452, 5209.270702101709, 4804.183288840905, 4846.030793841246, 4858.902821943541, 4935.728534930613, 5063.367079115111, 5008.273800298936, 5008.549230569266, 5012.072766538202, 5015.924761128586, 5028.069807085701, 4957.182064959314, 4967.428745694291, 4970.254461830755, 4972.279019542146, 4973.0, 5024.723640199751, 5104.0, 5108.846734597968, 5109.616778741535, 5113.411957624847, 4304.418903447994, 4312.202242585132, 4313.245182093121, 4363.738175709467, 4369.781510924441, 3731.2164445466215, 3827.4258861171047, 3843.6348546888003, 3850.2876967761053, 3869.5743468218475, 4174.937375939363, 4203.516595591485, 4214.557471465513, 4307.741535507879, 4412.779361031936, 4982.626303027215, 5071.264666623319, 5084.898302033938, 5118.692878427306, 5145.0, 4357.237483440385, 4363.738175709467, 4364.62900653448, 4364.956350436519, 4412.779361031936, 4425.889352766142, 4457.598816106566, 4566.794494247767, 4574.313852922021, 4611.9077618447445, 4709.340692303149, 4726.078414709099, 4727.810887564459, 4728.148933192058, 4731.243001119804, 4957.281194226744, 4985.551300382983, 4992.425871024879, 5011.072951503984, 5025.120603894377, 4690.366800482027, 4743.644226683082, 4755.762211889461, 4796.040791841576, 4804.8318308859025, 4946.307516947702, 4947.060058588857, 4956.454789973172, 4962.851114466572, 5009.073321435546, 4823.324734537237, 4862.708237505761, 4981.427135879276, 5023.070731914608, 5037.462139327165, 4796.496367881322, 4800.35195248637, 4802.471728109975, 4804.3273941648895, 4816.205326121291, 4780.95219047819, 4781.378420805273, 4784.067106914118, 4794.880127996688, 4800.903981920273, 4708.646851486221, 4718.150732868116, 4735.502772208868, 4748.8100475981955, 4761.761911904322, 4858.246971719389, 4859.246816743411, 4868.391451068616, 4871.561559459666, 4878.512148785235, 4773.809047638056, 4775.5224477551965, 4790.520947905321, 4796.160671882337, 4797.232442809134], "value": 4599.671675663214, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.7110302642626, 570.2102587915738, 583.1398686936769, 584.573261519091, 596.826920193144, 37135.25729485412, 38056.61943380565, 38338.23323533531, 42124.578754212525, 42469.57530424695, 39195.412068818994, 39696.60303396965, 39719.60280397195, 39758.60241397585, 39823.40264896022, 7296.963515182443, 7325.853482930338, 7489.438292128085, 7506.399488040971, 7514.173440921521, 9314.717894115916, 9690.951545242264, 9700.466474343908, 9951.701448956506, 9966.302358834884, 9764.755881102994, 9855.310128291023, 9864.605415783395, 9866.556004979757, 9868.259880508955, 9740.172085372751, 9767.023297670212, 9792.951035244849, 9793.265505087147, 9803.362781419184, 9575.329726919119, 9637.747092877951, 9639.42163470187, 9641.951790241073, 9647.0, 36808.44787328192, 37258.44112338317, 37304.44043339352, 37311.25377492462, 37332.81333593342, 3040.939181216363, 3067.0, 3312.403767321881, 3518.190816112283, 3564.198055437532, 26920.192394228205, 27157.728422715914, 27364.0, 27501.31246718848, 28598.285042873886, 3286.4905939579403, 3293.226091868409, 3332.916677083068, 3362.3443428531446, 3418.8290585470627, 229651.0, 230213.0, 230370.0, 231500.0, 231588.0, 50746.0, 51150.23274650883, 51190.48809511932, 51207.74396127996, 51322.48677513177, 53390.19914701283, 53599.0, 53710.73144634252, 53766.46233537615, 53849.73075134599, 14020.1587904724, 14444.277786110653, 14465.92767036179, 14482.058666186875, 14484.782728259084, 10101.0, 10302.227332950059, 10341.586336546454, 10592.099671528007, 11187.105031597453, 14620.122792632475, 16356.509304720877, 16823.32706691743, 16832.495025149266, 17364.218610162574, 5890.823275301748, 6049.606775559574, 6118.847028824315, 6174.104754810527, 6349.428551430394, 750.1748077115238, 821.765796747924, 831.3349320543541, 932.934694571387, 948.2508818033814, 24860.751392486207, 25982.610260846104, 26761.197164085108, 26780.0, 26869.731302687112, 915.2906497464385, 929.1173385283872, 937.5078084005816, 968.375397868371, 983.8819341679044, 12831.679208019688, 13250.337483125997, 13866.0, 13912.0, 13941.302934853216, 346080.0, 347509.0, 349862.0, 349937.0, 350041.0, 47069.0, 47207.291890621666, 47210.52789472061, 47218.29172562414, 47234.76382618065, 1050.5220124843179, 1076.4671487613525, 1123.0, 1159.4202898550725, 1172.4137931034484, 24655.63016554789, 28136.57795133034, 28335.43329133447, 28374.85812570924, 28949.7105028947, 41216.79391603023, 41774.58225417707, 41795.0, 41823.58176418197, 41888.79055604825, 279445.0, 281160.0, 282464.0, 282601.0, 282715.0, 23991.640125397786, 24163.758362416855, 24565.140220092926, 25092.498150037263, 34487.65512344945, 38009.42985855159, 38012.23975520529, 38545.807270963465, 38889.0, 39108.21783564256, 34006.0, 34527.0, 34626.48060279048, 34627.826860865534, 34904.47643285403, 32952.505712414815, 33057.66942330546, 33320.833395832866, 33582.66417335795, 34354.82822585871, 33592.664073359934, 33608.32783344271, 33697.83151084229, 33878.491822623175, 34052.0, 29298.41403171882, 30263.243418913822, 31484.2128946769, 31493.370132597676, 31626.0, 23940.52118957646, 23976.520469590858, 24033.639495407933, 24378.878105609358, 24394.390140246636], "value": 17253.980032039202, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.9501272315513, 356.0653285126541, 371.0575139146568, 376.8492602958816, 382.49892640640763, 12396.442160102795, 12493.918845126636, 13725.107867988574, 14063.929680351584, 16777.496675099737, 16192.83807161928, 16366.181690915466, 16701.91649041756, 16826.915865420655, 16829.91585042073, 4782.306565547993, 4817.903641927168, 4921.212605983043, 4946.87632809179, 4950.727709975949, 3665.3035923174643, 3855.4602355670227, 4908.656394052417, 4952.281919121725, 4970.179920313144, 3828.0812604974744, 3849.826757795906, 3865.6520913117815, 3872.1674839909415, 3900.8634697785583, 5784.103463963072, 5879.353271140171, 5886.6173698709445, 5887.528997680175, 5889.469947704684, 4545.840895568639, 4785.042991401733, 4822.565969062801, 5204.219367094928, 5207.140821764404, 11515.712107197387, 11568.01671857893, 11632.825507617392, 11646.941765291203, 11664.241824281395, 1702.3786317993968, 1764.3119183518438, 1811.429399739078, 1858.228835033473, 1868.0846385271254, 8427.789305267355, 8564.229219370287, 8580.39937204396, 8847.77880552985, 9093.545322733902, 1644.350481559777, 1644.740103304354, 1651.4880387079922, 1677.6812405642888, 1690.5604542818833, 64521.0, 65018.0, 67339.0, 68013.0, 68165.31834681639, 9060.546972651473, 9439.575219115157, 9907.108360247468, 9918.652847150315, 10004.599816007278, 12601.495940162291, 12628.747425051632, 12644.241345519298, 12644.620661380173, 12790.808137877939, 5384.91922621161, 5440.401555828856, 5632.746526406321, 6778.661066946633, 7004.334588214111, 6414.262359828679, 6461.095446637474, 6556.114924485133, 6579.934200657932, 6619.238787539494, 4204.159168166379, 4240.6395456385935, 4255.957440425556, 4286.7856607169515, 4333.306670932636, 1679.2359476438191, 1704.1905095079737, 1734.620084287185, 1757.66604345174, 1779.1549014218142, 785.403093648831, 802.3180296747835, 843.3674743942044, 847.5084451018395, 890.3811850763786, 15544.222788860512, 16691.49925502237, 16803.243854026598, 16921.492355229362, 16991.04169969858, 784.5763287824511, 817.4278005396128, 850.4812064640564, 869.0874581689201, 897.4974014551872, 8667.523286219319, 8905.910940890637, 9372.282038208843, 9417.387869788441, 9514.571844267024, 335373.0, 354730.0, 357945.0, 359243.0, 360834.0, 53456.73271633617, 69261.45908327322, 70724.0, 71290.2870971294, 73945.0, 768.1281745219217, 787.7557957033338, 805.9884844520207, 807.0355924669963, 807.7051876065194, 14836.925815370854, 14937.253137343307, 15504.534863954099, 15640.296186671854, 15845.286962086504, 36810.8159459201, 37626.0, 37721.62278377181, 38506.229875402896, 38565.6143438562, 46758.0, 50113.0, 50153.74923125507, 50977.745111274206, 53156.0, 7104.857902842017, 7356.264373562601, 7401.259874012556, 7447.702091916262, 7569.318761311509, 6641.667916604247, 8188.836223275382, 9688.75778105553, 11315.69869465022, 11363.261388009752, 9465.148136667733, 9738.951305243429, 9778.9022109778, 10293.43386113771, 10294.337367398954, 9915.752106197402, 10068.647597334058, 10132.696019119438, 10276.0, 10402.739931501774, 9917.603295868374, 10027.649032284127, 10078.395296282246, 10206.183505319408, 10435.895641043797, 7166.319199676022, 7371.152317483344, 7401.7039318428815, 7521.323080922743, 7569.016027916336, 8578.227959483676, 9689.982551831956, 9764.218862491125, 9951.900480995097, 10643.148548116287], "value": 7573.485000533053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.7175507265938, 1357.1517801374143, 1379.9379027943742, 1579.8578127968494, 1637.6315329050965, 5909.379515150901, 6097.512199024079, 6669.666516674165, 7023.332783385583, 7028.191757947831, 6501.512386571002, 6662.300458451853, 6710.1947766267995, 6818.5908845469185, 6835.077264569281, 2000.5798782255708, 2034.1659919433037, 2038.6330460517102, 2039.377989713137, 2039.9592008159827, 1745.0838309887283, 1806.2504060814747, 2030.2285131649953, 2061.5361543652707, 2071.637463443899, 1964.9214031438726, 2046.2428901306537, 2050.1389416445054, 2051.2820512820467, 2052.384284714587, 2044.0393015282941, 2081.0, 2082.6980087887246, 2104.715863358442, 2104.7579528354204, 2048.8463365247517, 2096.5597224582857, 2098.674705420662, 2099.464636517678, 2100.4013856051106, 6958.965205173992, 6981.89527157093, 6984.406325462342, 7019.929800701979, 7026.0, 4101.876943691694, 4143.6685065195015, 4260.637845783112, 4270.658347332206, 4287.506936702288, 2585.1598230575137, 2673.759361657441, 2735.5623100303856, 2742.2732975761437, 2749.8900043998215, 796.2316364708026, 809.2393150438569, 809.9676012959475, 811.1726039439739, 858.8840506531601, 9074.546272686339, 9092.318076144249, 9107.863382049209, 9110.362274640778, 9125.771855703593, 3550.609432962372, 3791.8007555617673, 3848.730588858753, 3854.229154169121, 3932.115274063313, 8031.0, 8035.116137224901, 8079.676812927534, 8088.797780055545, 8092.797680058045, 4330.58859408362, 4330.675199360061, 4331.956680433218, 4333.544977777351, 4337.783110844445, 3775.7734535927934, 3982.0443093657314, 3983.322835118037, 3987.401889716508, 3987.7407968481957, 3295.6436148154185, 3313.9171520712175, 3360.1431634933424, 3432.0, 3446.1212390840174, 896.8923729152413, 921.6175287255847, 1095.8739744929276, 1130.1241537808264, 1138.1520767028617, 702.0872865275122, 724.73547155289, 736.4550232827776, 792.3542313014874, 818.1859050245045, 4642.65180111493, 4706.835260765857, 4728.503507131771, 4817.470078291385, 4873.463918968911, 813.5403497024163, 843.6077224090827, 845.6279237135641, 859.1442484234025, 873.1661263493476, 3170.8256045917233, 3262.6574209707637, 3324.5678061851804, 3343.8829640962936, 3439.5872495300223, 7685.5004424712215, 7823.0, 7971.681132754741, 8025.638846251933, 8370.665173393118, 8218.465799722999, 8226.0, 8231.753047408587, 8240.83518329642, 8253.422260441712, 6388.584741991848, 6488.545801793829, 6551.0, 6594.769183078569, 6610.206775187008, 4978.975105124451, 5084.8220312288895, 5119.232115182753, 5125.410577783454, 5126.641135120506, 7514.774556763306, 7642.8089297768, 7735.497192682457, 7739.496932699357, 7808.0, 7546.207648196861, 7867.213278672087, 7900.565468899265, 7929.841403172019, 7999.6400161994015, 5867.6772777497645, 6033.909491357721, 6036.607620504653, 6037.124616930609, 6038.788642397495, 6482.70827812759, 6546.279909209888, 6553.344665533599, 6554.14796076507, 6560.245571759118, 5932.317783454785, 6036.0, 6092.482139018233, 6126.938730612636, 6156.07658851158, 5997.400259973968, 6068.271807383142, 6117.082437634391, 6205.689715514116, 6272.686365681789, 5655.717214139194, 5756.971215143897, 5762.6830524319885, 5766.481016708516, 5768.394318596487, 4293.50624678166, 4321.114171594752, 4383.890402739957, 4457.197704413236, 4466.0, 4226.281532139482, 4321.7406955582765, 4376.387305777257, 4398.340248962553, 4420.071784925201], "value": 3760.275220418451, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.34919763955884, 278.0518432146381, 278.23624151703575, 286.3985630176629, 288.31668944601296, 4555.612772914306, 4684.484706682262, 4730.574248317651, 4776.785044672989, 4783.712977221365, 4542.159700455418, 4617.1919914015, 4628.490866004737, 4633.1891918914225, 4657.743824089674, 3514.3147086318177, 3618.9638103619022, 3672.944905826408, 3685.244524872395, 3688.2623475304913, 3553.1472446612756, 3655.6344365563364, 3659.6340365963456, 3661.9084522886874, 3678.742488025839, 3626.7642603230706, 3636.56361236652, 3639.8726044588443, 3677.558692956849, 3688.8893333199912, 3676.694773355447, 3681.2637472505608, 3692.649198326155, 3693.076730817296, 3697.2605478904325, 3121.378042444335, 3220.6296275928335, 3234.692704193098, 3251.9837400812844, 3270.721988630969, 4552.863414097583, 4555.316702494619, 4571.2457444521615, 4578.404807375054, 4580.07636792548, 4141.668666506672, 4148.751074935513, 4148.879802453351, 4153.771542565158, 4164.312888373414, 4704.341392205094, 4879.243717223836, 4917.286993385975, 4937.358143441365, 4946.950530494685, 3457.913552161191, 3496.667816557423, 3509.104988384593, 3510.6999420544607, 3522.577290725104, 5099.388073431212, 5110.846674599731, 5111.207762796773, 5112.798492354294, 5119.3088932994315, 3597.136687195107, 3602.7117830573493, 3614.29521243355, 3622.8007459589976, 3623.9456408153897, 3567.3935430976794, 3611.115276757159, 3627.5646922369483, 3679.742418030712, 3682.49017902664, 4119.567445418248, 4123.195976784558, 4125.1131006833675, 4148.771817550003, 4151.398047283127, 4647.256438969748, 4769.0, 4786.401699787527, 4792.688475249098, 4906.90186196274, 1189.2864281431073, 1192.4753108632347, 1197.1799317467562, 1197.383347575999, 1223.9510419583116, 844.1431946574232, 848.3086284677968, 850.5407080176759, 856.7192047888446, 857.6740838481337, 4208.873733787991, 4208.9789551052045, 4210.210660469288, 4221.2190744712325, 4227.9365809512265, 4875.68308059975, 5086.847394578169, 5111.207762796773, 5128.69227846323, 5143.974280128576, 4421.955780442218, 4431.623312018514, 4432.623227025674, 4434.157510073141, 4434.933475997863, 2542.758437948392, 2604.1666666666483, 2607.0093364521363, 2621.973780262211, 2626.8817903194404, 4608.986023074918, 4634.397528321297, 4666.273478812861, 4697.365855609517, 4712.81148754046, 4985.576226020757, 4988.825391111293, 5026.220935754964, 5043.87390315245, 5079.187330027178, 4662.717752617989, 4666.813327466931, 4684.648651351163, 4693.366395536627, 4694.577488025958, 4660.370849935215, 4896.2410826321975, 4900.803967841389, 4903.26451032348, 4906.816466672297, 4883.291922671122, 4896.559309662005, 4899.824042229768, 4899.828506002273, 4933.755141410577, 4676.883077923079, 4707.364505791675, 4722.338872557913, 4743.620510359232, 4747.810087596457, 3333.399988002183, 3497.930041399107, 3518.683318501347, 3522.2779330237754, 3522.859085636546, 5024.638419942621, 5047.924281135713, 5052.494750524918, 5055.721935293447, 5074.112030394593, 4917.139500587311, 4927.876803079952, 4935.136351138464, 4937.530934561211, 4944.022391043612, 4681.274402467623, 4941.555260026615, 4967.9006419870675, 4989.2516122580455, 4992.6255530834605, 4853.951460485491, 4894.632902532253, 4907.9263811043575, 4909.852704418873, 4920.31115643803, 5002.724850133278, 5003.0, 5008.198688209869, 5016.347874776256, 5023.497650234947, 4769.379980602499, 4837.419509658723, 4844.394450693663, 4854.68444551103, 4867.342908707279], "value": 3680.9483418696295, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.2615834839844, 641.4964253061348, 651.6904470376571, 714.0931017607638, 714.1251966341233, 12642.557510487135, 13671.384787684554, 13711.520096796614, 13732.382042808073, 13745.999999999987, 12850.48598056079, 12973.675658108552, 13009.73980520389, 13045.478180872753, 13070.607881763563, 592.4756590417479, 610.6305685060541, 727.1165533876339, 740.0305599664457, 751.0874287740394, 741.2402287655169, 741.8367959049001, 741.9517731347445, 742.191011797141, 742.6992068212382, 784.3215618489994, 791.0586402181415, 792.9405294602899, 792.9762107136795, 792.9801754956114, 626.242246881272, 639.5555089212999, 756.9848603027964, 792.2552800367694, 793.714262865368, 582.0919365789382, 582.3739480058912, 582.5194214772787, 582.6329412470159, 582.7173820697001, 13045.282509461977, 13118.409671564803, 13123.14699544536, 13129.934350328283, 13131.671708207276, 12062.758744825142, 12159.0, 12482.625521234288, 12552.560660376934, 12657.873421265762, 11093.374305354577, 11134.610288639858, 11189.37592534437, 11339.37633430161, 11441.370724610144, 3984.5417776955733, 4001.639852413268, 4004.0990777075217, 4075.857344992911, 4079.5920407959266, 60952.695236523534, 62453.37546624521, 62938.0, 64053.35946640567, 64436.0, 9579.233661307078, 9732.75668108303, 9763.511824408752, 9829.361091529028, 9898.0, 18061.187246573936, 18071.0, 18345.17446714901, 18419.72370414445, 18632.347867824563, 6250.593711408744, 6268.310485846553, 6268.874622507525, 6462.483001359974, 6533.216014078341, 3423.965760342365, 3426.931461370759, 3465.4108801503803, 3507.877224297137, 3518.225990282134, 2560.347111486559, 2648.576227803542, 2652.9469410611678, 2657.3755167535614, 2659.9202023939315, 453.2883373104261, 455.12388651845725, 463.2379735335422, 466.0608873120665, 473.02084684702334, 512.1344927073234, 513.7071869034614, 521.8590980435262, 538.5476199992025, 543.3371287029818, 6739.416237184258, 6888.483363747739, 6932.341427564374, 6955.82610434733, 7065.467266366816, 456.3041361923094, 522.8640553456129, 533.1549494051972, 540.106124364178, 543.429399130911, 3156.6527681954967, 3280.6883346082564, 3296.027671836814, 3330.467125259947, 3330.766846320783, 64986.35013649898, 68754.0, 70678.0, 73952.63023684848, 74157.6292118536, 63502.0, 64174.67912660407, 65012.674936625015, 65231.67384163144, 66389.0, 58449.0, 59630.0, 59966.400335996084, 61266.38733612696, 62421.68789156025, 6355.682215889279, 6459.773907913201, 6516.771912983023, 6524.184476940382, 6776.728930842908, 40160.799196005, 40209.39685904772, 40762.79618601888, 42505.36241956311, 43441.56558434375, 38330.61669383382, 41744.0, 42214.57785422107, 42970.57029429666, 46554.767226163654, 11042.889571104508, 11074.612388566362, 11082.279651822606, 11220.934011268917, 11328.433578320886, 12254.693632659255, 12450.377481125726, 12678.239305641691, 13022.609321720363, 13376.665583360495, 8314.127016663164, 9376.390534615228, 11165.16261280391, 11750.412479375826, 12509.18690285165, 11485.655430337103, 11732.94133529327, 12019.879801201876, 12143.332116733665, 12144.574939877062, 11821.940890295493, 12239.265644061385, 12258.816117758062, 12429.12996090265, 12567.371631418575, 8644.481331120152, 9211.263098951933, 9224.005144386754, 9929.65246216379, 9954.104130628279, 9360.578773955325, 10079.143272821892, 10245.0, 10270.845937311096, 10295.3822770634], "value": 6094.1446489880045, "unit": "score"}], "name": "dromaeo_css", "value": 6083.818177286686, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 116.0, 115.0, 117.0, 116.0, 117.0, 114.0, 114.0, 114.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 131.0, 128.0, 168.0, 130.0, 131.0, 132.0, 135.0, 150.0, 130.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 162.0, 163.0, 162.0, 161.0, 163.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 109.0, 76.0, 77.0, 77.0, 77.0, 93.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 103.0, 83.0, 82.0, 84.0, 110.0, 83.0, 83.0, 111.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0, 66.0, 67.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 89.0, 91.0, 88.0, 85.0, 84.0, 90.0, 89.0, 84.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 141.0, 141.0, 159.0, 141.0, 159.0, 151.0, 138.0, 196.0, 140.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 183.0, 177.0, 180.0, 181.0, 182.0, 181.0, 180.0, 175.0, 177.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 71.0, 70.0, 72.0, 76.0, 70.0, 70.0, 68.0, 69.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1567.6999999999996, "alertThreshold": 2.0}]} 07:37:53 INFO - Return code: 0 07:37:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:37:54 INFO - # TBPL SUCCESS # 07:37:54 INFO - Running post-action listener: _resource_record_post_action 07:37:54 INFO - [mozharness: 2016-12-05 15:37:54.011700Z] Finished run-tests step (success) 07:37:54 INFO - Running post-run listener: _resource_record_post_run 07:37:54 INFO - Total resource usage - Wall time: 1207s; CPU: 13.0%; Read bytes: 8192; Write bytes: 390762496; Read time: 228; Write time: 222744 07:37:54 INFO - TinderboxPrint: CPU usage
13.1% 07:37:54 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 228 07:37:54 INFO - TinderboxPrint: I/O write bytes / time
390,762,496 / 222,744 07:37:54 INFO - TinderboxPrint: CPU idle
8,372.6 (86.9%) 07:37:54 INFO - TinderboxPrint: CPU user
1,207.1 (12.5%) 07:37:54 INFO - TinderboxPrint: Swap in / out
0 / 0 07:37:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 99835904; Read time: 60; Write time: 80964 07:37:54 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290926592; Read time: 168; Write time: 141780 07:37:54 INFO - Running post-run listener: _upload_blobber_files 07:37:54 INFO - Blob upload gear active. 07:37:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:37:54 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 07:37:54 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'] 07:37:54 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 07:37:55 INFO - (blobuploader) - INFO - Open directory for files ... 07:37:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:37:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:37:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:55 INFO - (blobuploader) - INFO - Done attempting. 07:37:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:37:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:37:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:57 INFO - (blobuploader) - INFO - Done attempting. 07:37:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:37:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:00 INFO - (blobuploader) - INFO - Done attempting. 07:38:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:38:00 INFO - Return code: 0 07:38:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:38:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:38:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54f867923235045023ccdf6d3cfa9f16859554634afff3abead51926c5bdd2522bbefa185e1a9cf92c3a768e40810606c3ed5b68e54b519e8691682351e69d4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/450f1989c66ae408cba022a5179ea719e50010b2af90194178220a41cf4208443add50abac5f36ba361fe8901badf7c187b8818760254652fb25c547f22b2b86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1ea7ad354a3c48c896ea4b353ce7a9f511e6a5da5838917b0ea2d90542b54980aeaad211001e0c3da7bb7d3a6fc7aef826144bdc5b3be5a13a51857ee6da3f1"} 07:38:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:38:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:38:00 INFO - Contents: 07:38:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54f867923235045023ccdf6d3cfa9f16859554634afff3abead51926c5bdd2522bbefa185e1a9cf92c3a768e40810606c3ed5b68e54b519e8691682351e69d4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/450f1989c66ae408cba022a5179ea719e50010b2af90194178220a41cf4208443add50abac5f36ba361fe8901badf7c187b8818760254652fb25c547f22b2b86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1ea7ad354a3c48c896ea4b353ce7a9f511e6a5da5838917b0ea2d90542b54980aeaad211001e0c3da7bb7d3a6fc7aef826144bdc5b3be5a13a51857ee6da3f1"} 07:38:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:38:00 INFO - Copying logs to upload dir... 07:38:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:38:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.942998 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-05 07:38:00.023529) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-05 07:38:00.027056) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54f867923235045023ccdf6d3cfa9f16859554634afff3abead51926c5bdd2522bbefa185e1a9cf92c3a768e40810606c3ed5b68e54b519e8691682351e69d4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/450f1989c66ae408cba022a5179ea719e50010b2af90194178220a41cf4208443add50abac5f36ba361fe8901badf7c187b8818760254652fb25c547f22b2b86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1ea7ad354a3c48c896ea4b353ce7a9f511e6a5da5838917b0ea2d90542b54980aeaad211001e0c3da7bb7d3a6fc7aef826144bdc5b3be5a13a51857ee6da3f1"} build_url:https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011486 build_url: 'https://queue.taskcluster.net/v1/task/LbwmY1U-TWOpZecX4R90MQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54f867923235045023ccdf6d3cfa9f16859554634afff3abead51926c5bdd2522bbefa185e1a9cf92c3a768e40810606c3ed5b68e54b519e8691682351e69d4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/450f1989c66ae408cba022a5179ea719e50010b2af90194178220a41cf4208443add50abac5f36ba361fe8901badf7c187b8818760254652fb25c547f22b2b86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1ea7ad354a3c48c896ea4b353ce7a9f511e6a5da5838917b0ea2d90542b54980aeaad211001e0c3da7bb7d3a6fc7aef826144bdc5b3be5a13a51857ee6da3f1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-05 07:38:00.052398) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 07:38:00.052742) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480945744.80189-14747035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 07:38:00.136492) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-05 07:38:00.136820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-05 07:38:00.137170) ========= ========= Total master_lag: 0.17 =========