builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1474799278.61 results: success (0) buildid: 20160925003105 builduid: 06283cbf0b324f4c95e5af4f5a4b5b06 revision: aef020a0ba34408c4d416c554ea3797aa167c5db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-25 03:27:58.608259) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-25 03:27:58.608676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-25 03:27:58.608991) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-25 03:27:58.659595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:27:58.660304) ========= 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=af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-25 03:27:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-09-25 03:27:58 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083588 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:27:58.759050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:27:58.759433) ========= 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=af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021171 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:27:58.808820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-25 03:27:58.809182) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev aef020a0ba34408c4d416c554ea3797aa167c5db --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev aef020a0ba34408c4d416c554ea3797aa167c5db --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=af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-25 03:27:58,978 truncating revision to first 12 chars 2016-09-25 03:27:58,978 Setting DEBUG logging. 2016-09-25 03:27:58,978 attempt 1/10 2016-09-25 03:27:58,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/aef020a0ba34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-25 03:28:00,305 unpacking tar archive at: mozilla-inbound-aef020a0ba34/testing/mozharness/ program finished with exit code 0 elapsedTime=1.706916 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-25 03:28:00.529112) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-25 03:28:00.529407) ========= script_repo_revision: aef020a0ba34408c4d416c554ea3797aa167c5db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-25 03:28:00.529769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-25 03:28:00.530024) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-25 03:28:00.541165) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-25 03:28:00.541417) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:00 INFO - MultiFileLogger online at 20160925 03:28:00 in /builds/slave/test 03:28:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:28:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:00 INFO - {'append_to_log': False, 03:28:00 INFO - 'base_work_dir': '/builds/slave/test', 03:28:00 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:28:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:00 INFO - 'branch': 'Mozilla-Inbound', 03:28:00 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:00 INFO - 'config_files': ('talos/linux_config.py',), 03:28:00 INFO - 'default_actions': ('clobber', 03:28:00 INFO - 'read-buildbot-config', 03:28:00 INFO - 'download-and-extract', 03:28:00 INFO - 'populate-webroot', 03:28:00 INFO - 'create-virtualenv', 03:28:00 INFO - 'install', 03:28:00 INFO - 'run-tests'), 03:28:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:00 INFO - 'download_minidump_stackwalk': True, 03:28:00 INFO - 'download_symbols': 'ondemand', 03:28:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:00 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:00 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:00 INFO - 'installer_path': 'installer.exe', 03:28:00 INFO - 'log_level': 'info', 03:28:00 INFO - 'log_name': 'talos', 03:28:00 INFO - 'log_to_console': True, 03:28:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:00 INFO - 'opt_config_files': (), 03:28:00 INFO - 'pip_index': False, 03:28:00 INFO - 'sps_profile': False, 03:28:00 INFO - 'sps_profile_interval': 0, 03:28:00 INFO - 'suite': 'dromaeojs', 03:28:00 INFO - 'system_bits': '32', 03:28:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:00 INFO - 'title': 'talos-linux64-ix-020', 03:28:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:00 INFO - 'use_talos_json': True, 03:28:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:00 INFO - 'work_dir': 'build'} 03:28:00 INFO - [mozharness: 2016-09-25 10:28:00.806968Z] Running clobber step. 03:28:00 INFO - Running pre-action listener: _resource_record_pre_action 03:28:00 INFO - Running main action method: clobber 03:28:00 INFO - rmtree: /builds/slave/test/build 03:28:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:01 INFO - Running post-action listener: _resource_record_post_action 03:28:01 INFO - [mozharness: 2016-09-25 10:28:01.256033Z] Finished clobber step (success) 03:28:01 INFO - [mozharness: 2016-09-25 10:28:01.256134Z] Running read-buildbot-config step. 03:28:01 INFO - Running pre-action listener: _resource_record_pre_action 03:28:01 INFO - Running main action method: read_buildbot_config 03:28:01 INFO - Using buildbot properties: 03:28:01 INFO - { 03:28:01 INFO - "project": "", 03:28:01 INFO - "product": "firefox", 03:28:01 INFO - "script_repo_revision": "production", 03:28:01 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:28:01 INFO - "repository": "", 03:28:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:28:01 INFO - "buildid": "20160925003105", 03:28:01 INFO - "pgo_build": "True", 03:28:01 INFO - "basedir": "/builds/slave/test", 03:28:01 INFO - "buildnumber": 1597, 03:28:01 INFO - "slavename": "talos-linux64-ix-020", 03:28:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:28:01 INFO - "platform": "ubuntu64_hw", 03:28:01 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:28:01 INFO - "branch": "mozilla-inbound", 03:28:01 INFO - "repo_path": "integration/mozilla-inbound", 03:28:01 INFO - "revision": "aef020a0ba34408c4d416c554ea3797aa167c5db", 03:28:01 INFO - "stage_platform": "linux64-pgo", 03:28:01 INFO - "builduid": "06283cbf0b324f4c95e5af4f5a4b5b06", 03:28:01 INFO - "slavebuilddir": "test" 03:28:01 INFO - } 03:28:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:28:01 INFO - Running post-action listener: _resource_record_post_action 03:28:01 INFO - [mozharness: 2016-09-25 10:28:01.258581Z] Finished read-buildbot-config step (success) 03:28:01 INFO - [mozharness: 2016-09-25 10:28:01.258670Z] Running download-and-extract step. 03:28:01 INFO - Running pre-action listener: _resource_record_pre_action 03:28:01 INFO - Running main action method: download_and_extract 03:28:01 INFO - mkdir: /builds/slave/test/build/tests 03:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:01 INFO - trying https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:28:01 INFO - Downloading https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:28:01 INFO - Downloaded 1361 bytes. 03:28:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:28:01 INFO - Using the following test package requirements: 03:28:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:28:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:28:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:28:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:01 INFO - u'jsshell-linux-x86_64.zip'], 03:28:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:28:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:28:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:28:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:28:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:28:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:28:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:28:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:28:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:28:01 INFO - Fetch https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:28:02 INFO - Expected file size: 21981576 03:28:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:28:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:28:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:28:06 INFO - Fetch https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:28:07 INFO - Expected file size: 21981576 03:28:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:28:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:28:11 INFO - Fetch https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:28:12 INFO - Expected file size: 14414057 03:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:12 INFO - trying https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:28:12 INFO - Downloading https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:28:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:28:14 INFO - Downloaded 59711231 bytes. 03:28:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:28:14 INFO - mkdir: /builds/slave/test/properties 03:28:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:14 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:14 INFO - Contents: 03:28:14 INFO - build_url:https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:28:15 INFO - Running post-action listener: _resource_record_post_action 03:28:15 INFO - Running post-action listener: set_extra_try_arguments 03:28:15 INFO - [mozharness: 2016-09-25 10:28:15.120944Z] Finished download-and-extract step (success) 03:28:15 INFO - [mozharness: 2016-09-25 10:28:15.121172Z] Running populate-webroot step. 03:28:15 INFO - Running pre-action listener: _resource_record_pre_action 03:28:15 INFO - Running main action method: populate_webroot 03:28:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:15 INFO - '--tppagecycles', 03:28:15 INFO - '7'], 03:28:15 INFO - 'tests': ['tsvgm']}}, 03:28:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:28:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:28:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:28:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:28:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'talos_options': ['--disable-e10s'], 03:28:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'talos_options': ['--disable-e10s'], 03:28:15 INFO - 'tests': ['damp', 'tps']}, 03:28:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'tests': ['damp', 'tps']}, 03:28:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:28:15 INFO - 'tests': ['dromaeo_dom']}, 03:28:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:28:15 INFO - 'tests': ['basic_compositor_video']}, 03:28:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:28:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:28:15 INFO - 'tests': ['a11yr', 03:28:15 INFO - 'ts_paint', 03:28:15 INFO - 'tpaint', 03:28:15 INFO - 'sessionrestore', 03:28:15 INFO - 'sessionrestore_no_auto_restore', 03:28:15 INFO - 'tabpaint']}, 03:28:15 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:15 INFO - 'ts_paint', 03:28:15 INFO - 'tpaint', 03:28:15 INFO - 'sessionrestore', 03:28:15 INFO - 'sessionrestore_no_auto_restore', 03:28:15 INFO - 'tabpaint']}, 03:28:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:28:15 INFO - 'ts_paint', 03:28:15 INFO - 'tpaint', 03:28:15 INFO - 'sessionrestore', 03:28:15 INFO - 'sessionrestore_no_auto_restore', 03:28:15 INFO - 'tabpaint']}, 03:28:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:28:15 INFO - 'ts_paint', 03:28:15 INFO - 'tpaint', 03:28:15 INFO - 'sessionrestore', 03:28:15 INFO - 'sessionrestore_no_auto_restore', 03:28:15 INFO - 'tabpaint']}, 03:28:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:28:15 INFO - 'tests': ['a11yr', 03:28:15 INFO - 'ts_paint', 03:28:15 INFO - 'tpaint', 03:28:15 INFO - 'sessionrestore', 03:28:15 INFO - 'sessionrestore_no_auto_restore', 03:28:15 INFO - 'tabpaint']}, 03:28:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:28:15 INFO - 'tests': ['a11yr', 03:28:15 INFO - 'ts_paint', 03:28:15 INFO - 'tpaint', 03:28:15 INFO - 'sessionrestore', 03:28:15 INFO - 'sessionrestore_no_auto_restore', 03:28:15 INFO - 'tabpaint']}, 03:28:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:28:15 INFO - 'tests': ['tsvgx', 03:28:15 INFO - 'tsvgr_opacity', 03:28:15 INFO - 'tart', 03:28:15 INFO - 'tscrollx', 03:28:15 INFO - 'cart']}, 03:28:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:15 INFO - 'tsvgr_opacity', 03:28:15 INFO - 'tart', 03:28:15 INFO - 'tscrollx', 03:28:15 INFO - 'cart']}, 03:28:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'talos_options': ['--disable-e10s'], 03:28:15 INFO - 'tests': ['tp5o']}, 03:28:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'tests': ['tp5o']}, 03:28:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'talos_options': ['--disable-e10s', 03:28:15 INFO - '--xperf_path', 03:28:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:15 INFO - 'tests': ['tp5n']}, 03:28:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'talos_options': ['--xperf_path', 03:28:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:15 INFO - 'tests': ['tp5n']}}, 03:28:15 INFO - 'talos.zip': {'path': '', 03:28:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:15 INFO - Running post-action listener: _resource_record_post_action 03:28:15 INFO - [mozharness: 2016-09-25 10:28:15.142245Z] Finished populate-webroot step (success) 03:28:15 INFO - [mozharness: 2016-09-25 10:28:15.142334Z] Running create-virtualenv step. 03:28:15 INFO - Running pre-action listener: _resource_record_pre_action 03:28:15 INFO - Running main action method: create_virtualenv 03:28:15 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:15 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 03:28:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:15 INFO - Using real prefix '/usr' 03:28:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:15 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:17 INFO - Installing pip.................done. 03:28:17 INFO - Return code: 0 03:28:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:17 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')]} 03:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:17 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')]} 03:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:17 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 0x7fa080bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19caf60>, '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 0x19cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cc1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', '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 03:28:17 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 03:28:17 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 03:28:17 INFO - Using env: {'DISPLAY': ':0', 03:28:17 INFO - 'HOME': '/home/cltbld', 03:28:17 INFO - 'LANG': 'en_US.UTF-8', 03:28:17 INFO - 'LANGUAGE': 'en_US:en', 03:28:17 INFO - 'LOGNAME': 'cltbld', 03:28:17 INFO - 'MAIL': '/var/mail/cltbld', 03:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:17 INFO - 'MOZ_NO_REMOTE': '1', 03:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:17 INFO - 'NO_EM_RESTART': '1', 03:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:17 INFO - 'PWD': '/builds/slave/test', 03:28:17 INFO - 'SHELL': '/bin/bash', 03:28:17 INFO - 'SHLVL': '1', 03:28:17 INFO - 'TERM': 'linux', 03:28:17 INFO - 'TMOUT': '86400', 03:28:17 INFO - 'USER': 'cltbld', 03:28:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', 03:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:17 INFO - '_': '/tools/buildbot/bin/python'} 03:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:17 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 03:28:17 INFO - Cleaning up... 03:28:17 INFO - Return code: 0 03:28:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28:17 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')]} 03:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:17 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')]} 03:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:17 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 0x7fa080bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19caf60>, '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 0x19cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cc1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', '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 03:28:17 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 03:28:17 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 03:28:17 INFO - Using env: {'DISPLAY': ':0', 03:28:17 INFO - 'HOME': '/home/cltbld', 03:28:17 INFO - 'LANG': 'en_US.UTF-8', 03:28:17 INFO - 'LANGUAGE': 'en_US:en', 03:28:17 INFO - 'LOGNAME': 'cltbld', 03:28:17 INFO - 'MAIL': '/var/mail/cltbld', 03:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:17 INFO - 'MOZ_NO_REMOTE': '1', 03:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:17 INFO - 'NO_EM_RESTART': '1', 03:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:17 INFO - 'PWD': '/builds/slave/test', 03:28:17 INFO - 'SHELL': '/bin/bash', 03:28:17 INFO - 'SHLVL': '1', 03:28:17 INFO - 'TERM': 'linux', 03:28:17 INFO - 'TMOUT': '86400', 03:28:17 INFO - 'USER': 'cltbld', 03:28:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', 03:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:17 INFO - '_': '/tools/buildbot/bin/python'} 03:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:18 INFO - Downloading/unpacking psutil>=3.1.1 03:28:18 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 03:28:18 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 03:28:18 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 03:28:18 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 03:28:18 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 03:28:18 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 03:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:20 INFO - Installing collected packages: psutil 03:28:20 INFO - Running setup.py install for psutil 03:28:20 INFO - building 'psutil._psutil_linux' extension 03:28:20 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 03:28:20 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 03:28:20 INFO - building 'psutil._psutil_posix' extension 03:28:20 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 03:28:20 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 03:28:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:20 INFO - Successfully installed psutil 03:28:20 INFO - Cleaning up... 03:28:20 INFO - Return code: 0 03:28:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28:20 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')]} 03:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:20 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')]} 03:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:20 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 0x7fa080bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19caf60>, '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 0x19cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cc1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', '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 03:28:20 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 03:28:20 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 03:28:20 INFO - Using env: {'DISPLAY': ':0', 03:28:20 INFO - 'HOME': '/home/cltbld', 03:28:20 INFO - 'LANG': 'en_US.UTF-8', 03:28:20 INFO - 'LANGUAGE': 'en_US:en', 03:28:20 INFO - 'LOGNAME': 'cltbld', 03:28:20 INFO - 'MAIL': '/var/mail/cltbld', 03:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:20 INFO - 'MOZ_NO_REMOTE': '1', 03:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:20 INFO - 'NO_EM_RESTART': '1', 03:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:20 INFO - 'PWD': '/builds/slave/test', 03:28:20 INFO - 'SHELL': '/bin/bash', 03:28:20 INFO - 'SHLVL': '1', 03:28:20 INFO - 'TERM': 'linux', 03:28:20 INFO - 'TMOUT': '86400', 03:28:20 INFO - 'USER': 'cltbld', 03:28:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', 03:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:20 INFO - '_': '/tools/buildbot/bin/python'} 03:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28:20 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 03:28:20 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 03:28:20 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 03:28:20 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 03:28:20 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 03:28:20 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 03:28:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:28:22 INFO - Installing collected packages: mozsystemmonitor 03:28:22 INFO - Running setup.py install for mozsystemmonitor 03:28:22 INFO - Successfully installed mozsystemmonitor 03:28:22 INFO - Cleaning up... 03:28:22 INFO - Return code: 0 03:28:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa080bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19caf60>, '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 0x19cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cc1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', '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 03:28:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:28:22 INFO - Using env: {'DISPLAY': ':0', 03:28:22 INFO - 'HOME': '/home/cltbld', 03:28:22 INFO - 'LANG': 'en_US.UTF-8', 03:28:22 INFO - 'LANGUAGE': 'en_US:en', 03:28:22 INFO - 'LOGNAME': 'cltbld', 03:28:22 INFO - 'MAIL': '/var/mail/cltbld', 03:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:22 INFO - 'MOZ_NO_REMOTE': '1', 03:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:22 INFO - 'NO_EM_RESTART': '1', 03:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:22 INFO - 'PWD': '/builds/slave/test', 03:28:22 INFO - 'SHELL': '/bin/bash', 03:28:22 INFO - 'SHLVL': '1', 03:28:22 INFO - 'TERM': 'linux', 03:28:22 INFO - 'TMOUT': '86400', 03:28:22 INFO - 'USER': 'cltbld', 03:28:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', 03:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:22 INFO - '_': '/tools/buildbot/bin/python'} 03:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:23 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:23 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 03:28:23 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 03:28:23 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 03:28:23 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 03:28:23 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 03:28:23 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 03:28:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:25 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:25 INFO - warning: no files found matching '*.txt' 03:28:25 INFO - no previously-included directories found matching 'build' 03:28:25 INFO - no previously-included directories found matching 'dist' 03:28:25 INFO - no previously-included directories found matching '.git*' 03:28:25 INFO - Installing collected packages: jsonschema, functools32 03:28:25 INFO - Running setup.py install for functools32 03:28:25 INFO - warning: no files found matching '*.txt' 03:28:25 INFO - no previously-included directories found matching 'build' 03:28:25 INFO - no previously-included directories found matching 'dist' 03:28:25 INFO - no previously-included directories found matching '.git*' 03:28:25 INFO - Successfully installed jsonschema functools32 03:28:25 INFO - Cleaning up... 03:28:25 INFO - Return code: 0 03:28:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa080bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19caf60>, '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 0x19cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cc1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', '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 03:28:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:28:25 INFO - Using env: {'DISPLAY': ':0', 03:28:25 INFO - 'HOME': '/home/cltbld', 03:28:25 INFO - 'LANG': 'en_US.UTF-8', 03:28:25 INFO - 'LANGUAGE': 'en_US:en', 03:28:25 INFO - 'LOGNAME': 'cltbld', 03:28:25 INFO - 'MAIL': '/var/mail/cltbld', 03:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:25 INFO - 'MOZ_NO_REMOTE': '1', 03:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:25 INFO - 'NO_EM_RESTART': '1', 03:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:25 INFO - 'PWD': '/builds/slave/test', 03:28:25 INFO - 'SHELL': '/bin/bash', 03:28:25 INFO - 'SHLVL': '1', 03:28:25 INFO - 'TERM': 'linux', 03:28:25 INFO - 'TMOUT': '86400', 03:28:25 INFO - 'USER': 'cltbld', 03:28:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', 03:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:25 INFO - '_': '/tools/buildbot/bin/python'} 03:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:28:25 INFO - Cleaning up... 03:28:25 INFO - Return code: 0 03:28:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa080bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19caf60>, '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 0x19cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cc1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', '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 03:28:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:28:25 INFO - Using env: {'DISPLAY': ':0', 03:28:25 INFO - 'HOME': '/home/cltbld', 03:28:25 INFO - 'LANG': 'en_US.UTF-8', 03:28:25 INFO - 'LANGUAGE': 'en_US:en', 03:28:25 INFO - 'LOGNAME': 'cltbld', 03:28:25 INFO - 'MAIL': '/var/mail/cltbld', 03:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:25 INFO - 'MOZ_NO_REMOTE': '1', 03:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:25 INFO - 'NO_EM_RESTART': '1', 03:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:25 INFO - 'PWD': '/builds/slave/test', 03:28:25 INFO - 'SHELL': '/bin/bash', 03:28:25 INFO - 'SHLVL': '1', 03:28:25 INFO - 'TERM': 'linux', 03:28:25 INFO - 'TMOUT': '86400', 03:28:25 INFO - 'USER': 'cltbld', 03:28:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', 03:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:25 INFO - '_': '/tools/buildbot/bin/python'} 03:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:25 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:27 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:28 INFO - Downloading docopt-0.6.1.tar.gz 03:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:28 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:28 INFO - Running setup.py install for blobuploader 03:28:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:28 INFO - Running setup.py install for requests 03:28:29 INFO - Running setup.py install for docopt 03:28:29 INFO - Successfully installed blobuploader requests docopt 03:28:29 INFO - Cleaning up... 03:28:29 INFO - Return code: 0 03:28:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:29 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 0x7fa080bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19caf60>, '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 0x19cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cc1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', '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 03:28:29 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 03:28:29 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 03:28:29 INFO - Using env: {'DISPLAY': ':0', 03:28:29 INFO - 'HOME': '/home/cltbld', 03:28:29 INFO - 'LANG': 'en_US.UTF-8', 03:28:29 INFO - 'LANGUAGE': 'en_US:en', 03:28:29 INFO - 'LOGNAME': 'cltbld', 03:28:29 INFO - 'MAIL': '/var/mail/cltbld', 03:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:29 INFO - 'MOZ_NO_REMOTE': '1', 03:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:29 INFO - 'NO_EM_RESTART': '1', 03:28:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:29 INFO - 'PWD': '/builds/slave/test', 03:28:29 INFO - 'SHELL': '/bin/bash', 03:28:29 INFO - 'SHLVL': '1', 03:28:29 INFO - 'TERM': 'linux', 03:28:29 INFO - 'TMOUT': '86400', 03:28:29 INFO - 'USER': 'cltbld', 03:28:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', 03:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:29 INFO - '_': '/tools/buildbot/bin/python'} 03:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:29 INFO - Running setup.py (path:/tmp/pip-NtomOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:29 INFO - Running setup.py (path:/tmp/pip-ZhJONw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:29 INFO - Running setup.py (path:/tmp/pip-493Lok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:29 INFO - Running setup.py (path:/tmp/pip-tOoZdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:29 INFO - Running setup.py (path:/tmp/pip-5JEPU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:29 INFO - Running setup.py (path:/tmp/pip-H9Q9EI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:30 INFO - Running setup.py (path:/tmp/pip-qVMO0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:30 INFO - Running setup.py (path:/tmp/pip-NhFqpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:30 INFO - Running setup.py (path:/tmp/pip-rdkdyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:30 INFO - Running setup.py (path:/tmp/pip-W1jy7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:30 INFO - Running setup.py (path:/tmp/pip-uIb9A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:30 INFO - Running setup.py (path:/tmp/pip-hOMlI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:30 INFO - Running setup.py (path:/tmp/pip-OjyPxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:30 INFO - Running setup.py (path:/tmp/pip-unNyYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:30 INFO - Running setup.py (path:/tmp/pip-Tunc4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:30 INFO - Running setup.py (path:/tmp/pip-PuhXX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:30 INFO - Running setup.py (path:/tmp/pip-4s3FdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:30 INFO - Running setup.py install for manifestparser 03:28:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:30 INFO - Running setup.py install for mozcrash 03:28:31 INFO - Running setup.py install for mozdebug 03:28:31 INFO - Running setup.py install for mozdevice 03:28:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:28:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:31 INFO - Running setup.py install for mozfile 03:28:31 INFO - Running setup.py install for mozhttpd 03:28:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:31 INFO - Running setup.py install for mozinfo 03:28:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:31 INFO - Running setup.py install for mozInstall 03:28:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:31 INFO - Running setup.py install for mozleak 03:28:31 INFO - Running setup.py install for mozlog 03:28:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:31 INFO - Running setup.py install for moznetwork 03:28:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:31 INFO - Running setup.py install for mozprocess 03:28:32 INFO - Running setup.py install for mozprofile 03:28:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:32 INFO - Running setup.py install for mozrunner 03:28:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:32 INFO - Running setup.py install for mozscreenshot 03:28:32 INFO - Running setup.py install for moztest 03:28:32 INFO - Running setup.py install for mozversion 03:28:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:32 INFO - Cleaning up... 03:28:32 INFO - Return code: 0 03:28:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:32 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 0x7fa080bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19caf60>, '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 0x19cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cc1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', '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 03:28:32 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 03:28:32 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 03:28:32 INFO - Using env: {'DISPLAY': ':0', 03:28:32 INFO - 'HOME': '/home/cltbld', 03:28:32 INFO - 'LANG': 'en_US.UTF-8', 03:28:32 INFO - 'LANGUAGE': 'en_US:en', 03:28:32 INFO - 'LOGNAME': 'cltbld', 03:28:32 INFO - 'MAIL': '/var/mail/cltbld', 03:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:32 INFO - 'MOZ_NO_REMOTE': '1', 03:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:32 INFO - 'NO_EM_RESTART': '1', 03:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:32 INFO - 'PWD': '/builds/slave/test', 03:28:32 INFO - 'SHELL': '/bin/bash', 03:28:32 INFO - 'SHLVL': '1', 03:28:32 INFO - 'TERM': 'linux', 03:28:32 INFO - 'TMOUT': '86400', 03:28:32 INFO - 'USER': 'cltbld', 03:28:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', 03:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:32 INFO - '_': '/tools/buildbot/bin/python'} 03:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:32 INFO - Running setup.py (path:/tmp/pip-wGFD5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:32 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)) 03:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:32 INFO - Running setup.py (path:/tmp/pip-rL27d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:33 INFO - Running setup.py (path:/tmp/pip-7nMFu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:33 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:33 INFO - Running setup.py (path:/tmp/pip-mj26RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:33 INFO - Running setup.py (path:/tmp/pip-KcuyU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:33 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:33 INFO - Running setup.py (path:/tmp/pip-O5MBIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:33 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:33 INFO - Running setup.py (path:/tmp/pip-3koKZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:33 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:33 INFO - Running setup.py (path:/tmp/pip-wgcQqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:33 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:33 INFO - Running setup.py (path:/tmp/pip-pvguPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:33 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:33 INFO - Running setup.py (path:/tmp/pip-u39OkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:33 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:33 INFO - Running setup.py (path:/tmp/pip-1rIzeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:33 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:33 INFO - Running setup.py (path:/tmp/pip-U2JBiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:33 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:33 INFO - Running setup.py (path:/tmp/pip-beRt_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:33 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:33 INFO - Running setup.py (path:/tmp/pip-gQPWYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:33 INFO - Running setup.py (path:/tmp/pip-eT3BzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:33 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)) 03:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:33 INFO - Running setup.py (path:/tmp/pip-F9G_JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:34 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)) 03:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:34 INFO - Running setup.py (path:/tmp/pip-5MsGlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:34 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)) 03:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:34 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)) 03:28:34 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:34 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28:35 INFO - Downloading blessings-1.6.tar.gz 03:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:36 INFO - Installing collected packages: blessings 03:28:36 INFO - Running setup.py install for blessings 03:28:36 INFO - Successfully installed blessings 03:28:36 INFO - Cleaning up... 03:28:36 INFO - Return code: 0 03:28:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:36 INFO - Reading from file tmpfile_stdout 03:28:36 INFO - Current package versions: 03:28:36 INFO - argparse == 1.2.1 03:28:36 INFO - blessings == 1.6 03:28:36 INFO - blobuploader == 1.2.4 03:28:36 INFO - docopt == 0.6.1 03:28:36 INFO - functools32 == 3.2.3-2 03:28:36 INFO - jsonschema == 2.5.1 03:28:36 INFO - manifestparser == 1.1 03:28:36 INFO - mozInstall == 1.12 03:28:36 INFO - mozcrash == 0.17 03:28:36 INFO - mozdebug == 0.1 03:28:36 INFO - mozdevice == 0.48 03:28:36 INFO - mozfile == 1.2 03:28:36 INFO - mozhttpd == 0.7 03:28:36 INFO - mozinfo == 0.9 03:28:36 INFO - mozleak == 0.1 03:28:36 INFO - mozlog == 3.4 03:28:36 INFO - moznetwork == 0.27 03:28:36 INFO - mozprocess == 0.23 03:28:36 INFO - mozprofile == 0.28 03:28:36 INFO - mozrunner == 6.12 03:28:36 INFO - mozscreenshot == 0.1 03:28:36 INFO - mozsystemmonitor == 0.3 03:28:36 INFO - moztest == 0.7 03:28:36 INFO - mozversion == 1.4 03:28:36 INFO - psutil == 3.1.1 03:28:36 INFO - requests == 1.2.3 03:28:36 INFO - wsgiref == 0.1.2 03:28:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:36 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 0x7fa080bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19caf60>, '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 0x19cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cc1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', '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 03:28:36 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 03:28:36 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 03:28:36 INFO - Using env: {'DISPLAY': ':0', 03:28:36 INFO - 'HOME': '/home/cltbld', 03:28:36 INFO - 'LANG': 'en_US.UTF-8', 03:28:36 INFO - 'LANGUAGE': 'en_US:en', 03:28:36 INFO - 'LOGNAME': 'cltbld', 03:28:36 INFO - 'MAIL': '/var/mail/cltbld', 03:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:36 INFO - 'MOZ_NO_REMOTE': '1', 03:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:36 INFO - 'NO_EM_RESTART': '1', 03:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:36 INFO - 'PWD': '/builds/slave/test', 03:28:36 INFO - 'SHELL': '/bin/bash', 03:28:36 INFO - 'SHLVL': '1', 03:28:36 INFO - 'TERM': 'linux', 03:28:36 INFO - 'TMOUT': '86400', 03:28:36 INFO - 'USER': 'cltbld', 03:28:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', 03:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:36 INFO - '_': '/tools/buildbot/bin/python'} 03:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:36 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)) 03:28:36 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)) 03:28:36 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)) 03:28:36 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)) 03:28:36 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)) 03:28:36 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)) 03:28:36 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)) 03:28:36 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)) 03:28:36 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)) 03:28:36 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)) 03:28:36 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)) 03:28:36 INFO - Cleaning up... 03:28:36 INFO - Return code: 0 03:28:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:36 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 0x7fa080bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19caf60>, '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 0x19cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cc1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', '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 03:28:36 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 03:28:36 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 03:28:36 INFO - Using env: {'DISPLAY': ':0', 03:28:36 INFO - 'HOME': '/home/cltbld', 03:28:36 INFO - 'LANG': 'en_US.UTF-8', 03:28:36 INFO - 'LANGUAGE': 'en_US:en', 03:28:36 INFO - 'LOGNAME': 'cltbld', 03:28:36 INFO - 'MAIL': '/var/mail/cltbld', 03:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:36 INFO - 'MOZ_NO_REMOTE': '1', 03:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:36 INFO - 'NO_EM_RESTART': '1', 03:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:36 INFO - 'PWD': '/builds/slave/test', 03:28:36 INFO - 'SHELL': '/bin/bash', 03:28:36 INFO - 'SHLVL': '1', 03:28:36 INFO - 'TERM': 'linux', 03:28:36 INFO - 'TMOUT': '86400', 03:28:36 INFO - 'USER': 'cltbld', 03:28:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', 03:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:36 INFO - '_': '/tools/buildbot/bin/python'} 03:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:36 INFO - Cleaning up... 03:28:36 INFO - Return code: 0 03:28:36 INFO - Running post-action listener: _resource_record_post_action 03:28:36 INFO - Running post-action listener: _start_resource_monitoring 03:28:36 INFO - Starting resource monitoring. 03:28:36 INFO - [mozharness: 2016-09-25 10:28:36.907974Z] Finished create-virtualenv step (success) 03:28:36 INFO - [mozharness: 2016-09-25 10:28:36.908469Z] Running install step. 03:28:36 INFO - Running pre-action listener: _resource_record_pre_action 03:28:36 INFO - Running main action method: install 03:28:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:37 INFO - Reading from file tmpfile_stdout 03:28:37 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:37 INFO - Reading from file tmpfile_stdout 03:28:37 INFO - Output received: 03:28:37 INFO - Usage: mozinstall [options] installer 03:28:37 INFO - Options: 03:28:37 INFO - -h, --help show this help message and exit 03:28:37 INFO - -d DEST, --destination=DEST 03:28:37 INFO - Directory to install application into. [default: 03:28:37 INFO - "/builds/slave/test"] 03:28:37 INFO - --app=APP Application being installed. [default: firefox] 03:28:37 INFO - mkdir: /builds/slave/test/build/application 03:28:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:28:54 INFO - Reading from file tmpfile_stdout 03:28:54 INFO - Output received: 03:28:54 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:54 INFO - Running post-action listener: _resource_record_post_action 03:28:54 INFO - [mozharness: 2016-09-25 10:28:54.219879Z] Finished install step (success) 03:28:54 INFO - [mozharness: 2016-09-25 10:28:54.220125Z] Running run-tests step. 03:28:54 INFO - Running pre-action listener: _resource_record_pre_action 03:28:54 INFO - Running main action method: run_tests 03:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:54 INFO - Python 2.7.3 03:28:54 INFO - Return code: 0 03:28:54 INFO - grabbing minidump binary from tooltool 03:28:54 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')]} 03:28:54 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 0x19caf60>, '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 0x19cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cc1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:54 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 03:28:54 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 03:28:54 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 03:28:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:54 INFO - Return code: 0 03:28:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 03:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 03:28:54 INFO - Using env: {'DISPLAY': ':0', 03:28:54 INFO - 'HOME': '/home/cltbld', 03:28:54 INFO - 'LANG': 'en_US.UTF-8', 03:28:54 INFO - 'LANGUAGE': 'en_US:en', 03:28:54 INFO - 'LOGNAME': 'cltbld', 03:28:54 INFO - 'MAIL': '/var/mail/cltbld', 03:28:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:54 INFO - 'MOZ_NO_REMOTE': '1', 03:28:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:54 INFO - 'NO_EM_RESTART': '1', 03:28:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:54 INFO - 'PWD': '/builds/slave/test', 03:28:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:54 INFO - 'SHELL': '/bin/bash', 03:28:54 INFO - 'SHLVL': '1', 03:28:54 INFO - 'TERM': 'linux', 03:28:54 INFO - 'TMOUT': '86400', 03:28:54 INFO - 'USER': 'cltbld', 03:28:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426', 03:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:54 INFO - '_': '/tools/buildbot/bin/python'} 03:28:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 03:28:54 INFO - mozversion application_buildid: 20160925003105 03:28:54 INFO - mozversion application_changeset: aef020a0ba34408c4d416c554ea3797aa167c5db 03:28:54 INFO - mozversion application_display_name: Nightly 03:28:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:54 INFO - mozversion application_name: Firefox 03:28:54 INFO - mozversion application_remotingname: firefox 03:28:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:28:54 INFO - mozversion application_vendor: Mozilla 03:28:54 INFO - mozversion application_version: 52.0a1 03:28:54 INFO - mozversion platform_buildid: 20160925003105 03:28:54 INFO - mozversion platform_changeset: aef020a0ba34408c4d416c554ea3797aa167c5db 03:28:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:28:54 INFO - mozversion platform_version: 52.0a1 03:28:54 INFO - using testdate: 1474799334 03:28:54 INFO - actual date: 1474799334 03:28:54 INFO - starting webserver on 'localhost:37203' 03:28:54 INFO - SUITE-START | Running 2 tests 03:28:54 INFO - TEST-START | dromaeo_css 03:28:54 INFO - operating with platform_type : linux_ 03:28:54 INFO - Initialising browser for dromaeo_css test... 03:28:54 INFO - TEST-INFO | started process 8160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1RKTzM/profile http://localhost:37203/getInfo.html) 03:28:59 INFO - PROCESS | 8160 | __metrics Screen width/height:1600/1200 03:28:59 INFO - PROCESS | 8160 | colorDepth:24 03:28:59 INFO - PROCESS | 8160 | Browser inner width/height: 1024/697 03:28:59 INFO - PROCESS | 8160 | __metrics 03:28:59 INFO - PROCESS | 8160 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:28:59 INFO - PROCESS | 8160 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:29:00 INFO - PROCESS | 8160 | console.error: PushService: 03:29:00 INFO - PROCESS | 8160 | stateChangeProcessEnqueue: Error transitioning state 03:29:00 INFO - PROCESS | 8160 | UnknownError 03:29:01 INFO - TEST-INFO | 8160: exit 0 03:29:01 INFO - Browser initialized. 03:29:01 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:01 INFO - TEST-INFO | started process 8242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1RKTzM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:13 INFO - PROCESS | 8242 | RSS: Main: 174288896 03:29:13 INFO - PROCESS | 8242 | 03:30:04 INFO - PROCESS | 8242 | 1474799404788 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] 03:32:14 INFO - PROCESS | 8242 | Cycle 1(1): loaded http://localhost:37203/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37203/tests/dromaeo/cssquery-ext.html) 03:32:15 INFO - PROCESS | 8242 | RSS: Main: 319770624 03:32:15 INFO - PROCESS | 8242 | 03:35:18 INFO - PROCESS | 8242 | Cycle 1(1): loaded http://localhost:37203/tests/dromaeo/cssquery-ext.html (next: http://localhost:37203/tests/dromaeo/cssquery-jquery.html) 03:35:18 INFO - PROCESS | 8242 | RSS: Main: 284995584 03:35:18 INFO - PROCESS | 8242 | 03:38:20 INFO - PROCESS | 8242 | Cycle 1(1): loaded http://localhost:37203/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37203/tests/dromaeo/cssquery-mootools.html) 03:38:21 INFO - PROCESS | 8242 | RSS: Main: 217464832 03:38:21 INFO - PROCESS | 8242 | 03:41:23 INFO - PROCESS | 8242 | Cycle 1(1): loaded http://localhost:37203/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37203/tests/dromaeo/cssquery-prototype.html) 03:41:24 INFO - PROCESS | 8242 | RSS: Main: 258048000 03:41:24 INFO - PROCESS | 8242 | 03:44:26 INFO - PROCESS | 8242 | Cycle 1(1): loaded http://localhost:37203/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37203/tests/dromaeo/cssquery-yui.html) 03:44:27 INFO - PROCESS | 8242 | RSS: Main: 216510464 03:44:27 INFO - PROCESS | 8242 | 03:47:30 INFO - PROCESS | 8242 | Cycle 1(1): loaded http://localhost:37203/tests/dromaeo/cssquery-yui.html (next: http://localhost:37203/tests/dromaeo/cssquery-dojo.html) 03:47:30 INFO - PROCESS | 8242 | RSS: Main: 308920320 03:47:30 INFO - PROCESS | 8242 | 03:47:30 INFO - PROCESS | 8242 | __start_tp_report 03:47:30 INFO - PROCESS | 8242 | _x_x_mozilla_page_load 03:47:30 INFO - PROCESS | 8242 | _x_x_mozilla_page_load_details 03:47:30 INFO - PROCESS | 8242 | |i|pagename|runs| 03:47:30 INFO - PROCESS | 8242 | |0;dojo.html;3009.8495075246233;3042.513197888337;3043.513037913934;3079.6612372638992;3092.0105566218817;5132.538071573557;5206.973965130179;5272.3145991021165;5329.040772660925;5343.358796944367;5214.7653355598995;5251.921221181676;5286.973565132179;5309.41596424394;5372.7313634318325;4759.571638552529;4787;4813.735244561548;4830.3237546743485;4869;4815.927761083586;4825.855224343275;4851.805927762885;4930.078920822028;4956.2070068789;4891;4934.28452874333;4954.355933728611;4975.129352363322;4988.102141614508;4775.522447755231;4786.1863483207935;4811.350467686852;4836.056968891067;4845.927311090337;4796.184648609745;4808.75956202192;4810.254410566367;4832.033593281358;4866.489018653061;5252.553532949704;5259.421463638997;5273.7626806793405;5311.415744268127;5339.786408543654;5517.2551705520045;5650.63270887391;5660.094384898396;5661.801836935688;5665.603407761459;5584.581156413245;5639.351474580435;5653.067243904751;5670.5747068969995;5678.205051292823;5304.230886521433;5382.111951527954;5383.650062745909;5386.380566234855;5388.326459192601;5826.271716035496;5834.299884013945;5834.883302333929;5839.153322768175;5839.211706419579;5538.833834984957;5567.220589117527;5603.411641777636;5609.046462101453;5612.7754889803955;5531.6957567333375;5605.215269862222;5610.85972850682;5686.14707793826;5688.175214593861;5613.410591887875;5650.519705824969;5660.915086273709;5673.319201695823;5692.260006199168;5658.236138121383;5699.971500142473;5703.885922281531;5710.200571919934;5767.596268261265;4398.186335527937;4398.318260669537;4410.823567057346;4412.889677758082;4455.443069616298;3886.378179491268;3886.805659717003;3908.7068469864876;3921.254961557295;3968.6825053995613;5402.405735369106;5426.158945363475;5429.8099566515775;5452.372977107683;5472.370677372073;5757.971210143923;5762.394948530427;5763.88472230553;5765.4522820332;5766.798162064308;5189.818356357509;5288.180332048539;5340.092184328673;5471.37079235885;5483.972580137074;4879.414470263591;4897.755112244445;4906.11689895815;4922.261660750916;4963.677360971526;5841.211436456109;5871.500922421642;5884.499817515388;5890.734916928748;5892.734826932799;5557.277553918127;5602.719864006865;5668.37647858727;5672.461116193955;5739.225204597493;5863.530917526673;5920.437558431942;5931.851703707442;5994.6403215807195;6001.039833626599;5639.295088113986;5645.209670646031;5648.85877853057;5706.400827913009;5714.742836572281;5654.660720356792;5688.687122208153;5712.343080545625;5714.914276285942;5721.141828725558;5408.107662235687;5408.405075441777;5464.5081942623765;5576.776928922797;5592.804251851166;5440.945590544202;5527.944720552743;5534.944650553443;5591.161325801162;5596.300462442195;5470.56235501151;5476.67139971603;5481.095619222943;5482.91775623358;5483.945160548344;5473.808416705396;5483.75323110453;5518.392976772632;5536.058869992031;5601.915971260516;5381.165919282517;5416.7020813855615;5477.972610136924;5480.698561578992;5538.806141785019 03:47:30 INFO - PROCESS | 8242 | |1;ext.html;543.2923716000853;601.9307779605346;611.089476679747;614.9139120523128;633.3286716080952;31756.523652145206;43562.34656480151;44546.777266113706;44590.7770461148;44656.77671611645;45121;45559.31661025079;45572.772136139356;45611.54388456114;45708;8070.515769053846;8827.69103081394;8969.910300896972;8971.506567138806;8982.775430614254;8063;10490.947545262263;10678.572857085746;10687.091597214247;11009.064229540498;10796.67609971702;10879.292845964987;10881.12950963925;10887.346759194434;10902.61840835571;10710.678679639585;10779.67660970172;10824.350538967687;10854.67435976914;10869.891301086967;10629.096526795154;10695.251332406735;10704.46477676121;10707.411092389915;10708.892911070867;42684;43050.56949430497;43082.56917430848;43085.56914430847;43122.78438607818;3100.2714362124884;3282.1302354875975;3295.2750394913082;3430.9142271443166;3553.129483276588;31876;32649.836750816332;32863.835680821445;33178.834105829555;34175.6582434175;3494.668006539375;3515.789052656849;3518.9120271993406;3548.1484443733316;3705.981470092659;325706.2584673502;328141;329240;330100;330453;36729.816350918074;37924.24151516954;56061.71969140128;56372.43627563672;56380.15429768557;38144.237115257536;38486.42270365947;38585.42121868118;38588.80705596454;38597;13127.737445251041;13279.269640169883;13311.866881331063;13316.134451260637;13321.733565328834;9284.58219380116;9479.526023698925;10292.691219263434;10551.47242637865;10693.251472397013;8453.492790432594;8534.402591818513;8584.05575386707;8630.093840146694;8659.653613855375;3361.7478689097925;3372.9325413491592;3375.6118046424485;3403.2002479417315;3424.880129195466;945.8297506448768;1010.3634710132569;1027.5530144387214;1073.9946300268448;1099.3184225779908;31555.842220789207;31854.522182167286;32128.196795079843;32377.838110809767;32524.186895327806;1070.8019016481976;1085.1698450685233;1092.3500517192258;1140.184767890962;1183.6922400175845;15645.217739112999;16577.41979030728;16649.44253433239;16869.746953795704;16894;493726;494933;497084;500068;501471;58248.70875645595;58710.70644646835;58827;58843;58888.70555647194;1203.5185925629644;1227.2329793878826;1308.5943357559188;1315.9078864479586;1335.7729186038202;29167.7083229165;33322.66677333292;33342;33539.66460335365;33822;48981.51018489769;49714.50285497099;49751.75124124356;49772.25341619951;49803.25295120504;395824;398797;398897;399253;399349;27806.828975653814;28605.28486787847;28988.565171522023;29043.273918152216;30256;47561.286580700624;47628.7618561905;47976;48338.274925875434;48452;39019;40593.59406405898;40760.79619602002;41988;43693;41001.97495062647;41043.22786740155;41311.38032929449;42315.57684423116;42518.78740606401;41325;42071;42178.578214217465;42194.36708449314;42260.36609450922;34962;37359.81320093382;37526.81236593799;37912.81043594875;38105;28342.43315133727;28454.43091138124;28612.71242794121;28615.143892729142;28849.567256491588 03:47:30 INFO - PROCESS | 8242 | |2;jquery.html;370.39810308249093;380.32112678868225;380.5311497619189;384.70185606155235;393.44720667462207;14329.283535823206;18613.72079418808;19457.610847783035;19588.804111958878;20730.27444039459;18234.81765182348;19162.808371916275;19232.13455394507;19283.325083622076;19322;5696;5944.197533333009;5974.55190860685;5976.342602313764;5979.312379076397;5695.629784064044;5814.186013958049;5841.386654401291;5846.473817356437;5857.033589457735;5807.128930660414;5808.361080281165;5812.564057695668;5815.592908496407;5815.621984570989;5581.386047534768;5686.971565142189;5716.314042314907;5717.085266357404;5731.426857314277;5070.974645126787;5110.8466745997675;5118.232265160219;5118.334616499831;5120;23165.76834231653;23328.65007024896;23518.882405588032;23525.529489410117;23595.52808943829;2345.777151170636;2355.0344358812977;2412.3969007748065;2522.369407648088;2883.2935930696904;9639.132478076937;9711.951440242825;9788.265880058952;10078.748031299276;10092.39445633257;1857.1642760757713;1949.5905859769466;1954.3355259211937;1955.2570023391163;2008.5279959209574;81832.59083704543;82682.58658706667;83128.1320307727;83571.16428835694;85900.57049714711;10607.15142788575;10797.56809727602;10827.67516974492;11014.229003969645;11136.276142050903;15437.30532126057;15475;15485.612859678373;15487.225638718019;15501.767473487907;7276.199618042011;7388.042168825265;7459.888101678479;7552.509086909334;7682.615869206517;6908.620025898624;6923.342282483156;7060.293970602898;7066.858662826715;7135.143782746104;4574.359589657384;4666.230072038075;4736.905261894743;4761.476237613929;4854.271859221145;1916.7029110487897;1938.7378766583731;1962.931297404584;1969.1335812242567;1978.4658142301498;877.7937184761576;954.7231302922214;964.4309857184295;1051.8737751469873;1069.3316677076828;18947.33684321042;19153.808461915203;19306;19521.414357569294;19848.908310043087;932.658474799808;944.6633459718016;953.4422362917771;980.9535665380306;1030.5414090729553;10202.693919182437;10452.843207351896;10853.891461085446;10875.401852898167;10883.401412922207;457181;468436;470591;473366;475628.79011333716;57833.421665783644;65656.01515977264;79395;93644;95798;967.1102585621245;981.5582987655441;988.2094324540483;989.6585677941099;999.8450240212778;16422.343106275614;16565.503034908972;17542.473725788248;17583.648327033643;17682.115894205497;40888.59111408848;41737;41914.37128443137;42190;42397.36403954005;55321.72339138279;55471;56546.434535654116;57486.425135748104;58332;8129.715459958873;8131.552764598004;8132.430729848854;8322.958385208036;8394.076651568445;10146.042274343543;12481.251124932533;12493.75012499763;12609.432575534307;13086.14940028895;10827.837582436427;11172.944135279271;11271.436428178395;11798.705032373917;11996.940015300217;10627.521761520595;11024.173187011167;11144.331340119294;11209.383483908463;11354.829677555008;11226.4386780659;11324.263922844988;11433.59982400612;11454.255473394203;11727.824082638597;8280.875786863082;8311.293540049164;8355.37334699912;8464.57677116154;8775.736727898173;9923.801523969625;11003.17476189273;11114.166437517057;11273.210875238654;11648.184627076023 03:47:30 INFO - PROCESS | 8242 | |3;mootools.html;1338.502631159304;1456.4465503108818;1491.8582734640208;1592.323262613389;1753.1847690823772;7207.531510451817;8232.176782321765;8468.788280292989;8488.405811593175;8759.562021898912;8540.402171847973;8633.3524985626;8635.827283454328;8636.222739953402;8665.653373865038;2280.8745518996448;2293.8050265727434;2295.5753185660706;2300.5513924784673;2310.6187479065934;2200.185931205448;2225.810806081485;2256.1652188690127;2266.9433264168365;2267.671187677786;2196.4179492434437;2217.246136313653;2220.744614369352;2223.8776867272295;2235.508188198594;2175.4996350839237;2184.584928863511;2197.9670304945357;2203.790639889216;2207.558488302338;2185.726784151981;2193.046024979139;2193.5722534105857;2204.911803527857;2212.6349152389835;8399.790005249857;8487.787805304855;8521.275691566225;8555.23002929733;8665.263452606472;4983.252512123175;5089.4147173074825;5097.082525145473;5120.078385890538;5120.61595380348;3065.20304720772;3152.6374466936136;3192.2657788708493;3192.2657788708493;3200.4079245339453;1056.1814593689876;1080.36258607422;1131.1007748839693;1133.699569614053;1169.1932566529154;11317;11351.943240283828;11374;11388.71528211793;11412.486438110305;4039.2527382434346;4183.079722461053;4194.077302993336;4314.892127696833;4315.309550471972;8974.68588599409;8978.775530611656;8980.506072166094;8987.77530561728;8995.370324077383;4841.1285968526;4853.150698627726;4853.247746599282;4854.902901941941;4860.708357498562;3849.3840985442193;4048.858289959896;4158.750474971512;4161.604647558477;4524.457065152137;3341.3818443588016;3612.6026137124895;3637.3452778500123;3657.140571965586;3663.157473780992;1136.5737848306885;1164.3770582738364;1165.6794381544973;1166.1370585766472;1173.559915031863;945.9337846350827;960.8222478841436;984.8522721591819;992.9156021738089;1007.9092881640687;5716.399778023331;5818.44724751148;5875.089361149029;5884.882302353929;6078.969605152034;433.4776594203977;435.17099924643605;435.3208993969418;435.4448078699683;436.75978211983283;4021.4168945503325;4113.341865301538;4202.348635961431;4205.663546916239;4210.473690788652;10047.849282260771;10378.792424151627;10447.320924140058;10516.263861529773;10528.052475277262;10384.273100882865;10386.42874641887;10436.73908152287;10440.112590429746;10443.582256709798;7441.330280274693;7765.378769698411;7773.766786996399;7851.646675899598;7855.567943763033;5799.82600521985;5962.731677074629;5994.160817485468;6024.518038556993;6228.719707613078;9278.164965153168;9360.578773955325;9539.809203816023;9545.713628591153;9581.329306948446;9597.184239339455;9728.270379721407;9736.367136136128;9778.266630002636;9831.803363932539;6478.578892371981;6641.169853768279;7168.462365322726;7242.311980361857;7297.452691048086;8286.627101780556;8373.58132093405;8374.162583741578;8376.162383761575;8379.58102094905;7205.063341765537;7285.599292038989;7384.778456646309;7443.925560744323;7728;7188.784336469915;7245.818854528468;7253.854922901618;7276.381507571704;7470.775876723707;6384.776532821515;6490.545661803817;6492.967535162294;6496.285408605144;6499.447546958561;4855.95144048555;4980.526849949249;5079.847604571869;5122.846314610568;5170.6380553360905;4998.925016124834;5126.4360920297995;5142.948570514247;5157.7679004444135;5344.225087362389 03:47:30 INFO - PROCESS | 8242 | |4;prototype.html;299.42510380070263;300.7954590878202;306.7239484463983;313.1045210697406;314.5721818327076;5183.870403239921;5319.946800531993;5335.919961200585;5378.919316210255;5423.430539793324;5155;5258.342707161605;5264.8157314494;5271.182966640167;5274.393444753854;4138.441310423084;4145.3781932710035;4148.751074935499;4165.604267594574;4167.93717602011;3990;4129.731567448106;4140.627343539081;4151.647109995654;4183.3515805050265;4108.178364327132;4120.402541631462;4121.258173528764;4130.772807495587;4133.090720041601;4096.836126554934;4097.344424892018;4101.692373072032;4110.403991421242;4121.62905338521;3603.6756691897594;3618.475321078429;3619.1542313420346;3632.146445585285;3647.927041459156;5163.63854530183;5184.196449550326;5195.272661827347;5204.271402003723;5218.512723873678;4657.790399432034;4662.393888794435;4663.696859704109;4669.556392142741;4678.730815554453;5416.83749487516;5513.751881165357;5532.2531458253425;5533.778648854041;5562.721863906789;3886.125621735115;3910.393888947218;3929.096307849211;3948;3958.7426817256787;5777.971110144465;5794.797182098649;5799.681017544033;5821;5840.503557197643;4036.1725846201457;4049.453323801249;4056.290149223933;4057.9797101014306;4079.755214687128;3913.804309784556;4084.1831633673382;4097.569755175723;4103.610157035077;4118.238125946709;4648.976755116203;4667.276572131325;4674.836380726658;4678.69588476748;4692.835750748775;5624.184493248456;5625.971870140623;5636.830895073154;5637.408072152447;5644.8306550803545;1309.8755618216255;1311.9147255428365;1377.7037936843626;1394.9442022318995;1398.3567558922805;860.445012966633;885.3090596959776;897.8653202019618;900.3157600223877;900.3877363392955;4729.385179926588;4774.928376074362;4778.061492182283;4779.402574678165;4780.067886762048;5018;5028.346314979102;5043.924341134886;5045.318881950963;5051.570616497565;4536.909261814745;4754.83803270828;4769.856904292877;4775.904481910342;4837.831220550545;2682.409869828635;2702.8783704733332;2711.1459890134543;2713.4437440324687;2724.891004359843;5200.765965531485;5218.66078704883;5232.2674825524455;5236.319278493847;5257.369115706139;5132.589392848563;5174.758058066112;5198.610104242197;5422.322209723706;5847.970760146172;5907.91138132937;5913.29040515141;5923.911141332884;5949;5953.583249172603;5773.653580785166;5777.884442311046;5797.710114494174;5801.680907550125;5842.7078646066675;5483.972580137074;5652.180433837153;5671.646266799232;5724.169995350734;5745.626534275259;5919.467247947706;5938.554608404301;5939.227900372924;5941.970290148694;5956.285245770535;3827.1771569112775;4099.590040995877;4103.610157035077;4107.219628270619;4124.298869192185;5431.696392865605;5634.887302254014;5677.3754886963225;5681.488666020078;5694.601377903507;5479.876625291885;5518.3377994639295;5611.6352437091455;5624.212610234488;5627.606067575231;5602.411746766694;5616.360310653986;5618.550515958796;5622.493975542221;5645.548356131581;5343.145096784496;5573.972130139324;5586.044884290466;5596.300462442195;5629.915551266816;5648.802291919763;5654.604177707521;5665.036943719495;5676.460736230051;5680.176374425602;5430.484104010113;5564;5577.414371490935;5592.86017849557;5606.943930560642 03:47:30 INFO - PROCESS | 8242 | |5;yui.html;599.2790850610404;632.7342516143223;653.9797915252207;683.5351960666751;696.248052103728;14467.638309042279;15088.773668394955;15184.0889546627;15269.16019618922;15308.234588270598;14158.575242742709;14168.858311416883;14220.71558568828;14222.431102755903;14272.500462483815;654.5974225851091;667.5994403357971;790.8418316336727;790.9129995700483;813.662330132994;810.4367464612097;811.6388207247777;813.7965508622844;814.3322475570035;814.7881550796806;859.9828003439959;860.5009094725044;861.6984055580529;861.8319427711599;862.2369203255133;683.3951952522004;699.9055127557816;819.635262308273;821.9753407397787;861.315254372772;613.5705006495471;614.0788816774838;614.665007570875;615.2801222569559;615.3630991923383;14107.224102674349;14209.57371278853;14228.644283892882;14242.501512447014;14267.429302827875;12128.878711212952;12210.755784884253;12513.562025329069;12600.55898043564;13018.349082545836;12496.437660305308;12727.809082863765;12761.680957976032;12813.935930320382;12993.545225917047;4390.692651514395;4502.189605870942;4600.194965880957;4606.147862645421;4653.58117769399;75123;75396.62301688457;81114;81381;81988.59005704994;11088.889111108785;11198.160137989684;11324.94337528307;11423.714407139889;11528.423578821026;21833.781662183173;22018;22044.779552204272;22121.889390552944;22141.335759926907;8035.598220088972;8078.555679437687;8144.389170812213;8156;8165.265126138676;4269.7224680395675;4304.418903447994;4338.739675619473;4402.3836662867225;4452.554744525586;3226.709596136312;3346.397648423307;3350.983245083759;3354.4632858742484;3356.278400143981;525.2571472149958;592.1620906417371;600.8227572866015;601.3655593349059;602.0397466041657;497.2566013809378;548.0245163608782;548.4816848078607;584.801167603017;601.5849064145725;8260.339172866155;8691.608877600524;9078.636854525745;9127.589258483384;9192.080791920887;560.742058653016;562.7073921560766;573.3549756523911;585.0726598341591;609.5032548472981;4209.17921005401;4406.228909940747;4464.642828573771;4478.552144785495;4518.84769383805;70974;120242;123267;125549.37225313815;127208.36395817962;89736;107316;107880.46059769651;109453.45273273582;111844;73471.55077166087;76093;80323.59838200889;84164;86084;8769.780755481164;9256.907430925605;9405.294602904673;9438.339316247797;9463.101005404751;51335.74332128315;52218.21672674989;52951.676208093566;53157.734211328694;53310.73344633252;68704.31295686979;70117;76212.61893690718;76621.61689191518;77409.61295193488;11918.880811191777;11933.403329833647;12166.513339466675;12205.389730513616;12286.569970051005;13542.458301667823;13601.183928964294;13730.862691372959;14388.712225755635;14485.141535192903;9150.176484116462;11848.348340841336;12794.296313702836;12858.67853303675;13217.801732974205;12529.874701252871;12635.87364126347;12672.6831829205;12932.935335323264;13240.271785051915;13020.348982551024;13300.933495332461;13306.667333316744;13671.521496747566;13872.306384680523;10377.533011014371;10741.812129737733;10747;10824;12052.758944820878;10574.524146413276;10972.780544388908;11023.228374014063;11028;11072.778544429228 03:47:30 INFO - PROCESS | 8242 | __end_tp_report 03:47:30 INFO - PROCESS | 8242 | __start_cc_report 03:47:30 INFO - PROCESS | 8242 | _x_x_mozilla_cycle_collect,1034 03:47:30 INFO - PROCESS | 8242 | __end_cc_report 03:47:30 INFO - PROCESS | 8242 | __startTimestamp1474800450590__endTimestamp 03:47:30 INFO - PROCESS | 8242 | 03:47:30 INFO - PROCESS | 8242 | ------- Summary: start ------- 03:47:30 INFO - PROCESS | 8242 | Number of tests: 6 03:47:30 INFO - PROCESS | 8242 | 03:47:30 INFO - PROCESS | 8242 | [#0] dojo.html Cycles:165 Average:5282.87 Median:5476.67 stddev:593.85 (10.8%) stddev-sans-first:568.27 03:47:30 INFO - PROCESS | 8242 | Values: 3009.8 3042.5 3043.5 3079.7 3092.0 5132.5 5207.0 5272.3 5329.0 5343.4 5214.8 5251.9 5287.0 5309.4 5372.7 4759.6 4787.0 4813.7 4830.3 4869.0 4815.9 4825.9 4851.8 4930.1 4956.2 4891.0 4934.3 4954.4 4975.1 4988.1 4775.5 4786.2 4811.4 4836.1 4845.9 4796.2 4808.8 4810.3 4832.0 4866.5 5252.6 5259.4 5273.8 5311.4 5339.8 5517.3 5650.6 5660.1 5661.8 5665.6 5584.6 5639.4 5653.1 5670.6 5678.2 5304.2 5382.1 5383.7 5386.4 5388.3 5826.3 5834.3 5834.9 5839.2 5839.2 5538.8 5567.2 5603.4 5609.0 5612.8 5531.7 5605.2 5610.9 5686.1 5688.2 5613.4 5650.5 5660.9 5673.3 5692.3 5658.2 5700.0 5703.9 5710.2 5767.6 4398.2 4398.3 4410.8 4412.9 4455.4 3886.4 3886.8 3908.7 3921.3 3968.7 5402.4 5426.2 5429.8 5452.4 5472.4 5758.0 5762.4 5763.9 5765.5 5766.8 5189.8 5288.2 5340.1 5471.4 5484.0 4879.4 4897.8 4906.1 4922.3 4963.7 5841.2 5871.5 5884.5 5890.7 5892.7 5557.3 5602.7 5668.4 5672.5 5739.2 5863.5 5920.4 5931.9 5994.6 6001.0 5639.3 5645.2 5648.9 5706.4 5714.7 5654.7 5688.7 5712.3 5714.9 5721.1 5408.1 5408.4 5464.5 5576.8 5592.8 5440.9 5527.9 5534.9 5591.2 5596.3 5470.6 5476.7 5481.1 5482.9 5483.9 5473.8 5483.8 5518.4 5536.1 5601.9 5381.2 5416.7 5478.0 5480.7 5538.8 03:47:30 INFO - PROCESS | 8242 | 03:47:30 INFO - PROCESS | 8242 | [#1] ext.html Cycles:180 Average:56380.35 Median:3550.64 stddev:109634.50 (3087.7%) stddev-sans-first:109861.90 03:47:30 INFO - PROCESS | 8242 | Values: 543.3 601.9 611.1 614.9 633.3 31756.5 43562.3 44546.8 44590.8 44656.8 45121.0 45559.3 45572.8 45611.5 45708.0 8070.5 8827.7 8969.9 8971.5 8982.8 8063.0 10490.9 10678.6 10687.1 11009.1 10796.7 10879.3 10881.1 10887.3 10902.6 10710.7 10779.7 10824.4 10854.7 10869.9 10629.1 10695.3 10704.5 10707.4 10708.9 42684.0 43050.6 43082.6 43085.6 43122.8 3100.3 3282.1 3295.3 3430.9 3553.1 31876.0 32649.8 32863.8 33178.8 34175.7 3494.7 3515.8 3518.9 3548.1 3706.0 325706.3 328141.0 329240.0 330100.0 330453.0 36729.8 37924.2 56061.7 56372.4 56380.2 38144.2 38486.4 38585.4 38588.8 38597.0 13127.7 13279.3 13311.9 13316.1 13321.7 9284.6 9479.5 10292.7 10551.5 10693.3 8453.5 8534.4 8584.1 8630.1 8659.7 3361.7 3372.9 3375.6 3403.2 3424.9 945.8 1010.4 1027.6 1074.0 1099.3 31555.8 31854.5 32128.2 32377.8 32524.2 1070.8 1085.2 1092.4 1140.2 1183.7 15645.2 16577.4 16649.4 16869.7 16894.0 493726.0 494933.0 497084.0 500068.0 501471.0 58248.7 58710.7 58827.0 58843.0 58888.7 1203.5 1227.2 1308.6 1315.9 1335.8 29167.7 33322.7 33342.0 33539.7 33822.0 48981.5 49714.5 49751.8 49772.3 49803.3 395824.0 398797.0 398897.0 399253.0 399349.0 27806.8 28605.3 28988.6 29043.3 30256.0 47561.3 47628.8 47976.0 48338.3 48452.0 39019.0 40593.6 40760.8 41988.0 43693.0 41002.0 41043.2 41311.4 42315.6 42518.8 41325.0 42071.0 42178.6 42194.4 42260.4 34962.0 37359.8 37526.8 37912.8 38105.0 28342.4 28454.4 28612.7 28615.1 28849.6 03:47:30 INFO - PROCESS | 8242 | 03:47:30 INFO - PROCESS | 8242 | [#2] jquery.html Cycles:180 Average:27910.67 Median:41825.69 stddev:77296.02 (184.8%) stddev-sans-first:77485.20 03:47:30 INFO - PROCESS | 8242 | Values: 370.4 380.3 380.5 384.7 393.4 14329.3 18613.7 19457.6 19588.8 20730.3 18234.8 19162.8 19232.1 19283.3 19322.0 5696.0 5944.2 5974.6 5976.3 5979.3 5695.6 5814.2 5841.4 5846.5 5857.0 5807.1 5808.4 5812.6 5815.6 5815.6 5581.4 5687.0 5716.3 5717.1 5731.4 5071.0 5110.8 5118.2 5118.3 5120.0 23165.8 23328.7 23518.9 23525.5 23595.5 2345.8 2355.0 2412.4 2522.4 2883.3 9639.1 9712.0 9788.3 10078.7 10092.4 1857.2 1949.6 1954.3 1955.3 2008.5 81832.6 82682.6 83128.1 83571.2 85900.6 10607.2 10797.6 10827.7 11014.2 11136.3 15437.3 15475.0 15485.6 15487.2 15501.8 7276.2 7388.0 7459.9 7552.5 7682.6 6908.6 6923.3 7060.3 7066.9 7135.1 4574.4 4666.2 4736.9 4761.5 4854.3 1916.7 1938.7 1962.9 1969.1 1978.5 877.8 954.7 964.4 1051.9 1069.3 18947.3 19153.8 19306.0 19521.4 19848.9 932.7 944.7 953.4 981.0 1030.5 10202.7 10452.8 10853.9 10875.4 10883.4 457181.0 468436.0 470591.0 473366.0 475628.8 57833.4 65656.0 79395.0 93644.0 95798.0 967.1 981.6 988.2 989.7 999.8 16422.3 16565.5 17542.5 17583.6 17682.1 40888.6 41737.0 41914.4 42190.0 42397.4 55321.7 55471.0 56546.4 57486.4 58332.0 8129.7 8131.6 8132.4 8323.0 8394.1 10146.0 12481.3 12493.8 12609.4 13086.1 10827.8 11172.9 11271.4 11798.7 11996.9 10627.5 11024.2 11144.3 11209.4 11354.8 11226.4 11324.3 11433.6 11454.3 11727.8 8280.9 8311.3 8355.4 8464.6 8775.7 9923.8 11003.2 11114.2 11273.2 11648.2 03:47:30 INFO - PROCESS | 8242 | 03:47:30 INFO - PROCESS | 8242 | [#3] mootools.html Cycles:180 Average:5488.46 Median:4858.33 stddev:3116.00 (64.1%) stddev-sans-first:3109.14 03:47:30 INFO - PROCESS | 8242 | Values: 1338.5 1456.4 1491.9 1592.3 1753.2 7207.5 8232.2 8468.8 8488.4 8759.6 8540.4 8633.4 8635.8 8636.2 8665.7 2280.9 2293.8 2295.6 2300.6 2310.6 2200.2 2225.8 2256.2 2266.9 2267.7 2196.4 2217.2 2220.7 2223.9 2235.5 2175.5 2184.6 2198.0 2203.8 2207.6 2185.7 2193.0 2193.6 2204.9 2212.6 8399.8 8487.8 8521.3 8555.2 8665.3 4983.3 5089.4 5097.1 5120.1 5120.6 3065.2 3152.6 3192.3 3192.3 3200.4 1056.2 1080.4 1131.1 1133.7 1169.2 11317.0 11351.9 11374.0 11388.7 11412.5 4039.3 4183.1 4194.1 4314.9 4315.3 8974.7 8978.8 8980.5 8987.8 8995.4 4841.1 4853.2 4853.2 4854.9 4860.7 3849.4 4048.9 4158.8 4161.6 4524.5 3341.4 3612.6 3637.3 3657.1 3663.2 1136.6 1164.4 1165.7 1166.1 1173.6 945.9 960.8 984.9 992.9 1007.9 5716.4 5818.4 5875.1 5884.9 6079.0 433.5 435.2 435.3 435.4 436.8 4021.4 4113.3 4202.3 4205.7 4210.5 10047.8 10378.8 10447.3 10516.3 10528.1 10384.3 10386.4 10436.7 10440.1 10443.6 7441.3 7765.4 7773.8 7851.6 7855.6 5799.8 5962.7 5994.2 6024.5 6228.7 9278.2 9360.6 9539.8 9545.7 9581.3 9597.2 9728.3 9736.4 9778.3 9831.8 6478.6 6641.2 7168.5 7242.3 7297.5 8286.6 8373.6 8374.2 8376.2 8379.6 7205.1 7285.6 7384.8 7443.9 7728.0 7188.8 7245.8 7253.9 7276.4 7470.8 6384.8 6490.5 6493.0 6496.3 6499.4 4856.0 4980.5 5079.8 5122.8 5170.6 4998.9 5126.4 5142.9 5157.8 5344.2 03:47:30 INFO - PROCESS | 8242 | 03:47:30 INFO - PROCESS | 8242 | [#4] prototype.html Cycles:180 Average:4599.25 Median:5189.73 stddev:1374.16 (26.5%) stddev-sans-first:1339.58 03:47:30 INFO - PROCESS | 8242 | Values: 299.4 300.8 306.7 313.1 314.6 5183.9 5319.9 5335.9 5378.9 5423.4 5155.0 5258.3 5264.8 5271.2 5274.4 4138.4 4145.4 4148.8 4165.6 4167.9 3990.0 4129.7 4140.6 4151.6 4183.4 4108.2 4120.4 4121.3 4130.8 4133.1 4096.8 4097.3 4101.7 4110.4 4121.6 3603.7 3618.5 3619.2 3632.1 3647.9 5163.6 5184.2 5195.3 5204.3 5218.5 4657.8 4662.4 4663.7 4669.6 4678.7 5416.8 5513.8 5532.3 5533.8 5562.7 3886.1 3910.4 3929.1 3948.0 3958.7 5778.0 5794.8 5799.7 5821.0 5840.5 4036.2 4049.5 4056.3 4058.0 4079.8 3913.8 4084.2 4097.6 4103.6 4118.2 4649.0 4667.3 4674.8 4678.7 4692.8 5624.2 5626.0 5636.8 5637.4 5644.8 1309.9 1311.9 1377.7 1394.9 1398.4 860.4 885.3 897.9 900.3 900.4 4729.4 4774.9 4778.1 4779.4 4780.1 5018.0 5028.3 5043.9 5045.3 5051.6 4536.9 4754.8 4769.9 4775.9 4837.8 2682.4 2702.9 2711.1 2713.4 2724.9 5200.8 5218.7 5232.3 5236.3 5257.4 5132.6 5174.8 5198.6 5422.3 5848.0 5907.9 5913.3 5923.9 5949.0 5953.6 5773.7 5777.9 5797.7 5801.7 5842.7 5484.0 5652.2 5671.6 5724.2 5745.6 5919.5 5938.6 5939.2 5942.0 5956.3 3827.2 4099.6 4103.6 4107.2 4124.3 5431.7 5634.9 5677.4 5681.5 5694.6 5479.9 5518.3 5611.6 5624.2 5627.6 5602.4 5616.4 5618.6 5622.5 5645.5 5343.1 5574.0 5586.0 5596.3 5629.9 5648.8 5654.6 5665.0 5676.5 5680.2 5430.5 5564.0 5577.4 5592.9 5606.9 03:47:30 INFO - PROCESS | 8242 | 03:47:30 INFO - PROCESS | 8242 | [#5] yui.html Cycles:180 Average:20595.47 Median:4471.60 stddev:30380.01 (679.4%) stddev-sans-first:30428.13 03:47:30 INFO - PROCESS | 8242 | Values: 599.3 632.7 654.0 683.5 696.2 14467.6 15088.8 15184.1 15269.2 15308.2 14158.6 14168.9 14220.7 14222.4 14272.5 654.6 667.6 790.8 790.9 813.7 810.4 811.6 813.8 814.3 814.8 860.0 860.5 861.7 861.8 862.2 683.4 699.9 819.6 822.0 861.3 613.6 614.1 614.7 615.3 615.4 14107.2 14209.6 14228.6 14242.5 14267.4 12128.9 12210.8 12513.6 12600.6 13018.3 12496.4 12727.8 12761.7 12813.9 12993.5 4390.7 4502.2 4600.2 4606.1 4653.6 75123.0 75396.6 81114.0 81381.0 81988.6 11088.9 11198.2 11324.9 11423.7 11528.4 21833.8 22018.0 22044.8 22121.9 22141.3 8035.6 8078.6 8144.4 8156.0 8165.3 4269.7 4304.4 4338.7 4402.4 4452.6 3226.7 3346.4 3351.0 3354.5 3356.3 525.3 592.2 600.8 601.4 602.0 497.3 548.0 548.5 584.8 601.6 8260.3 8691.6 9078.6 9127.6 9192.1 560.7 562.7 573.4 585.1 609.5 4209.2 4406.2 4464.6 4478.6 4518.8 70974.0 120242.0 123267.0 125549.4 127208.4 89736.0 107316.0 107880.5 109453.5 111844.0 73471.6 76093.0 80323.6 84164.0 86084.0 8769.8 9256.9 9405.3 9438.3 9463.1 51335.7 52218.2 52951.7 53157.7 53310.7 68704.3 70117.0 76212.6 76621.6 77409.6 11918.9 11933.4 12166.5 12205.4 12286.6 13542.5 13601.2 13730.9 14388.7 14485.1 9150.2 11848.3 12794.3 12858.7 13217.8 12529.9 12635.9 12672.7 12932.9 13240.3 13020.3 13300.9 13306.7 13671.5 13872.3 10377.5 10741.8 10747.0 10824.0 12052.8 10574.5 10972.8 11023.2 11028.0 11072.8 03:47:30 INFO - PROCESS | 8242 | -------- Summary: end -------- 03:47:30 INFO - PROCESS | 8242 | 03:47:31 INFO - TEST-INFO | 8242: exit 0 03:47:31 INFO - TEST-OK | dromaeo_css | took 1117051ms 03:47:31 INFO - TEST-START | kraken 03:47:31 INFO - operating with platform_type : linux_ 03:47:31 INFO - Initialising browser for kraken test... 03:47:31 INFO - TEST-INFO | started process 8543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdoCr_W/profile http://localhost:37203/getInfo.html) 03:47:36 INFO - PROCESS | 8543 | __metrics Screen width/height:1600/1200 03:47:36 INFO - PROCESS | 8543 | colorDepth:24 03:47:36 INFO - PROCESS | 8543 | Browser inner width/height: 1024/697 03:47:36 INFO - PROCESS | 8543 | __metrics 03:47:36 INFO - PROCESS | 8543 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:47:36 INFO - PROCESS | 8543 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:47:37 INFO - PROCESS | 8543 | console.error: PushService: 03:47:37 INFO - PROCESS | 8543 | stateChangeProcessEnqueue: Error transitioning state 03:47:37 INFO - PROCESS | 8543 | UnknownError 03:47:38 INFO - TEST-INFO | 8543: exit 0 03:47:38 INFO - Browser initialized. 03:47:38 INFO - Running cycle 1/1 for kraken test... 03:47:38 INFO - TEST-INFO | started process 8628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdoCr_W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:50 INFO - PROCESS | 8628 | RSS: Main: 173715456 03:47:50 INFO - PROCESS | 8628 | 03:47:52 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37203/tests/kraken/driver.html?testName=audio-beat-detection) 03:47:53 INFO - PROCESS | 8628 | RSS: Main: 241500160 03:47:53 INFO - PROCESS | 8628 | 03:47:56 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37203/tests/kraken/driver.html?testName=audio-dft) 03:47:56 INFO - PROCESS | 8628 | RSS: Main: 217051136 03:47:56 INFO - PROCESS | 8628 | 03:48:00 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37203/tests/kraken/driver.html?testName=audio-fft) 03:48:00 INFO - PROCESS | 8628 | RSS: Main: 298201088 03:48:00 INFO - PROCESS | 8628 | 03:48:02 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37203/tests/kraken/driver.html?testName=audio-oscillator) 03:48:03 INFO - PROCESS | 8628 | RSS: Main: 208629760 03:48:03 INFO - PROCESS | 8628 | 03:48:05 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37203/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:06 INFO - PROCESS | 8628 | RSS: Main: 212742144 03:48:06 INFO - PROCESS | 8628 | 03:48:09 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37203/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:09 INFO - PROCESS | 8628 | RSS: Main: 249405440 03:48:09 INFO - PROCESS | 8628 | 03:48:13 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37203/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:13 INFO - PROCESS | 8628 | RSS: Main: 248082432 03:48:13 INFO - PROCESS | 8628 | 03:48:16 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37203/tests/kraken/driver.html?testName=json-parse-financial) 03:48:17 INFO - PROCESS | 8628 | RSS: Main: 248676352 03:48:17 INFO - PROCESS | 8628 | 03:48:18 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37203/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:19 INFO - PROCESS | 8628 | RSS: Main: 210747392 03:48:19 INFO - PROCESS | 8628 | 03:48:20 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37203/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:21 INFO - PROCESS | 8628 | RSS: Main: 217784320 03:48:21 INFO - PROCESS | 8628 | 03:48:23 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37203/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:24 INFO - PROCESS | 8628 | RSS: Main: 223150080 03:48:24 INFO - PROCESS | 8628 | 03:48:26 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37203/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:27 INFO - PROCESS | 8628 | RSS: Main: 224788480 03:48:27 INFO - PROCESS | 8628 | 03:48:30 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37203/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:30 INFO - PROCESS | 8628 | RSS: Main: 221990912 03:48:30 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:37203/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37203/tests/kraken/driver.html?testName=ai-astar) 03:48:32 INFO - PROCESS | 8628 | RSS: Main: 272392192 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | __start_tp_report 03:48:32 INFO - PROCESS | 8628 | _x_x_mozilla_page_load 03:48:32 INFO - PROCESS | 8628 | _x_x_mozilla_page_load_details 03:48:32 INFO - PROCESS | 8628 | |i|pagename|runs| 03:48:32 INFO - PROCESS | 8628 | |0;ai-astar;107;110;110;110;109;110;110;110;110;110 03:48:32 INFO - PROCESS | 8628 | |1;audio-beat-detection;147;119;117;168;122;121;122;125;159;123 03:48:32 INFO - PROCESS | 8628 | |2;audio-dft;160;160;160;159;162;163;162;161;160;161 03:48:32 INFO - PROCESS | 8628 | |3;audio-fft;75;75;75;118;76;77;76;77;97;77 03:48:32 INFO - PROCESS | 8628 | |4;audio-oscillator;83;83;113;83;82;84;107;82;82;112 03:48:32 INFO - PROCESS | 8628 | |5;imaging-gaussian-blur;116;116;116;117;117;117;116;117;116;116 03:48:32 INFO - PROCESS | 8628 | |6;imaging-darkroom;145;147;146;145;146;146;145;145;145;146 03:48:32 INFO - PROCESS | 8628 | |7;imaging-desaturate;95;96;96;95;96;96;96;95;96;94 03:48:32 INFO - PROCESS | 8628 | |8;json-parse-financial;53;51;52;51;52;53;53;55;52;54 03:48:32 INFO - PROCESS | 8628 | |9;json-stringify-tinderbox;60;61;59;60;60;61;61;60;64;60 03:48:32 INFO - PROCESS | 8628 | |10;stanford-crypto-aes;79;79;78;78;88;84;91;79;78;86 03:48:32 INFO - PROCESS | 8628 | |11;stanford-crypto-ccm;129;131;132;121;127;122;124;136;158;124 03:48:32 INFO - PROCESS | 8628 | |12;stanford-crypto-pbkdf2;172;168;164;164;164;165;167;162;166;162 03:48:32 INFO - PROCESS | 8628 | |13;stanford-crypto-sha256-iterative;65;65;66;64;64;65;64;64;63;67 03:48:32 INFO - PROCESS | 8628 | __end_tp_report 03:48:32 INFO - PROCESS | 8628 | __start_cc_report 03:48:32 INFO - PROCESS | 8628 | _x_x_mozilla_cycle_collect,1614 03:48:32 INFO - PROCESS | 8628 | __end_cc_report 03:48:32 INFO - PROCESS | 8628 | __startTimestamp1474800512688__endTimestamp 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | ------- Summary: start ------- 03:48:32 INFO - PROCESS | 8628 | Number of tests: 14 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:0.97 (0.9%) stddev-sans-first:0.33 03:48:32 INFO - PROCESS | 8628 | Values: 107.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:124.00 stddev:18.54 (15.0%) stddev-sans-first:18.89 03:48:32 INFO - PROCESS | 8628 | Values: 147.0 119.0 117.0 168.0 122.0 121.0 122.0 125.0 159.0 123.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 03:48:32 INFO - PROCESS | 8628 | Values: 160.0 160.0 160.0 159.0 162.0 163.0 162.0 161.0 160.0 161.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.50 stddev:14.20 (18.6%) stddev-sans-first:14.81 03:48:32 INFO - PROCESS | 8628 | Values: 75.0 75.0 75.0 118.0 76.0 77.0 76.0 77.0 97.0 77.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.50 stddev:13.60 (16.5%) stddev-sans-first:14.11 03:48:32 INFO - PROCESS | 8628 | Values: 83.0 83.0 113.0 83.0 82.0 84.0 107.0 82.0 82.0 112.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:48:32 INFO - PROCESS | 8628 | Values: 116.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 03:48:32 INFO - PROCESS | 8628 | Values: 145.0 147.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 03:48:32 INFO - PROCESS | 8628 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 94.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.26 (2.4%) stddev-sans-first:1.33 03:48:32 INFO - PROCESS | 8628 | Values: 53.0 51.0 52.0 51.0 52.0 53.0 53.0 55.0 52.0 54.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.50 stddev:1.35 (2.2%) stddev-sans-first:1.41 03:48:32 INFO - PROCESS | 8628 | Values: 60.0 61.0 59.0 60.0 60.0 61.0 61.0 60.0 64.0 60.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:4.85 (6.0%) stddev-sans-first:5.02 03:48:32 INFO - PROCESS | 8628 | Values: 79.0 79.0 78.0 78.0 88.0 84.0 91.0 79.0 78.0 86.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:130.00 stddev:10.80 (8.3%) stddev-sans-first:11.45 03:48:32 INFO - PROCESS | 8628 | Values: 129.0 131.0 132.0 121.0 127.0 122.0 124.0 136.0 158.0 124.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:165.50 stddev:3.03 (1.8%) stddev-sans-first:2.06 03:48:32 INFO - PROCESS | 8628 | Values: 172.0 168.0 164.0 164.0 164.0 165.0 167.0 162.0 166.0 162.0 03:48:32 INFO - PROCESS | 8628 | 03:48:32 INFO - PROCESS | 8628 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 03:48:32 INFO - PROCESS | 8628 | Values: 65.0 65.0 66.0 64.0 64.0 65.0 64.0 64.0 63.0 67.0 03:48:32 INFO - PROCESS | 8628 | -------- Summary: end -------- 03:48:32 INFO - PROCESS | 8628 | 03:48:33 INFO - TEST-INFO | 8628: exit 0 03:48:33 INFO - TEST-OK | kraken | took 62374ms 03:48:33 INFO - SUITE-END | took 1179s 03:48:34 INFO - Completed test suite (00:19:39) 03:48:34 INFO - javascript benchmark 03:48:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3009.8495075246233, 3042.513197888337, 3043.513037913934, 3079.6612372638992, 3092.0105566218817, 5132.538071573557, 5206.973965130179, 5272.3145991021165, 5329.040772660925, 5343.358796944367, 5214.7653355598995, 5251.921221181676, 5286.973565132179, 5309.41596424394, 5372.7313634318325, 4759.571638552529, 4787.0, 4813.735244561548, 4830.3237546743485, 4869.0, 4815.927761083586, 4825.855224343275, 4851.805927762885, 4930.078920822028, 4956.2070068789, 4891.0, 4934.28452874333, 4954.355933728611, 4975.129352363322, 4988.102141614508, 4775.522447755231, 4786.1863483207935, 4811.350467686852, 4836.056968891067, 4845.927311090337, 4796.184648609745, 4808.75956202192, 4810.254410566367, 4832.033593281358, 4866.489018653061, 5252.553532949704, 5259.421463638997, 5273.7626806793405, 5311.415744268127, 5339.786408543654, 5517.2551705520045, 5650.63270887391, 5660.094384898396, 5661.801836935688, 5665.603407761459, 5584.581156413245, 5639.351474580435, 5653.067243904751, 5670.5747068969995, 5678.205051292823, 5304.230886521433, 5382.111951527954, 5383.650062745909, 5386.380566234855, 5388.326459192601, 5826.271716035496, 5834.299884013945, 5834.883302333929, 5839.153322768175, 5839.211706419579, 5538.833834984957, 5567.220589117527, 5603.411641777636, 5609.046462101453, 5612.7754889803955, 5531.6957567333375, 5605.215269862222, 5610.85972850682, 5686.14707793826, 5688.175214593861, 5613.410591887875, 5650.519705824969, 5660.915086273709, 5673.319201695823, 5692.260006199168, 5658.236138121383, 5699.971500142473, 5703.885922281531, 5710.200571919934, 5767.596268261265, 4398.186335527937, 4398.318260669537, 4410.823567057346, 4412.889677758082, 4455.443069616298, 3886.378179491268, 3886.805659717003, 3908.7068469864876, 3921.254961557295, 3968.6825053995613, 5402.405735369106, 5426.158945363475, 5429.8099566515775, 5452.372977107683, 5472.370677372073, 5757.971210143923, 5762.394948530427, 5763.88472230553, 5765.4522820332, 5766.798162064308, 5189.818356357509, 5288.180332048539, 5340.092184328673, 5471.37079235885, 5483.972580137074, 4879.414470263591, 4897.755112244445, 4906.11689895815, 4922.261660750916, 4963.677360971526, 5841.211436456109, 5871.500922421642, 5884.499817515388, 5890.734916928748, 5892.734826932799, 5557.277553918127, 5602.719864006865, 5668.37647858727, 5672.461116193955, 5739.225204597493, 5863.530917526673, 5920.437558431942, 5931.851703707442, 5994.6403215807195, 6001.039833626599, 5639.295088113986, 5645.209670646031, 5648.85877853057, 5706.400827913009, 5714.742836572281, 5654.660720356792, 5688.687122208153, 5712.343080545625, 5714.914276285942, 5721.141828725558, 5408.107662235687, 5408.405075441777, 5464.5081942623765, 5576.776928922797, 5592.804251851166, 5440.945590544202, 5527.944720552743, 5534.944650553443, 5591.161325801162, 5596.300462442195, 5470.56235501151, 5476.67139971603, 5481.095619222943, 5482.91775623358, 5483.945160548344, 5473.808416705396, 5483.75323110453, 5518.392976772632, 5536.058869992031, 5601.915971260516, 5381.165919282517, 5416.7020813855615, 5477.972610136924, 5480.698561578992, 5538.806141785019], "value": 5242.941476548408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.2923716000853, 601.9307779605346, 611.089476679747, 614.9139120523128, 633.3286716080952, 31756.523652145206, 43562.34656480151, 44546.777266113706, 44590.7770461148, 44656.77671611645, 45121.0, 45559.31661025079, 45572.772136139356, 45611.54388456114, 45708.0, 8070.515769053846, 8827.69103081394, 8969.910300896972, 8971.506567138806, 8982.775430614254, 8063.0, 10490.947545262263, 10678.572857085746, 10687.091597214247, 11009.064229540498, 10796.67609971702, 10879.292845964987, 10881.12950963925, 10887.346759194434, 10902.61840835571, 10710.678679639585, 10779.67660970172, 10824.350538967687, 10854.67435976914, 10869.891301086967, 10629.096526795154, 10695.251332406735, 10704.46477676121, 10707.411092389915, 10708.892911070867, 42684.0, 43050.56949430497, 43082.56917430848, 43085.56914430847, 43122.78438607818, 3100.2714362124884, 3282.1302354875975, 3295.2750394913082, 3430.9142271443166, 3553.129483276588, 31876.0, 32649.836750816332, 32863.835680821445, 33178.834105829555, 34175.6582434175, 3494.668006539375, 3515.789052656849, 3518.9120271993406, 3548.1484443733316, 3705.981470092659, 325706.2584673502, 328141.0, 329240.0, 330100.0, 330453.0, 36729.816350918074, 37924.24151516954, 56061.71969140128, 56372.43627563672, 56380.15429768557, 38144.237115257536, 38486.42270365947, 38585.42121868118, 38588.80705596454, 38597.0, 13127.737445251041, 13279.269640169883, 13311.866881331063, 13316.134451260637, 13321.733565328834, 9284.58219380116, 9479.526023698925, 10292.691219263434, 10551.47242637865, 10693.251472397013, 8453.492790432594, 8534.402591818513, 8584.05575386707, 8630.093840146694, 8659.653613855375, 3361.7478689097925, 3372.9325413491592, 3375.6118046424485, 3403.2002479417315, 3424.880129195466, 945.8297506448768, 1010.3634710132569, 1027.5530144387214, 1073.9946300268448, 1099.3184225779908, 31555.842220789207, 31854.522182167286, 32128.196795079843, 32377.838110809767, 32524.186895327806, 1070.8019016481976, 1085.1698450685233, 1092.3500517192258, 1140.184767890962, 1183.6922400175845, 15645.217739112999, 16577.41979030728, 16649.44253433239, 16869.746953795704, 16894.0, 493726.0, 494933.0, 497084.0, 500068.0, 501471.0, 58248.70875645595, 58710.70644646835, 58827.0, 58843.0, 58888.70555647194, 1203.5185925629644, 1227.2329793878826, 1308.5943357559188, 1315.9078864479586, 1335.7729186038202, 29167.7083229165, 33322.66677333292, 33342.0, 33539.66460335365, 33822.0, 48981.51018489769, 49714.50285497099, 49751.75124124356, 49772.25341619951, 49803.25295120504, 395824.0, 398797.0, 398897.0, 399253.0, 399349.0, 27806.828975653814, 28605.28486787847, 28988.565171522023, 29043.273918152216, 30256.0, 47561.286580700624, 47628.7618561905, 47976.0, 48338.274925875434, 48452.0, 39019.0, 40593.59406405898, 40760.79619602002, 41988.0, 43693.0, 41001.97495062647, 41043.22786740155, 41311.38032929449, 42315.57684423116, 42518.78740606401, 41325.0, 42071.0, 42178.578214217465, 42194.36708449314, 42260.36609450922, 34962.0, 37359.81320093382, 37526.81236593799, 37912.81043594875, 38105.0, 28342.43315133727, 28454.43091138124, 28612.71242794121, 28615.143892729142, 28849.567256491588], "value": 18844.360793506206, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.39810308249093, 380.32112678868225, 380.5311497619189, 384.70185606155235, 393.44720667462207, 14329.283535823206, 18613.72079418808, 19457.610847783035, 19588.804111958878, 20730.27444039459, 18234.81765182348, 19162.808371916275, 19232.13455394507, 19283.325083622076, 19322.0, 5696.0, 5944.197533333009, 5974.55190860685, 5976.342602313764, 5979.312379076397, 5695.629784064044, 5814.186013958049, 5841.386654401291, 5846.473817356437, 5857.033589457735, 5807.128930660414, 5808.361080281165, 5812.564057695668, 5815.592908496407, 5815.621984570989, 5581.386047534768, 5686.971565142189, 5716.314042314907, 5717.085266357404, 5731.426857314277, 5070.974645126787, 5110.8466745997675, 5118.232265160219, 5118.334616499831, 5120.0, 23165.76834231653, 23328.65007024896, 23518.882405588032, 23525.529489410117, 23595.52808943829, 2345.777151170636, 2355.0344358812977, 2412.3969007748065, 2522.369407648088, 2883.2935930696904, 9639.132478076937, 9711.951440242825, 9788.265880058952, 10078.748031299276, 10092.39445633257, 1857.1642760757713, 1949.5905859769466, 1954.3355259211937, 1955.2570023391163, 2008.5279959209574, 81832.59083704543, 82682.58658706667, 83128.1320307727, 83571.16428835694, 85900.57049714711, 10607.15142788575, 10797.56809727602, 10827.67516974492, 11014.229003969645, 11136.276142050903, 15437.30532126057, 15475.0, 15485.612859678373, 15487.225638718019, 15501.767473487907, 7276.199618042011, 7388.042168825265, 7459.888101678479, 7552.509086909334, 7682.615869206517, 6908.620025898624, 6923.342282483156, 7060.293970602898, 7066.858662826715, 7135.143782746104, 4574.359589657384, 4666.230072038075, 4736.905261894743, 4761.476237613929, 4854.271859221145, 1916.7029110487897, 1938.7378766583731, 1962.931297404584, 1969.1335812242567, 1978.4658142301498, 877.7937184761576, 954.7231302922214, 964.4309857184295, 1051.8737751469873, 1069.3316677076828, 18947.33684321042, 19153.808461915203, 19306.0, 19521.414357569294, 19848.908310043087, 932.658474799808, 944.6633459718016, 953.4422362917771, 980.9535665380306, 1030.5414090729553, 10202.693919182437, 10452.843207351896, 10853.891461085446, 10875.401852898167, 10883.401412922207, 457181.0, 468436.0, 470591.0, 473366.0, 475628.79011333716, 57833.421665783644, 65656.01515977264, 79395.0, 93644.0, 95798.0, 967.1102585621245, 981.5582987655441, 988.2094324540483, 989.6585677941099, 999.8450240212778, 16422.343106275614, 16565.503034908972, 17542.473725788248, 17583.648327033643, 17682.115894205497, 40888.59111408848, 41737.0, 41914.37128443137, 42190.0, 42397.36403954005, 55321.72339138279, 55471.0, 56546.434535654116, 57486.425135748104, 58332.0, 8129.715459958873, 8131.552764598004, 8132.430729848854, 8322.958385208036, 8394.076651568445, 10146.042274343543, 12481.251124932533, 12493.75012499763, 12609.432575534307, 13086.14940028895, 10827.837582436427, 11172.944135279271, 11271.436428178395, 11798.705032373917, 11996.940015300217, 10627.521761520595, 11024.173187011167, 11144.331340119294, 11209.383483908463, 11354.829677555008, 11226.4386780659, 11324.263922844988, 11433.59982400612, 11454.255473394203, 11727.824082638597, 8280.875786863082, 8311.293540049164, 8355.37334699912, 8464.57677116154, 8775.736727898173, 9923.801523969625, 11003.17476189273, 11114.166437517057, 11273.210875238654, 11648.184627076023], "value": 9008.662612228336, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.502631159304, 1456.4465503108818, 1491.8582734640208, 1592.323262613389, 1753.1847690823772, 7207.531510451817, 8232.176782321765, 8468.788280292989, 8488.405811593175, 8759.562021898912, 8540.402171847973, 8633.3524985626, 8635.827283454328, 8636.222739953402, 8665.653373865038, 2280.8745518996448, 2293.8050265727434, 2295.5753185660706, 2300.5513924784673, 2310.6187479065934, 2200.185931205448, 2225.810806081485, 2256.1652188690127, 2266.9433264168365, 2267.671187677786, 2196.4179492434437, 2217.246136313653, 2220.744614369352, 2223.8776867272295, 2235.508188198594, 2175.4996350839237, 2184.584928863511, 2197.9670304945357, 2203.790639889216, 2207.558488302338, 2185.726784151981, 2193.046024979139, 2193.5722534105857, 2204.911803527857, 2212.6349152389835, 8399.790005249857, 8487.787805304855, 8521.275691566225, 8555.23002929733, 8665.263452606472, 4983.252512123175, 5089.4147173074825, 5097.082525145473, 5120.078385890538, 5120.61595380348, 3065.20304720772, 3152.6374466936136, 3192.2657788708493, 3192.2657788708493, 3200.4079245339453, 1056.1814593689876, 1080.36258607422, 1131.1007748839693, 1133.699569614053, 1169.1932566529154, 11317.0, 11351.943240283828, 11374.0, 11388.71528211793, 11412.486438110305, 4039.2527382434346, 4183.079722461053, 4194.077302993336, 4314.892127696833, 4315.309550471972, 8974.68588599409, 8978.775530611656, 8980.506072166094, 8987.77530561728, 8995.370324077383, 4841.1285968526, 4853.150698627726, 4853.247746599282, 4854.902901941941, 4860.708357498562, 3849.3840985442193, 4048.858289959896, 4158.750474971512, 4161.604647558477, 4524.457065152137, 3341.3818443588016, 3612.6026137124895, 3637.3452778500123, 3657.140571965586, 3663.157473780992, 1136.5737848306885, 1164.3770582738364, 1165.6794381544973, 1166.1370585766472, 1173.559915031863, 945.9337846350827, 960.8222478841436, 984.8522721591819, 992.9156021738089, 1007.9092881640687, 5716.399778023331, 5818.44724751148, 5875.089361149029, 5884.882302353929, 6078.969605152034, 433.4776594203977, 435.17099924643605, 435.3208993969418, 435.4448078699683, 436.75978211983283, 4021.4168945503325, 4113.341865301538, 4202.348635961431, 4205.663546916239, 4210.473690788652, 10047.849282260771, 10378.792424151627, 10447.320924140058, 10516.263861529773, 10528.052475277262, 10384.273100882865, 10386.42874641887, 10436.73908152287, 10440.112590429746, 10443.582256709798, 7441.330280274693, 7765.378769698411, 7773.766786996399, 7851.646675899598, 7855.567943763033, 5799.82600521985, 5962.731677074629, 5994.160817485468, 6024.518038556993, 6228.719707613078, 9278.164965153168, 9360.578773955325, 9539.809203816023, 9545.713628591153, 9581.329306948446, 9597.184239339455, 9728.270379721407, 9736.367136136128, 9778.266630002636, 9831.803363932539, 6478.578892371981, 6641.169853768279, 7168.462365322726, 7242.311980361857, 7297.452691048086, 8286.627101780556, 8373.58132093405, 8374.162583741578, 8376.162383761575, 8379.58102094905, 7205.063341765537, 7285.599292038989, 7384.778456646309, 7443.925560744323, 7728.0, 7188.784336469915, 7245.818854528468, 7253.854922901618, 7276.381507571704, 7470.775876723707, 6384.776532821515, 6490.545661803817, 6492.967535162294, 6496.285408605144, 6499.447546958561, 4855.95144048555, 4980.526849949249, 5079.847604571869, 5122.846314610568, 5170.6380553360905, 4998.925016124834, 5126.4360920297995, 5142.948570514247, 5157.7679004444135, 5344.225087362389], "value": 4332.468759029463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.42510380070263, 300.7954590878202, 306.7239484463983, 313.1045210697406, 314.5721818327076, 5183.870403239921, 5319.946800531993, 5335.919961200585, 5378.919316210255, 5423.430539793324, 5155.0, 5258.342707161605, 5264.8157314494, 5271.182966640167, 5274.393444753854, 4138.441310423084, 4145.3781932710035, 4148.751074935499, 4165.604267594574, 4167.93717602011, 3990.0, 4129.731567448106, 4140.627343539081, 4151.647109995654, 4183.3515805050265, 4108.178364327132, 4120.402541631462, 4121.258173528764, 4130.772807495587, 4133.090720041601, 4096.836126554934, 4097.344424892018, 4101.692373072032, 4110.403991421242, 4121.62905338521, 3603.6756691897594, 3618.475321078429, 3619.1542313420346, 3632.146445585285, 3647.927041459156, 5163.63854530183, 5184.196449550326, 5195.272661827347, 5204.271402003723, 5218.512723873678, 4657.790399432034, 4662.393888794435, 4663.696859704109, 4669.556392142741, 4678.730815554453, 5416.83749487516, 5513.751881165357, 5532.2531458253425, 5533.778648854041, 5562.721863906789, 3886.125621735115, 3910.393888947218, 3929.096307849211, 3948.0, 3958.7426817256787, 5777.971110144465, 5794.797182098649, 5799.681017544033, 5821.0, 5840.503557197643, 4036.1725846201457, 4049.453323801249, 4056.290149223933, 4057.9797101014306, 4079.755214687128, 3913.804309784556, 4084.1831633673382, 4097.569755175723, 4103.610157035077, 4118.238125946709, 4648.976755116203, 4667.276572131325, 4674.836380726658, 4678.69588476748, 4692.835750748775, 5624.184493248456, 5625.971870140623, 5636.830895073154, 5637.408072152447, 5644.8306550803545, 1309.8755618216255, 1311.9147255428365, 1377.7037936843626, 1394.9442022318995, 1398.3567558922805, 860.445012966633, 885.3090596959776, 897.8653202019618, 900.3157600223877, 900.3877363392955, 4729.385179926588, 4774.928376074362, 4778.061492182283, 4779.402574678165, 4780.067886762048, 5018.0, 5028.346314979102, 5043.924341134886, 5045.318881950963, 5051.570616497565, 4536.909261814745, 4754.83803270828, 4769.856904292877, 4775.904481910342, 4837.831220550545, 2682.409869828635, 2702.8783704733332, 2711.1459890134543, 2713.4437440324687, 2724.891004359843, 5200.765965531485, 5218.66078704883, 5232.2674825524455, 5236.319278493847, 5257.369115706139, 5132.589392848563, 5174.758058066112, 5198.610104242197, 5422.322209723706, 5847.970760146172, 5907.91138132937, 5913.29040515141, 5923.911141332884, 5949.0, 5953.583249172603, 5773.653580785166, 5777.884442311046, 5797.710114494174, 5801.680907550125, 5842.7078646066675, 5483.972580137074, 5652.180433837153, 5671.646266799232, 5724.169995350734, 5745.626534275259, 5919.467247947706, 5938.554608404301, 5939.227900372924, 5941.970290148694, 5956.285245770535, 3827.1771569112775, 4099.590040995877, 4103.610157035077, 4107.219628270619, 4124.298869192185, 5431.696392865605, 5634.887302254014, 5677.3754886963225, 5681.488666020078, 5694.601377903507, 5479.876625291885, 5518.3377994639295, 5611.6352437091455, 5624.212610234488, 5627.606067575231, 5602.411746766694, 5616.360310653986, 5618.550515958796, 5622.493975542221, 5645.548356131581, 5343.145096784496, 5573.972130139324, 5586.044884290466, 5596.300462442195, 5629.915551266816, 5648.802291919763, 5654.604177707521, 5665.036943719495, 5676.460736230051, 5680.176374425602, 5430.484104010113, 5564.0, 5577.414371490935, 5592.86017849557, 5606.943930560642], "value": 4150.665359039473, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.2790850610404, 632.7342516143223, 653.9797915252207, 683.5351960666751, 696.248052103728, 14467.638309042279, 15088.773668394955, 15184.0889546627, 15269.16019618922, 15308.234588270598, 14158.575242742709, 14168.858311416883, 14220.71558568828, 14222.431102755903, 14272.500462483815, 654.5974225851091, 667.5994403357971, 790.8418316336727, 790.9129995700483, 813.662330132994, 810.4367464612097, 811.6388207247777, 813.7965508622844, 814.3322475570035, 814.7881550796806, 859.9828003439959, 860.5009094725044, 861.6984055580529, 861.8319427711599, 862.2369203255133, 683.3951952522004, 699.9055127557816, 819.635262308273, 821.9753407397787, 861.315254372772, 613.5705006495471, 614.0788816774838, 614.665007570875, 615.2801222569559, 615.3630991923383, 14107.224102674349, 14209.57371278853, 14228.644283892882, 14242.501512447014, 14267.429302827875, 12128.878711212952, 12210.755784884253, 12513.562025329069, 12600.55898043564, 13018.349082545836, 12496.437660305308, 12727.809082863765, 12761.680957976032, 12813.935930320382, 12993.545225917047, 4390.692651514395, 4502.189605870942, 4600.194965880957, 4606.147862645421, 4653.58117769399, 75123.0, 75396.62301688457, 81114.0, 81381.0, 81988.59005704994, 11088.889111108785, 11198.160137989684, 11324.94337528307, 11423.714407139889, 11528.423578821026, 21833.781662183173, 22018.0, 22044.779552204272, 22121.889390552944, 22141.335759926907, 8035.598220088972, 8078.555679437687, 8144.389170812213, 8156.0, 8165.265126138676, 4269.7224680395675, 4304.418903447994, 4338.739675619473, 4402.3836662867225, 4452.554744525586, 3226.709596136312, 3346.397648423307, 3350.983245083759, 3354.4632858742484, 3356.278400143981, 525.2571472149958, 592.1620906417371, 600.8227572866015, 601.3655593349059, 602.0397466041657, 497.2566013809378, 548.0245163608782, 548.4816848078607, 584.801167603017, 601.5849064145725, 8260.339172866155, 8691.608877600524, 9078.636854525745, 9127.589258483384, 9192.080791920887, 560.742058653016, 562.7073921560766, 573.3549756523911, 585.0726598341591, 609.5032548472981, 4209.17921005401, 4406.228909940747, 4464.642828573771, 4478.552144785495, 4518.84769383805, 70974.0, 120242.0, 123267.0, 125549.37225313815, 127208.36395817962, 89736.0, 107316.0, 107880.46059769651, 109453.45273273582, 111844.0, 73471.55077166087, 76093.0, 80323.59838200889, 84164.0, 86084.0, 8769.780755481164, 9256.907430925605, 9405.294602904673, 9438.339316247797, 9463.101005404751, 51335.74332128315, 52218.21672674989, 52951.676208093566, 53157.734211328694, 53310.73344633252, 68704.31295686979, 70117.0, 76212.61893690718, 76621.61689191518, 77409.61295193488, 11918.880811191777, 11933.403329833647, 12166.513339466675, 12205.389730513616, 12286.569970051005, 13542.458301667823, 13601.183928964294, 13730.862691372959, 14388.712225755635, 14485.141535192903, 9150.176484116462, 11848.348340841336, 12794.296313702836, 12858.67853303675, 13217.801732974205, 12529.874701252871, 12635.87364126347, 12672.6831829205, 12932.935335323264, 13240.271785051915, 13020.348982551024, 13300.933495332461, 13306.667333316744, 13671.521496747566, 13872.306384680523, 10377.533011014371, 10741.812129737733, 10747.0, 10824.0, 12052.758944820878, 10574.524146413276, 10972.780544388908, 11023.228374014063, 11028.0, 11072.778544429228], "value": 7237.850079026492, "unit": "score"}], "name": "dromaeo_css", "value": 6982.123704726201, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 117.0, 168.0, 122.0, 121.0, 122.0, 125.0, 159.0, 123.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 162.0, 163.0, 162.0, 161.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 118.0, 76.0, 77.0, 76.0, 77.0, 97.0, 77.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 113.0, 83.0, 82.0, 84.0, 107.0, 82.0, 82.0, 112.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 51.0, 52.0, 53.0, 53.0, 55.0, 52.0, 54.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 60.0, 60.0, 61.0, 61.0, 60.0, 64.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 88.0, 84.0, 91.0, 79.0, 78.0, 86.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 132.0, 121.0, 127.0, 122.0, 124.0, 136.0, 158.0, 124.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 164.0, 164.0, 164.0, 165.0, 167.0, 162.0, 166.0, 162.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 64.0, 64.0, 65.0, 64.0, 64.0, 63.0, 67.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1489.3000000000002, "alertThreshold": 2.0}]} 03:48:34 INFO - Return code: 0 03:48:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:48:34 INFO - # TBPL SUCCESS # 03:48:34 INFO - Running post-action listener: _resource_record_post_action 03:48:34 INFO - [mozharness: 2016-09-25 10:48:34.475074Z] Finished run-tests step (success) 03:48:34 INFO - Running post-run listener: _resource_record_post_run 03:48:34 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 196608; Write bytes: 404029440; Read time: 36; Write time: 604952 03:48:34 INFO - TinderboxPrint: CPU usage
13.0% 03:48:34 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 36 03:48:34 INFO - TinderboxPrint: I/O write bytes / time
404,029,440 / 604,952 03:48:34 INFO - TinderboxPrint: CPU idle
8,304.1 (86.9%) 03:48:34 INFO - TinderboxPrint: CPU user
1,192.9 (12.5%) 03:48:34 INFO - TinderboxPrint: Swap in / out
0 / 0 03:48:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115564544; Read time: 0; Write time: 119052 03:48:34 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 192512; Write bytes: 288464896; Read time: 28; Write time: 485900 03:48:35 INFO - Running post-run listener: _upload_blobber_files 03:48:35 INFO - Blob upload gear active. 03:48:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:35 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 03:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:48:35 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:48:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:48:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:38 INFO - (blobuploader) - INFO - Done attempting. 03:48:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:48:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:48:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:39 INFO - (blobuploader) - INFO - Done attempting. 03:48:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:48:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:48:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:40 INFO - (blobuploader) - INFO - Done attempting. 03:48:40 INFO - (blobuploader) - INFO - Iteration through files over. 03:48:40 INFO - Return code: 0 03:48:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:48:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:48:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/168ec4e2444d11a3d58377893f9ad0fef6a1af35a7923c7ecbd38e67a740f405f162a3eb06b9cad7ca179f0762dec1ab14803158ecf6b9332f2312077cd63754", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee6755440c4f11e2cbecaa5fe8db31c6dbdd323d9ccd54e4fd0ba8dc706306e230cd53d4400b7817a78c4dc54c96d31e704c59ffdaac484292952f415d0fa1af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50c39312d6340706fde08eaef5a8ebade439fa08f17db06bae502c4f19004e2e6af0f9bdd0dce2fe5f5f3b5b8dd8516aaed1faad6110e64cc1802ebe49180955"} 03:48:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:48:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:48:40 INFO - Contents: 03:48:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/168ec4e2444d11a3d58377893f9ad0fef6a1af35a7923c7ecbd38e67a740f405f162a3eb06b9cad7ca179f0762dec1ab14803158ecf6b9332f2312077cd63754", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee6755440c4f11e2cbecaa5fe8db31c6dbdd323d9ccd54e4fd0ba8dc706306e230cd53d4400b7817a78c4dc54c96d31e704c59ffdaac484292952f415d0fa1af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50c39312d6340706fde08eaef5a8ebade439fa08f17db06bae502c4f19004e2e6af0f9bdd0dce2fe5f5f3b5b8dd8516aaed1faad6110e64cc1802ebe49180955"} 03:48:40 INFO - Running post-run listener: copy_logs_to_upload_dir 03:48:40 INFO - Copying logs to upload dir... 03:48:40 INFO - mkdir: /builds/slave/test/build/upload/logs 03:48:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.775356 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-25 03:48:40.331312) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-25 03:48:40.334551) ========= 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=af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/168ec4e2444d11a3d58377893f9ad0fef6a1af35a7923c7ecbd38e67a740f405f162a3eb06b9cad7ca179f0762dec1ab14803158ecf6b9332f2312077cd63754", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee6755440c4f11e2cbecaa5fe8db31c6dbdd323d9ccd54e4fd0ba8dc706306e230cd53d4400b7817a78c4dc54c96d31e704c59ffdaac484292952f415d0fa1af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50c39312d6340706fde08eaef5a8ebade439fa08f17db06bae502c4f19004e2e6af0f9bdd0dce2fe5f5f3b5b8dd8516aaed1faad6110e64cc1802ebe49180955"} build_url:https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/IJzV4qQUQjapvvehoGyuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/168ec4e2444d11a3d58377893f9ad0fef6a1af35a7923c7ecbd38e67a740f405f162a3eb06b9cad7ca179f0762dec1ab14803158ecf6b9332f2312077cd63754", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee6755440c4f11e2cbecaa5fe8db31c6dbdd323d9ccd54e4fd0ba8dc706306e230cd53d4400b7817a78c4dc54c96d31e704c59ffdaac484292952f415d0fa1af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50c39312d6340706fde08eaef5a8ebade439fa08f17db06bae502c4f19004e2e6af0f9bdd0dce2fe5f5f3b5b8dd8516aaed1faad6110e64cc1802ebe49180955"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-25 03:48:40.362662) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:48:40.362944) ========= 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=af724c981e2a0f424dbabf99000001e7-1474799041.560941-921747426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:48:40.448574) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-25 03:48:40.449333) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-25 03:48:40.449938) ========= ========= Total master_lag: 0.17 =========