builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1474808998.71 results: success (0) buildid: 20160925030226 builduid: a63625bcc9e8401281e61cd368cc5121 revision: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-25 06:09:58.712606) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-25 06:09:58.713037) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-25 06:09:58.713325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-25 06:09:58.760656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 06:09:58.760935) ========= 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=df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-25 06:09: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% 69.5M=0s 2016-09-25 06:09:59 (69.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146371 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 06:09:58.924045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 06:09:58.924347) ========= 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=df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018314 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 06:09:58.974492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-25 06:09:58.974785) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 --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=df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-25 06:09:59,225 truncating revision to first 12 chars 2016-09-25 06:09:59,225 Setting DEBUG logging. 2016-09-25 06:09:59,225 attempt 1/10 2016-09-25 06:09:59,225 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/29beaebdfacc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-25 06:10:00,632 unpacking tar archive at: mozilla-central-29beaebdfacc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.748881 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-25 06:10:00.736345) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-25 06:10:00.736633) ========= script_repo_revision: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-25 06:10:00.737021) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-25 06:10:00.737301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-25 06:10:00.746778) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-25 06:10:00.747042) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:10:01 INFO - MultiFileLogger online at 20160925 06:10:01 in /builds/slave/test 06:10:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:10:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:10:01 INFO - {'append_to_log': False, 06:10:01 INFO - 'base_work_dir': '/builds/slave/test', 06:10:01 INFO - 'blob_upload_branch': 'Firefox', 06:10:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:10:01 INFO - 'branch': 'Firefox', 06:10:01 INFO - 'buildbot_json_path': 'buildprops.json', 06:10:01 INFO - 'config_files': ('talos/linux_config.py',), 06:10:01 INFO - 'default_actions': ('clobber', 06:10:01 INFO - 'read-buildbot-config', 06:10:01 INFO - 'download-and-extract', 06:10:01 INFO - 'populate-webroot', 06:10:01 INFO - 'create-virtualenv', 06:10:01 INFO - 'install', 06:10:01 INFO - 'run-tests'), 06:10:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:10:01 INFO - 'download_minidump_stackwalk': True, 06:10:01 INFO - 'download_symbols': 'ondemand', 06:10:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:10:01 INFO - 'tooltool.py': '/tools/tooltool.py', 06:10:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:10:01 INFO - '/tools/misc-python/virtualenv.py')}, 06:10:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:10:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:10:01 INFO - 'installer_path': 'installer.exe', 06:10:01 INFO - 'log_level': 'info', 06:10:01 INFO - 'log_name': 'talos', 06:10:01 INFO - 'log_to_console': True, 06:10:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:10:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:10:01 INFO - 'opt_config_files': (), 06:10:01 INFO - 'pip_index': False, 06:10:01 INFO - 'sps_profile': False, 06:10:01 INFO - 'sps_profile_interval': 0, 06:10:01 INFO - 'suite': 'dromaeojs', 06:10:01 INFO - 'system_bits': '32', 06:10:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:10:01 INFO - 'title': 'talos-linux64-ix-021', 06:10:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:10:01 INFO - 'use_talos_json': True, 06:10:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:10:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:10:01 INFO - 'work_dir': 'build'} 06:10:01 INFO - [mozharness: 2016-09-25 13:10:01.098008Z] Running clobber step. 06:10:01 INFO - Running pre-action listener: _resource_record_pre_action 06:10:01 INFO - Running main action method: clobber 06:10:01 INFO - rmtree: /builds/slave/test/build 06:10:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:10:01 INFO - Running post-action listener: _resource_record_post_action 06:10:01 INFO - [mozharness: 2016-09-25 13:10:01.545265Z] Finished clobber step (success) 06:10:01 INFO - [mozharness: 2016-09-25 13:10:01.545365Z] Running read-buildbot-config step. 06:10:01 INFO - Running pre-action listener: _resource_record_pre_action 06:10:01 INFO - Running main action method: read_buildbot_config 06:10:01 INFO - Using buildbot properties: 06:10:01 INFO - { 06:10:01 INFO - "project": "", 06:10:01 INFO - "product": "firefox", 06:10:01 INFO - "script_repo_revision": "production", 06:10:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:10:01 INFO - "repository": "", 06:10:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:10:01 INFO - "buildid": "20160925030226", 06:10:01 INFO - "stage_platform": "linux64-pgo", 06:10:01 INFO - "basedir": "/builds/slave/test", 06:10:01 INFO - "nightly_build": "True", 06:10:01 INFO - "buildnumber": 0, 06:10:01 INFO - "slavename": "talos-linux64-ix-021", 06:10:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:10:01 INFO - "platform": "ubuntu64_hw", 06:10:01 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:10:01 INFO - "branch": "mozilla-central", 06:10:01 INFO - "repo_path": "mozilla-central", 06:10:01 INFO - "revision": "29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49", 06:10:01 INFO - "pgo_build": "True", 06:10:01 INFO - "builduid": "a63625bcc9e8401281e61cd368cc5121", 06:10:01 INFO - "slavebuilddir": "test" 06:10:01 INFO - } 06:10:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:10:01 INFO - Running post-action listener: _resource_record_post_action 06:10:01 INFO - [mozharness: 2016-09-25 13:10:01.547880Z] Finished read-buildbot-config step (success) 06:10:01 INFO - [mozharness: 2016-09-25 13:10:01.547969Z] Running download-and-extract step. 06:10:01 INFO - Running pre-action listener: _resource_record_pre_action 06:10:01 INFO - Running main action method: download_and_extract 06:10:01 INFO - mkdir: /builds/slave/test/build/tests 06:10: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')]} 06:10:01 INFO - trying https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:10:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/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 06:10:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/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 06:10:02 INFO - Downloaded 1361 bytes. 06:10:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:10:02 INFO - Using the following test package requirements: 06:10:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:10:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:10:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:10:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:10:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:10:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:10:02 INFO - u'jsshell-linux-x86_64.zip'], 06:10:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:10:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:10:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:10:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:10:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:10:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:10:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:10:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:10:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:10:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:10:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:10:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:10:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:10:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:10:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:10:02 INFO - Expected file size: 21948384 06:10:07 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 06:10:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:10:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:10:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:10:07 INFO - Expected file size: 21948384 06:10:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:10:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:10:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:10:13 INFO - Expected file size: 14414059 06:10:13 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')]} 06:10:13 INFO - trying https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:10:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/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 06:10:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/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 06:10:16 INFO - Downloaded 59681215 bytes. 06:10:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:10:16 INFO - mkdir: /builds/slave/test/properties 06:10:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:10:16 INFO - Writing to file /builds/slave/test/properties/build_url 06:10:16 INFO - Contents: 06:10:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:10:16 INFO - Running post-action listener: _resource_record_post_action 06:10:16 INFO - Running post-action listener: set_extra_try_arguments 06:10:16 INFO - [mozharness: 2016-09-25 13:10:16.911629Z] Finished download-and-extract step (success) 06:10:16 INFO - [mozharness: 2016-09-25 13:10:16.911857Z] Running populate-webroot step. 06:10:16 INFO - Running pre-action listener: _resource_record_pre_action 06:10:16 INFO - Running main action method: populate_webroot 06:10:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:10:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:10:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:10:16 INFO - '--tppagecycles', 06:10:16 INFO - '7'], 06:10:16 INFO - 'tests': ['tsvgm']}}, 06:10:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:10:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:10:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:10:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:10:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:10:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:10:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:16 INFO - 'talos_options': ['--disable-e10s'], 06:10:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:16 INFO - 'talos_options': ['--disable-e10s'], 06:10:16 INFO - 'tests': ['damp', 'tps']}, 06:10:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:16 INFO - 'tests': ['damp', 'tps']}, 06:10:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:10:16 INFO - 'tests': ['dromaeo_dom']}, 06:10:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:10:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:10:16 INFO - 'tests': ['basic_compositor_video']}, 06:10:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:10:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:10:16 INFO - 'tests': ['a11yr', 06:10:16 INFO - 'ts_paint', 06:10:16 INFO - 'tpaint', 06:10:16 INFO - 'sessionrestore', 06:10:16 INFO - 'sessionrestore_no_auto_restore', 06:10:16 INFO - 'tabpaint']}, 06:10:16 INFO - 'other-e10s': {'tests': ['a11yr', 06:10:16 INFO - 'ts_paint', 06:10:16 INFO - 'tpaint', 06:10:16 INFO - 'sessionrestore', 06:10:16 INFO - 'sessionrestore_no_auto_restore', 06:10:16 INFO - 'tabpaint']}, 06:10:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:10:16 INFO - 'ts_paint', 06:10:16 INFO - 'tpaint', 06:10:16 INFO - 'sessionrestore', 06:10:16 INFO - 'sessionrestore_no_auto_restore', 06:10:16 INFO - 'tabpaint']}, 06:10:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:10:16 INFO - 'ts_paint', 06:10:16 INFO - 'tpaint', 06:10:16 INFO - 'sessionrestore', 06:10:16 INFO - 'sessionrestore_no_auto_restore', 06:10:16 INFO - 'tabpaint']}, 06:10:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:10:16 INFO - 'tests': ['a11yr', 06:10:16 INFO - 'ts_paint', 06:10:16 INFO - 'tpaint', 06:10:16 INFO - 'sessionrestore', 06:10:16 INFO - 'sessionrestore_no_auto_restore', 06:10:16 INFO - 'tabpaint']}, 06:10:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:10:16 INFO - 'tests': ['a11yr', 06:10:16 INFO - 'ts_paint', 06:10:16 INFO - 'tpaint', 06:10:16 INFO - 'sessionrestore', 06:10:16 INFO - 'sessionrestore_no_auto_restore', 06:10:16 INFO - 'tabpaint']}, 06:10:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:10:16 INFO - 'tests': ['tsvgx', 06:10:16 INFO - 'tsvgr_opacity', 06:10:16 INFO - 'tart', 06:10:16 INFO - 'tscrollx', 06:10:16 INFO - 'cart']}, 06:10:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:10:16 INFO - 'tsvgr_opacity', 06:10:16 INFO - 'tart', 06:10:16 INFO - 'tscrollx', 06:10:16 INFO - 'cart']}, 06:10:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:16 INFO - 'talos_options': ['--disable-e10s'], 06:10:16 INFO - 'tests': ['tp5o']}, 06:10:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:16 INFO - 'tests': ['tp5o']}, 06:10:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:16 INFO - 'talos_options': ['--disable-e10s', 06:10:16 INFO - '--xperf_path', 06:10:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:16 INFO - 'tests': ['tp5n']}, 06:10:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:16 INFO - 'talos_options': ['--xperf_path', 06:10:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:16 INFO - 'tests': ['tp5n']}}, 06:10:16 INFO - 'talos.zip': {'path': '', 06:10:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:10:16 INFO - Running post-action listener: _resource_record_post_action 06:10:16 INFO - [mozharness: 2016-09-25 13:10:16.933577Z] Finished populate-webroot step (success) 06:10:16 INFO - [mozharness: 2016-09-25 13:10:16.933666Z] Running create-virtualenv step. 06:10:16 INFO - Running pre-action listener: _resource_record_pre_action 06:10:16 INFO - Running main action method: create_virtualenv 06:10:16 INFO - Creating virtualenv /builds/slave/test/build/venv 06:10:16 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 06:10:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:10:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:10:17 INFO - Using real prefix '/usr' 06:10:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:10:17 INFO - Installing distribute.............................................................................................................................................................................................done. 06:10:19 INFO - Installing pip.................done. 06:10:19 INFO - Return code: 0 06:10:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43801abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953930>, '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 0x2954830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2954cc0>, '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': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', '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 06:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:10:19 INFO - Using env: {'DISPLAY': ':0', 06:10:19 INFO - 'HOME': '/home/cltbld', 06:10:19 INFO - 'LANG': 'en_US.UTF-8', 06:10:19 INFO - 'LANGUAGE': 'en_US:en', 06:10:19 INFO - 'LOGNAME': 'cltbld', 06:10:19 INFO - 'MAIL': '/var/mail/cltbld', 06:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:19 INFO - 'MOZ_NO_REMOTE': '1', 06:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:19 INFO - 'NO_EM_RESTART': '1', 06:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:19 INFO - 'PWD': '/builds/slave/test', 06:10:19 INFO - 'SHELL': '/bin/bash', 06:10:19 INFO - 'SHLVL': '1', 06:10:19 INFO - 'TERM': 'linux', 06:10:19 INFO - 'TMOUT': '86400', 06:10:19 INFO - 'USER': 'cltbld', 06:10:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', 06:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:19 INFO - '_': '/tools/buildbot/bin/python'} 06:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:19 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 06:10:19 INFO - Cleaning up... 06:10:19 INFO - Return code: 0 06:10:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f43801abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953930>, '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 0x2954830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2954cc0>, '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': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', '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 06:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:10:19 INFO - Using env: {'DISPLAY': ':0', 06:10:19 INFO - 'HOME': '/home/cltbld', 06:10:19 INFO - 'LANG': 'en_US.UTF-8', 06:10:19 INFO - 'LANGUAGE': 'en_US:en', 06:10:19 INFO - 'LOGNAME': 'cltbld', 06:10:19 INFO - 'MAIL': '/var/mail/cltbld', 06:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:19 INFO - 'MOZ_NO_REMOTE': '1', 06:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:19 INFO - 'NO_EM_RESTART': '1', 06:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:19 INFO - 'PWD': '/builds/slave/test', 06:10:19 INFO - 'SHELL': '/bin/bash', 06:10:19 INFO - 'SHLVL': '1', 06:10:19 INFO - 'TERM': 'linux', 06:10:19 INFO - 'TMOUT': '86400', 06:10:19 INFO - 'USER': 'cltbld', 06:10:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', 06:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:19 INFO - '_': '/tools/buildbot/bin/python'} 06:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:19 INFO - Downloading/unpacking psutil>=3.1.1 06:10:19 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 06:10:19 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 06:10:19 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 06:10:19 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 06:10:19 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 06:10:19 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 06:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:10:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:21 INFO - Installing collected packages: psutil 06:10:21 INFO - Running setup.py install for psutil 06:10:22 INFO - building 'psutil._psutil_linux' extension 06:10:22 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 06:10:22 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 06:10:22 INFO - building 'psutil._psutil_posix' extension 06:10:22 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 06:10:22 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 06:10:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:22 INFO - Successfully installed psutil 06:10:22 INFO - Cleaning up... 06:10:22 INFO - Return code: 0 06:10:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:10: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')]} 06:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10: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')]} 06:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43801abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953930>, '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 0x2954830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2954cc0>, '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': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', '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 06:10: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:10: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 mozsystemmonitor==0.3 06:10:22 INFO - Using env: {'DISPLAY': ':0', 06:10:22 INFO - 'HOME': '/home/cltbld', 06:10:22 INFO - 'LANG': 'en_US.UTF-8', 06:10:22 INFO - 'LANGUAGE': 'en_US:en', 06:10:22 INFO - 'LOGNAME': 'cltbld', 06:10:22 INFO - 'MAIL': '/var/mail/cltbld', 06:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:22 INFO - 'MOZ_NO_REMOTE': '1', 06:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:22 INFO - 'NO_EM_RESTART': '1', 06:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:22 INFO - 'PWD': '/builds/slave/test', 06:10:22 INFO - 'SHELL': '/bin/bash', 06:10:22 INFO - 'SHLVL': '1', 06:10:22 INFO - 'TERM': 'linux', 06:10:22 INFO - 'TMOUT': '86400', 06:10:22 INFO - 'USER': 'cltbld', 06:10:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', 06:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:22 INFO - '_': '/tools/buildbot/bin/python'} 06:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:10:24 INFO - Installing collected packages: mozsystemmonitor 06:10:24 INFO - Running setup.py install for mozsystemmonitor 06:10:24 INFO - Successfully installed mozsystemmonitor 06:10:24 INFO - Cleaning up... 06:10:24 INFO - Return code: 0 06:10:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:24 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 0x7f43801abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953930>, '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 0x2954830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2954cc0>, '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': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', '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 06:10:24 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 06:10:24 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 06:10:24 INFO - Using env: {'DISPLAY': ':0', 06:10:24 INFO - 'HOME': '/home/cltbld', 06:10:24 INFO - 'LANG': 'en_US.UTF-8', 06:10:24 INFO - 'LANGUAGE': 'en_US:en', 06:10:24 INFO - 'LOGNAME': 'cltbld', 06:10:24 INFO - 'MAIL': '/var/mail/cltbld', 06:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:24 INFO - 'MOZ_NO_REMOTE': '1', 06:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:24 INFO - 'NO_EM_RESTART': '1', 06:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:24 INFO - 'PWD': '/builds/slave/test', 06:10:24 INFO - 'SHELL': '/bin/bash', 06:10:24 INFO - 'SHLVL': '1', 06:10:24 INFO - 'TERM': 'linux', 06:10:24 INFO - 'TMOUT': '86400', 06:10:24 INFO - 'USER': 'cltbld', 06:10:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', 06:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:24 INFO - '_': '/tools/buildbot/bin/python'} 06:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:25 INFO - Downloading/unpacking jsonschema==2.5.1 06:10: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 06:10: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 06:10: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 06:10: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 06:10: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 06:10: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 06:10:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:10:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:10:26 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 06:10:26 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 06:10:26 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 06:10:26 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 06:10:26 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 06:10:26 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 06:10:27 INFO - Downloading functools32-3.2.3-2.tar.gz 06:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:10:27 INFO - warning: no files found matching '*.txt' 06:10:27 INFO - no previously-included directories found matching 'build' 06:10:27 INFO - no previously-included directories found matching 'dist' 06:10:27 INFO - no previously-included directories found matching '.git*' 06:10:27 INFO - Installing collected packages: jsonschema, functools32 06:10:27 INFO - Running setup.py install for functools32 06:10:27 INFO - warning: no files found matching '*.txt' 06:10:27 INFO - no previously-included directories found matching 'build' 06:10:27 INFO - no previously-included directories found matching 'dist' 06:10:27 INFO - no previously-included directories found matching '.git*' 06:10:27 INFO - Successfully installed jsonschema functools32 06:10:27 INFO - Cleaning up... 06:10:27 INFO - Return code: 0 06:10:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f43801abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953930>, '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 0x2954830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2954cc0>, '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': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', '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 06:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:10:27 INFO - Using env: {'DISPLAY': ':0', 06:10:27 INFO - 'HOME': '/home/cltbld', 06:10:27 INFO - 'LANG': 'en_US.UTF-8', 06:10:27 INFO - 'LANGUAGE': 'en_US:en', 06:10:27 INFO - 'LOGNAME': 'cltbld', 06:10:27 INFO - 'MAIL': '/var/mail/cltbld', 06:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:27 INFO - 'MOZ_NO_REMOTE': '1', 06:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:27 INFO - 'NO_EM_RESTART': '1', 06:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:27 INFO - 'PWD': '/builds/slave/test', 06:10:27 INFO - 'SHELL': '/bin/bash', 06:10:27 INFO - 'SHLVL': '1', 06:10:27 INFO - 'TERM': 'linux', 06:10:27 INFO - 'TMOUT': '86400', 06:10:27 INFO - 'USER': 'cltbld', 06:10:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', 06:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:27 INFO - '_': '/tools/buildbot/bin/python'} 06:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:10:27 INFO - Cleaning up... 06:10:27 INFO - Return code: 0 06:10:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f43801abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953930>, '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 0x2954830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2954cc0>, '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': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', '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 06:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:10:27 INFO - Using env: {'DISPLAY': ':0', 06:10:27 INFO - 'HOME': '/home/cltbld', 06:10:27 INFO - 'LANG': 'en_US.UTF-8', 06:10:27 INFO - 'LANGUAGE': 'en_US:en', 06:10:27 INFO - 'LOGNAME': 'cltbld', 06:10:27 INFO - 'MAIL': '/var/mail/cltbld', 06:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:27 INFO - 'MOZ_NO_REMOTE': '1', 06:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:27 INFO - 'NO_EM_RESTART': '1', 06:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:27 INFO - 'PWD': '/builds/slave/test', 06:10:27 INFO - 'SHELL': '/bin/bash', 06:10:27 INFO - 'SHLVL': '1', 06:10:27 INFO - 'TERM': 'linux', 06:10:27 INFO - 'TMOUT': '86400', 06:10:27 INFO - 'USER': 'cltbld', 06:10:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', 06:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:27 INFO - '_': '/tools/buildbot/bin/python'} 06:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:27 INFO - Downloading/unpacking blobuploader==1.2.4 06:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:29 INFO - Downloading blobuploader-1.2.4.tar.gz 06:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:10:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:10:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:30 INFO - Downloading docopt-0.6.1.tar.gz 06:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:10:30 INFO - Installing collected packages: blobuploader, requests, docopt 06:10:30 INFO - Running setup.py install for blobuploader 06:10:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:10:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:10:30 INFO - Running setup.py install for requests 06:10:30 INFO - Running setup.py install for docopt 06:10:31 INFO - Successfully installed blobuploader requests docopt 06:10:31 INFO - Cleaning up... 06:10:31 INFO - Return code: 0 06:10:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:31 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')]} 06:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:31 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')]} 06:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:31 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 0x7f43801abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953930>, '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 0x2954830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2954cc0>, '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': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', '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 06:10:31 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 06:10:31 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 06:10:31 INFO - Using env: {'DISPLAY': ':0', 06:10:31 INFO - 'HOME': '/home/cltbld', 06:10:31 INFO - 'LANG': 'en_US.UTF-8', 06:10:31 INFO - 'LANGUAGE': 'en_US:en', 06:10:31 INFO - 'LOGNAME': 'cltbld', 06:10:31 INFO - 'MAIL': '/var/mail/cltbld', 06:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:31 INFO - 'MOZ_NO_REMOTE': '1', 06:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:31 INFO - 'NO_EM_RESTART': '1', 06:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:31 INFO - 'PWD': '/builds/slave/test', 06:10:31 INFO - 'SHELL': '/bin/bash', 06:10:31 INFO - 'SHLVL': '1', 06:10:31 INFO - 'TERM': 'linux', 06:10:31 INFO - 'TMOUT': '86400', 06:10:31 INFO - 'USER': 'cltbld', 06:10:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', 06:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:31 INFO - '_': '/tools/buildbot/bin/python'} 06:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:10:31 INFO - Running setup.py (path:/tmp/pip-r1GlhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:10:31 INFO - Running setup.py (path:/tmp/pip-A2PdVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:10:31 INFO - Running setup.py (path:/tmp/pip-4sbiMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:10:31 INFO - Running setup.py (path:/tmp/pip-36ewzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:10:31 INFO - Running setup.py (path:/tmp/pip-wxdOTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:10:31 INFO - Running setup.py (path:/tmp/pip-O7FzuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:10:31 INFO - Running setup.py (path:/tmp/pip-Fdbwzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:10:31 INFO - Running setup.py (path:/tmp/pip-GEt6fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:10:31 INFO - Running setup.py (path:/tmp/pip-SelM0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:10:31 INFO - Running setup.py (path:/tmp/pip-BPfyAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:10:32 INFO - Running setup.py (path:/tmp/pip-O2MBY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:10:32 INFO - Running setup.py (path:/tmp/pip-7960XR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:10:32 INFO - Running setup.py (path:/tmp/pip-lPyp44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:10:32 INFO - Running setup.py (path:/tmp/pip-M_ElQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:32 INFO - Running setup.py (path:/tmp/pip-aG_oYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:10:32 INFO - Running setup.py (path:/tmp/pip-dIGAAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:10:32 INFO - Running setup.py (path:/tmp/pip-JUM79d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:10:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:10:32 INFO - Running setup.py install for manifestparser 06:10:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:10:32 INFO - Running setup.py install for mozcrash 06:10:32 INFO - Running setup.py install for mozdebug 06:10:32 INFO - Running setup.py install for mozdevice 06:10:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:10:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:10:32 INFO - Running setup.py install for mozfile 06:10:33 INFO - Running setup.py install for mozhttpd 06:10:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:10:33 INFO - Running setup.py install for mozinfo 06:10:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:10:33 INFO - Running setup.py install for mozInstall 06:10:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:10:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:10:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:10:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:10:33 INFO - Running setup.py install for mozleak 06:10:33 INFO - Running setup.py install for mozlog 06:10:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:10:33 INFO - Running setup.py install for moznetwork 06:10:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:10:33 INFO - Running setup.py install for mozprocess 06:10:33 INFO - Running setup.py install for mozprofile 06:10:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:10:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:10:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:10:33 INFO - Running setup.py install for mozrunner 06:10:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:10:34 INFO - Running setup.py install for mozscreenshot 06:10:34 INFO - Running setup.py install for moztest 06:10:34 INFO - Running setup.py install for mozversion 06:10:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:10:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:10:34 INFO - Cleaning up... 06:10:34 INFO - Return code: 0 06:10:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:34 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 0x7f43801abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953930>, '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 0x2954830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2954cc0>, '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': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', '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 06:10:34 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 06:10:34 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 06:10:34 INFO - Using env: {'DISPLAY': ':0', 06:10:34 INFO - 'HOME': '/home/cltbld', 06:10:34 INFO - 'LANG': 'en_US.UTF-8', 06:10:34 INFO - 'LANGUAGE': 'en_US:en', 06:10:34 INFO - 'LOGNAME': 'cltbld', 06:10:34 INFO - 'MAIL': '/var/mail/cltbld', 06:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:34 INFO - 'MOZ_NO_REMOTE': '1', 06:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:34 INFO - 'NO_EM_RESTART': '1', 06:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:34 INFO - 'PWD': '/builds/slave/test', 06:10:34 INFO - 'SHELL': '/bin/bash', 06:10:34 INFO - 'SHLVL': '1', 06:10:34 INFO - 'TERM': 'linux', 06:10:34 INFO - 'TMOUT': '86400', 06:10:34 INFO - 'USER': 'cltbld', 06:10:34 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', 06:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:34 INFO - '_': '/tools/buildbot/bin/python'} 06:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:10:34 INFO - Running setup.py (path:/tmp/pip-A2iYa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:10:34 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)) 06:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:10:34 INFO - Running setup.py (path:/tmp/pip-hZimm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:10:34 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)) 06:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:10:34 INFO - Running setup.py (path:/tmp/pip-CmE0QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:10:34 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)) 06:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:10:34 INFO - Running setup.py (path:/tmp/pip-AEbTFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:10:34 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)) 06:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:10:34 INFO - Running setup.py (path:/tmp/pip-NXLmfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:10:34 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)) 06:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:10:34 INFO - Running setup.py (path:/tmp/pip-YxoUES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:10:34 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)) 06:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:10:34 INFO - Running setup.py (path:/tmp/pip-gDZnub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:10:35 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)) 06:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:10:35 INFO - Running setup.py (path:/tmp/pip-slz3s2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:10:35 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)) 06:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:10:35 INFO - Running setup.py (path:/tmp/pip-SqXpl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:10:35 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)) 06:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:10:35 INFO - Running setup.py (path:/tmp/pip-SL1pm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:10:35 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)) 06:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:10:35 INFO - Running setup.py (path:/tmp/pip-nGN0uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:10:35 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)) 06:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:10:35 INFO - Running setup.py (path:/tmp/pip-qRDzkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:10:35 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)) 06:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:10:35 INFO - Running setup.py (path:/tmp/pip-G8_yqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:10:35 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)) 06:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:10:35 INFO - Running setup.py (path:/tmp/pip-sqMfkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:10:35 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)) 06:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:35 INFO - Running setup.py (path:/tmp/pip-iptKSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:35 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)) 06:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:10:35 INFO - Running setup.py (path:/tmp/pip-Y7A_Ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:10:35 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)) 06:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:10:35 INFO - Running setup.py (path:/tmp/pip-0ocqPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:37 INFO - Downloading blessings-1.6.tar.gz 06:10:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:10:37 INFO - Installing collected packages: blessings 06:10:37 INFO - Running setup.py install for blessings 06:10:37 INFO - Successfully installed blessings 06:10:37 INFO - Cleaning up... 06:10:37 INFO - Return code: 0 06:10:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:10:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:38 INFO - Reading from file tmpfile_stdout 06:10:38 INFO - Current package versions: 06:10:38 INFO - argparse == 1.2.1 06:10:38 INFO - blessings == 1.6 06:10:38 INFO - blobuploader == 1.2.4 06:10:38 INFO - docopt == 0.6.1 06:10:38 INFO - functools32 == 3.2.3-2 06:10:38 INFO - jsonschema == 2.5.1 06:10:38 INFO - manifestparser == 1.1 06:10:38 INFO - mozInstall == 1.12 06:10:38 INFO - mozcrash == 0.17 06:10:38 INFO - mozdebug == 0.1 06:10:38 INFO - mozdevice == 0.48 06:10:38 INFO - mozfile == 1.2 06:10:38 INFO - mozhttpd == 0.7 06:10:38 INFO - mozinfo == 0.9 06:10:38 INFO - mozleak == 0.1 06:10:38 INFO - mozlog == 3.4 06:10:38 INFO - moznetwork == 0.27 06:10:38 INFO - mozprocess == 0.23 06:10:38 INFO - mozprofile == 0.28 06:10:38 INFO - mozrunner == 6.12 06:10:38 INFO - mozscreenshot == 0.1 06:10:38 INFO - mozsystemmonitor == 0.3 06:10:38 INFO - moztest == 0.7 06:10:38 INFO - mozversion == 1.4 06:10:38 INFO - psutil == 3.1.1 06:10:38 INFO - requests == 1.2.3 06:10:38 INFO - wsgiref == 0.1.2 06:10:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:38 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')]} 06:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:38 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')]} 06:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:38 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 0x7f43801abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953930>, '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 0x2954830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2954cc0>, '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': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', '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 06:10:38 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 06:10:38 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 06:10:38 INFO - Using env: {'DISPLAY': ':0', 06:10:38 INFO - 'HOME': '/home/cltbld', 06:10:38 INFO - 'LANG': 'en_US.UTF-8', 06:10:38 INFO - 'LANGUAGE': 'en_US:en', 06:10:38 INFO - 'LOGNAME': 'cltbld', 06:10:38 INFO - 'MAIL': '/var/mail/cltbld', 06:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:38 INFO - 'MOZ_NO_REMOTE': '1', 06:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:38 INFO - 'NO_EM_RESTART': '1', 06:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:38 INFO - 'PWD': '/builds/slave/test', 06:10:38 INFO - 'SHELL': '/bin/bash', 06:10:38 INFO - 'SHLVL': '1', 06:10:38 INFO - 'TERM': 'linux', 06:10:38 INFO - 'TMOUT': '86400', 06:10:38 INFO - 'USER': 'cltbld', 06:10:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', 06:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:38 INFO - '_': '/tools/buildbot/bin/python'} 06:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:38 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)) 06:10:38 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)) 06:10:38 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)) 06:10:38 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)) 06:10:38 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)) 06:10:38 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)) 06:10:38 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)) 06:10:38 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)) 06:10:38 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)) 06:10:38 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)) 06:10:38 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)) 06:10:38 INFO - Cleaning up... 06:10:38 INFO - Return code: 0 06:10:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:10:38 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')]} 06:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:38 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')]} 06:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:38 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 0x7f43801abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953930>, '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 0x2954830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2954cc0>, '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': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', '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 06:10:38 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 06:10:38 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 06:10:38 INFO - Using env: {'DISPLAY': ':0', 06:10:38 INFO - 'HOME': '/home/cltbld', 06:10:38 INFO - 'LANG': 'en_US.UTF-8', 06:10:38 INFO - 'LANGUAGE': 'en_US:en', 06:10:38 INFO - 'LOGNAME': 'cltbld', 06:10:38 INFO - 'MAIL': '/var/mail/cltbld', 06:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:38 INFO - 'MOZ_NO_REMOTE': '1', 06:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:38 INFO - 'NO_EM_RESTART': '1', 06:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:38 INFO - 'PWD': '/builds/slave/test', 06:10:38 INFO - 'SHELL': '/bin/bash', 06:10:38 INFO - 'SHLVL': '1', 06:10:38 INFO - 'TERM': 'linux', 06:10:38 INFO - 'TMOUT': '86400', 06:10:38 INFO - 'USER': 'cltbld', 06:10:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', 06:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:38 INFO - '_': '/tools/buildbot/bin/python'} 06:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:10:38 INFO - Cleaning up... 06:10:38 INFO - Return code: 0 06:10:38 INFO - Running post-action listener: _resource_record_post_action 06:10:38 INFO - Running post-action listener: _start_resource_monitoring 06:10:38 INFO - Starting resource monitoring. 06:10:38 INFO - [mozharness: 2016-09-25 13:10:38.634872Z] Finished create-virtualenv step (success) 06:10:38 INFO - [mozharness: 2016-09-25 13:10:38.635327Z] Running install step. 06:10:38 INFO - Running pre-action listener: _resource_record_pre_action 06:10:38 INFO - Running main action method: install 06:10:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:38 INFO - Reading from file tmpfile_stdout 06:10:38 INFO - Detecting whether we're running mozinstall >=1.0... 06:10:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:10:39 INFO - Reading from file tmpfile_stdout 06:10:39 INFO - Output received: 06:10:39 INFO - Usage: mozinstall [options] installer 06:10:39 INFO - Options: 06:10:39 INFO - -h, --help show this help message and exit 06:10:39 INFO - -d DEST, --destination=DEST 06:10:39 INFO - Directory to install application into. [default: 06:10:39 INFO - "/builds/slave/test"] 06:10:39 INFO - --app=APP Application being installed. [default: firefox] 06:10:39 INFO - mkdir: /builds/slave/test/build/application 06:10:39 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'] 06:10:39 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 06:10:55 INFO - Reading from file tmpfile_stdout 06:10:55 INFO - Output received: 06:10:55 INFO - /builds/slave/test/build/application/firefox/firefox 06:10:55 INFO - Running post-action listener: _resource_record_post_action 06:10:55 INFO - [mozharness: 2016-09-25 13:10:55.983997Z] Finished install step (success) 06:10:55 INFO - [mozharness: 2016-09-25 13:10:55.984242Z] Running run-tests step. 06:10:55 INFO - Running pre-action listener: _resource_record_pre_action 06:10:55 INFO - Running main action method: run_tests 06:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:10:55 INFO - Python 2.7.3 06:10:55 INFO - Return code: 0 06:10:55 INFO - grabbing minidump binary from tooltool 06:10:55 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')]} 06:10:55 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 0x2953930>, '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 0x2954830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2954cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:10:55 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 06:10:55 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 06:10:55 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 06:10:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:10:56 INFO - Return code: 0 06:10:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:10:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:10:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:10:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:10:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 06:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 06:10:56 INFO - Using env: {'DISPLAY': ':0', 06:10:56 INFO - 'HOME': '/home/cltbld', 06:10:56 INFO - 'LANG': 'en_US.UTF-8', 06:10:56 INFO - 'LANGUAGE': 'en_US:en', 06:10:56 INFO - 'LOGNAME': 'cltbld', 06:10:56 INFO - 'MAIL': '/var/mail/cltbld', 06:10:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:10:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:56 INFO - 'MOZ_NO_REMOTE': '1', 06:10:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:56 INFO - 'NO_EM_RESTART': '1', 06:10:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:56 INFO - 'PWD': '/builds/slave/test', 06:10:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:10:56 INFO - 'SHELL': '/bin/bash', 06:10:56 INFO - 'SHLVL': '1', 06:10:56 INFO - 'TERM': 'linux', 06:10:56 INFO - 'TMOUT': '86400', 06:10:56 INFO - 'USER': 'cltbld', 06:10:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984', 06:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:56 INFO - '_': '/tools/buildbot/bin/python'} 06:10:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 06:10:56 INFO - mozversion application_buildid: 20160925030226 06:10:56 INFO - mozversion application_changeset: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 06:10:56 INFO - mozversion application_display_name: Nightly 06:10:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:10:56 INFO - mozversion application_name: Firefox 06:10:56 INFO - mozversion application_remotingname: firefox 06:10:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:10:56 INFO - mozversion application_vendor: Mozilla 06:10:56 INFO - mozversion application_version: 52.0a1 06:10:56 INFO - mozversion platform_buildid: 20160925030226 06:10:56 INFO - mozversion platform_changeset: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 06:10:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:10:56 INFO - mozversion platform_version: 52.0a1 06:10:56 INFO - using testdate: 1474809056 06:10:56 INFO - actual date: 1474809056 06:10:56 INFO - starting webserver on 'localhost:43108' 06:10:56 INFO - SUITE-START | Running 2 tests 06:10:56 INFO - TEST-START | dromaeo_css 06:10:56 INFO - operating with platform_type : linux_ 06:10:56 INFO - Initialising browser for dromaeo_css test... 06:10:56 INFO - TEST-INFO | started process 19656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDunoI8/profile http://localhost:43108/getInfo.html) 06:11:00 INFO - PROCESS | 19656 | __metrics Screen width/height:1600/1200 06:11:00 INFO - PROCESS | 19656 | colorDepth:24 06:11:00 INFO - PROCESS | 19656 | Browser inner width/height: 1024/697 06:11:00 INFO - PROCESS | 19656 | __metrics 06:11:01 INFO - PROCESS | 19656 | 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" 06:11:01 INFO - PROCESS | 19656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:11:02 INFO - PROCESS | 19656 | console.error: PushService: 06:11:02 INFO - PROCESS | 19656 | stateChangeProcessEnqueue: Error transitioning state 06:11:02 INFO - PROCESS | 19656 | UnknownError 06:11:02 INFO - TEST-INFO | 19656: exit 0 06:11:02 INFO - Browser initialized. 06:11:02 INFO - Running cycle 1/1 for dromaeo_css test... 06:11:02 INFO - TEST-INFO | started process 19737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDunoI8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:14 INFO - PROCESS | 19737 | RSS: Main: 173568000 06:11:14 INFO - PROCESS | 19737 | 06:12:06 INFO - PROCESS | 19737 | 1474809126362 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] 06:14:15 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:43108/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43108/tests/dromaeo/cssquery-ext.html) 06:14:16 INFO - PROCESS | 19737 | RSS: Main: 299266048 06:14:16 INFO - PROCESS | 19737 | 06:17:19 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:43108/tests/dromaeo/cssquery-ext.html (next: http://localhost:43108/tests/dromaeo/cssquery-jquery.html) 06:17:20 INFO - PROCESS | 19737 | RSS: Main: 270069760 06:17:20 INFO - PROCESS | 19737 | 06:20:22 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:43108/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43108/tests/dromaeo/cssquery-mootools.html) 06:20:22 INFO - PROCESS | 19737 | RSS: Main: 253911040 06:20:22 INFO - PROCESS | 19737 | 06:23:24 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:43108/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43108/tests/dromaeo/cssquery-prototype.html) 06:23:25 INFO - PROCESS | 19737 | RSS: Main: 252157952 06:23:25 INFO - PROCESS | 19737 | 06:26:27 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:43108/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43108/tests/dromaeo/cssquery-yui.html) 06:26:28 INFO - PROCESS | 19737 | RSS: Main: 216363008 06:26:28 INFO - PROCESS | 19737 | 06:29:31 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:43108/tests/dromaeo/cssquery-yui.html (next: http://localhost:43108/tests/dromaeo/cssquery-dojo.html) 06:29:31 INFO - PROCESS | 19737 | RSS: Main: 308899840 06:29:31 INFO - PROCESS | 19737 | 06:29:31 INFO - PROCESS | 19737 | __start_tp_report 06:29:31 INFO - PROCESS | 19737 | _x_x_mozilla_page_load 06:29:31 INFO - PROCESS | 19737 | _x_x_mozilla_page_load_details 06:29:31 INFO - PROCESS | 19737 | |i|pagename|runs| 06:29:31 INFO - PROCESS | 19737 | |0;dojo.html;2983.105068479456;3006.7594592432592;3013.457577636026;3042.771792115592;3052.496338104213;5193.480651934809;5200.453952335007;5233.110371236894;5240.764165612547;5272.604554658396;5279.340082489689;5308.840734777953;5323.148296272597;5346.866328341784;5371.677699338053;4770.403699537558;4785.2104402773675;4835.10550548148;4854.805807767702;4881;4856.514348565133;4919.704817710949;4923.113839508887;4929.778159982791;4983.451820299764;4761.833335833264;4764.190087685102;4843.007183527368;4906.730129842857;4925.753712314406;4791.856244312677;4855.635827312965;4863.708177509361;4876.02479504097;4939.333190019337;4821.903561928777;4822.7829747661435;4825.324454576362;4849.83025594106;4894.975525122387;5213.739313034371;5296.390915044781;5322.973385133049;5328.8401347959625;5347.358317001946;5628.887422251573;5638;5693.174489699012;5705.03014487534;5774.711264436762;5725.370209276976;5731.770729170828;5732.254806875079;5734.455226753452;5737.512311453532;5348.224507446398;5351.759170837322;5352.330958630171;5353.437889021675;5401.459854014567;5707.6575405475805;5764.394738552475;5770.105633626795;5783.132530120515;5813.069908814654;5488.69812160327;5567.47109024642;5567.638103523258;5634.7182640867795;5649.604527683023;5648.915266271009;5670.8015219467125;5672;5672.149177623307;5681.261436013292;5596.664200148004;5651.717414129277;5654.4062873398525;5656.095024796013;5656.6888821115235;5533.253010843485;5593.244911936918;5594.049011668027;5642.746076426571;5671.801486948019;4275.722078064916;4279.957200428018;4314.935275970863;4316.417283666728;4334.003179268723;3817.599152089046;3829.2532956073296;3831.099691572478;3874.321993651156;3875.5736868944396;5350.38470575881;5361.812336568201;5364.785408583613;5366.517013468729;5370.91943620846;5566.693831839207;5598.468145526169;5612.971935140298;5652.491275785199;5661.122526008476;5309.814156504581;5336.439673834191;5342.065138600729;5359.678419294854;5391.002664507078;4696.929546056812;4703.0593881223895;4704.670673052853;4705.85882423521;4758.500357462486;5810.738516766755;5849.853753656193;5873.236479257669;5876.6180198286975;5907.054871220584;5739.167820665896;5739.598228123991;5741.45456181662;5786.913196302143;5803.274590676166;5925.288965324189;5935.228420305332;5939.346671866005;5942.405759424023;5945.524358051432;5437.537809286255;5509.283793106871;5525.143602741581;5562.471565201299;5631.099024156116;5713.942860571341;5743.195952566561;5743.827685169452;5812.912806307993;5823.854403639943;5556.194351819045;5559.027170245272;5559.0827513461445;5560.388357280777;5561.944380556142;5482.698451585201;5533.723313834212;5600.103983362643;5614.2701448811395;5618.775248990158;5479.561635069264;5540.63985840919;5542.3903370630005;5554.416786237387;5615.915761263666;5554.111342185231;5604.775808967595;5646.661200327993;5647.830565083054;5652.265205523256;5411.944670789316;5437.265969094122;5466.508014278734;5529.336479622471;5538.889222215614 06:29:31 INFO - PROCESS | 19737 | |1;ext.html;558.0739497634142;590.8257064166071;605.2313561776543;612.1216054961129;617.3918690090258;31676.366472670532;43011.78494107529;43980.34029489556;44009.339859902124;44037.779811100896;44625.7768711156;44935.550644493545;44942;45032.77483612586;45072.09855802882;8148.185181481864;8363;8936.776580585489;9091.090890910922;9096.090390960917;10498.475076246195;10848.511816968215;10858.23992320538;11196.272242304265;11196.888031119706;11036.503357348938;11145.888541114608;11147.832782508269;11150.219484636078;11152.442377881114;8210.548419836907;8432.283255923254;10749.408782516959;10793.136549076095;10860.99999999996;10433.061024507755;10819.67540973772;10821.296615719953;10825.350478971286;10840.024397804236;42233;42376.36435453471;42550;42553.57446425558;42617.360739588934;2982.4482470742983;3078.153507785377;3164.17731389838;3182.9681703182905;3238.5951756030495;28712.712872871212;28898.855505722546;28902.277443064093;29158.708412916025;29356.26609334762;4353.673474489426;4397.802098905557;4443.777811109431;4478.57453541913;4496.168208881335;348010;348268.99999999744;348645;348945;349774;57562;57988;58047;58061;58073.4192658068;50674;50817;50848.23727644089;50903.23645145326;50938.74530627323;15829.68340633181;16273.349066037463;16296.674066518603;16330.428435004955;16382.098984555725;11200;11605.88394116065;11678.474468648932;11803.822942655866;12313;16486.917565412095;16877.578060548585;16880.915595421946;17420.386941958554;17610.91194544019;6082.414973636275;6117.877642447215;6249.687515624291;6267.780627678009;6283.632875151726;921.5438358012826;981.1464026297167;985.1970643925322;1079.2984560035882;1090.6291860767378;30976;31061.321815809708;31394;31518.36963260722;31959.680403196136;1029.3978022856713;1053.0943388685723;1054.984175237372;1119.356370087203;1123.859517560305;15894.68210635804;16544.338226471045;16666.916665416837;16704.74942875858;16980.32078716862;496957;723835;749321;750228;750777;56876.431235687116;57522.7123864378;57642;57685;57689.423105769245;1185.5731936502852;1212.9090318226167;1276.304414094321;1294.9417276222594;1306.5818937939957;27801.44397112006;31698.24791028411;33573;33760;33928.321433570694;51904.221436677726;52891;52912;52933.47066529439;52959;423881;425695;426073;426210;426883;25123.74876251287;25262;26104.477910441306;27159.592606110527;27565;37453.4381984265;48548.757256213496;51532;52774.73612632066;55282.72358638181;38213.42679859749;39261.607383925795;41526.37710434286;42137.36793948032;43206.351904720825;42067.57932420759;42267.5773242276;42736;43007.569924301606;43446.13107737891;41549.37675934924;42466.78766606271;43064.13871722611;43194;43439.56560434482;35648.4652730204;38194.866078093655;38531.6146838528;38841.21350087105;38950.80524597359;28219;28694;28862.855685722276;28986.710132899243;29112.708872911 06:29:31 INFO - PROCESS | 19737 | |2;jquery.html;384.3715525116435;386.77760287834485;394.4635295997443;401.2736946127511;401.7047470109469;14171.885595755712;15590.532284031497;17627.294908203672;19212.61574768504;19233.23067077317;18117.365892193775;18153.45539633813;18489;18496.630067398644;18584.628307433843;5521.365043020044;5595.160725891108;5615.9157612635845;5713.342965558952;5719.313682358123;4042.7574345539215;4279.593438623326;5627.577931655122;5707.942920570783;5712.657525481509;5819.67991760453;6144.8463788405425;6159.568830181889;6169.845753856144;6270.184875966118;5992.370801065891;6220;6236.345183755709;6255.749770009194;6283.748650053993;5468.179773034037;5566.777328906839;5572.888542229132;5581.748821303051;5617.01702202113;21595.352139435843;22492.77507224923;22528.3816817552;22561;22731.204407845646;2290.1068583252545;2349.5884732657046;2356.29311206639;2419.6733440985417;2818.4363127374404;13491.932540337333;14346.856531434762;14640.926795366062;14843.777343339858;15290.159041252728;1857.674906891302;1906.74258975038;1937.883726976386;1965.665836807746;2010.883959402531;79840.20159798386;79844;80331;81831.18168818354;82184.58907705483;10509.737256568495;10591.981285333643;10647.094996925192;10648.893511064945;10948.616798412017;13193.340332983504;15190.620234494227;15194.772078418833;15206.771898421532;15243.466478673194;6926.341997510229;7113.75101871432;7168.354848063699;7329.853402932018;7334.743283985035;6893.551919125241;7008.474364422688;7158.642067896689;7490.550566966;7539.246075392417;6077.118817771398;6083.513318934474;6127.754889804358;6213.545649468525;6250.6874656267;1904.2192700992528;1935.4193741877662;1938.3215874444113;1965.7837637859825;1972.3984184823767;833.4999000599713;962.4369743699874;1025.7230547752065;1039.26212389203;1051.726551096705;19315.4205373839;19758.506037348892;19886.70169947452;20045.899770501055;20177.59644807125;939.7838497145558;971.723058928202;981.3228872078244;993.1657407777501;1022.2486472442748;10521.684349469528;11116.141840019529;11117.444127793578;11244.887551124548;11288.492017859217;445341;447863;473109;473588;484874;88296.558517207;89474.55262723645;89511.55244223737;90547;91054.54472727726;998.7465730508166;999.645125980281;1011.2769369900557;1011.595361855249;1013.0730381700808;16766.748498772773;17306.134693265034;17865.553361165556;17878.5530361742;18048.819511804715;39518.802405987786;40858.182836342516;40922.79538602288;41314;42761.786191068844;52696;53738.193927090346;56197.15704264521;57149.428505716074;57627.42372576221;7169.605671688108;7190.5326153801925;7225.205227424874;7307.67115479794;7381.778546643609;9428.528573571431;11725.296482211095;11910.880891190976;12033.75932481328;12330.81503777462;10633;10769.084627806724;10791.6222932197;10829.67510974672;11197.216194866282;10437.21720870953;10485.16118710486;10814.134869210287;10882;11374.658760237206;10400.271980961563;10577.206709496664;10781.676549703521;10871.782564348827;11040.889591103985;7183.928160718535;7309.232530584212;7339.486235963432;7395.963020184865;7496.062992125984;10327.793444130924;10575.841362379417;10619.36283822973;11075.889241107809;11554.248973816675 06:29:31 INFO - PROCESS | 19737 | |3;mootools.html;1327.3495986966389;1366.658335416146;1434.0033676594771;1435.0815478094019;1657.850793428592;7736.65185066672;8437.282830959368;8838.77903052424;8846.734597962064;9048;8834.293256539477;8905.287576993842;8912.777180570489;8914.687985920495;8928.553572321374;2044.2947183221765;2065.0603975191325;2068.803463670949;2070.130545171032;2071.2129390831537;2014.8287395571394;2021.4542073640182;2038.4394291569788;2121.596896589643;2131.05168200151;2048.795120487947;2054.6917962305697;2055.814976652101;2064.4735592423986;2077.40793873746;1998.9100490477963;2022.0496366707623;2024.6861736430803;2028.188724510193;2030.7664618568906;1938.2247101159508;1957.4323446200726;2001.6997450382414;2020.6564883969613;2023.5548179400507;8274.213949674771;8509.191626795444;8666.090060543615;8667.609957551926;8670.263027642657;5038;5180.844574662766;5235.921461178085;5236.633435659505;5239.502247286502;3177.523371494271;3291.8189499577516;3332.3335332933266;3348.3470723208984;3361.1765117546356;1110.8278216876397;1114.5318966034285;1120.548353449567;1132.318507017079;1140.931544107356;12052.819207711891;12194.634160975185;12266.632001039983;12270.32513211773;12285.385730713519;4312.741235525878;4382.517923028464;4466.642668586505;4467.530909254547;4555.407796986437;9851.359661621971;9852.16256618181;9866.0267946411;9867;9869.950650246703;5209.609279304067;5237.450067742909;5244.370675518886;5245.659032162897;5250.921236181461;4050.311447054008;4333.1766964276685;4366.672499562545;4828.565429111397;4828.879278018007;3902.3366027775346;4063.7358571692744;4071.633552980246;4119.7940102994735;4131.091159944807;1316.5392112760649;1325.5543522201522;1328.5881376773038;1340.6246251049722;1349.7233067221196;673.9561928474634;756.2173150789017;818.29217726666;819.700809204648;902.3638334973828;5433.347998240158;5691.459311365414;5776.537876969833;5778.133280007948;5819.563532735062;389.8421139438532;400.969927255457;401.9758814471141;406.0093372171891;413.31389892777844;3749.362608356586;3764.981175094107;3779.3197224499304;3780.4140358244517;3794.354959656865;10854.891451085547;11228.101751859831;11286.774264514665;11317.660470185907;11334;11165.655212405485;11245.550177992789;11253.268537545033;11263.04264137541;11272.041876440595;7686.692532298645;8257.876131858027;8315.168483151636;8331.29184019353;8334.249917507332;5572.526335261548;5580.665160090408;5608.803691870765;5670.9432905672065;5960.254968128984;10008.449535275338;10043.443266293736;10256;10295.53670084863;10298.124659404035;10348.172146228435;10409.843852342372;10480.63317783874;10507.369557826554;10593.205509586658;7287.198408174991;7394.2975417335265;7398;7399.556026638419;7401.444891633257;8269.793255168668;8307;8314.127016663164;8371.41400101987;8445.324374049938;7083.539569927938;7254.5647261164495;7257.709691612487;7308.8903666443985;7354.6322683866665;7264.055672762507;7369.889451658337;7421.0723659542555;7548.509346892434;7824.530528168328;6405.231372235362;6450.161479007699;6485.448736857231;6500.6424646643;6599.571027883172;4987.925181122214;5036.84889453317;5050.090983622837;5089.694618322913;5345.572354211731;4964.776585053609;4987.476314986874;5051.520105589963;5140.074786538459;5231.189165679326 06:29:31 INFO - PROCESS | 19737 | |4;prototype.html;304.6983486348516;312.0809216856358;317.8474332320486;318.2473450290064;323.3597476995547;5023.623228257886;5144.408393034802;5172.224166375041;5260;5268.182477045418;4985.351904252442;5077.5176358246;5086.262491938666;5106.540411362977;5145.665531740444;4045.5145382553987;4048.7165898387125;4057.8985525361954;4066.2883995300776;4066.471358723362;3926.646601805837;4053.500204924182;4078.4290199372113;4080.6531444827224;4087.305158123126;4006.298897692907;4008.118213992917;4013.3377992631326;4032.717709760318;4040.5555388907196;3999.200159967989;4006.238814625212;4010.375797801895;4011.4785077939973;4025.29557327468;3522.20750331176;3523.0487768302414;3537.221811201557;3556.1820781220204;3572.4462708280257;4811.855644330676;5008.924866127011;5011.198208286693;5015.843187429404;5025.195968644999;4586.1515619610145;4606.286025665993;4610.395126753374;4622.237330840408;4645.814167433298;5349.331333583302;5361.640878013701;5367.872746723154;5384.300040994684;5405.675659460445;3736.57029441615;3947.7631342119275;3958.3270843956598;3978.204359128186;3987.5613682494904;5638.351589567212;5675.602707810455;5684.914726279109;5696.145578163268;5705.800296989585;4070.3487442009136;4071.898202544901;4085.101277718897;4086.877393678135;4088.0801819590356;3900.278448486982;4068.8372465101656;4076.9592304077173;4119.8352065917625;4130.297849365615;4614.700044497097;4615.7076018714815;4617.538246175355;4624.190766615829;4632.305154226893;5421.810236641778;5429.239906413105;5432.29380180574;5483.588730845203;5520.751566179531;1324.3973991833693;1346.3604787725947;1395.2814300635182;1397.182648150843;1407.268220525321;893.2853717026483;906.0667512462174;919.3610440743619;933.4352716606492;938.5307346326837;4601.032334144525;4657.790399432034;4676.766161691902;4679.789409476582;4704.341392205026;4899.902001960012;4906.779194936236;4927.644897653103;4931.432885218246;4959.049365627446;4483.977580112144;4636.09919932826;4653.976730116327;4678.058605678673;4690.437147542249;2594.0920677762633;2600.4409052053898;2604.632567901867;2617.5472612699755;2628.921132366032;5049.772760225798;5059.747012649353;5076.411030374462;5080.3996741027195;5128.615353848401;4906;4925.783397471152;4950.232713929347;4987;5341.893162136736;5798.507126894261;5799.462327979844;5806.82579522615;5811.593188476766;5831.999999999915;5599.552035837041;5610.691411972381;5616.539699678031;5646.2942132233475;5647.1529270609735;5411.404745478073;5517.668939863621;5527.231285988445;5559.63862348946;5562.582806289463;5726.284214473191;5763.740631671669;5776.884462310814;5777.566682498746;5778.971105144447;3973.2252210818615;3974.960250397575;3978.3037968356;4016.9598304017754;4022.727159155068;5308.150695888639;5362.463753624606;5606.831795046155;5619.9206293671605;5667.433256674464;5301.1783173608155;5353.304070470814;5427.421974562051;5451.618386712892;5459.7342103026795;5442.727863606883;5450.2369668247275;5455.809046683347;5482.862928426821;5509.449055094458;5287.68273903567;5349.224362467343;5357.276767636319;5371.677699338053;5417.458254174551;5449.373322068013;5449.591280654046;5458.399576046552;5469.917951230815;5482.5613950884635;5338.225957236256;5363.785448582169;5366.195070739421;5398.730063496888;5427.918581221364 06:29:31 INFO - PROCESS | 19737 | |5;yui.html;640.356441776015;727.0766127018686;736.8305289783348;743.2678811370799;774.3727580659667;15976.920115399422;16901.239444225008;17141.82858171418;17144.914275428622;17184.398546050892;14416.711665766677;14516.854831451683;14528.927355363236;14538.709225815477;14541.92729036356;764.094547960667;783.0759703549809;784.1531146361915;784.4391260248921;784.525362155896;776.3750181104209;779.3881802784815;780.9648565814524;785.0932173339802;786.2098590916149;836.602613758466;836.7196989008689;838.4089217101929;838.7316058861136;839.3495041342977;825.2861274997144;829.7054545636272;831.6382373667444;832.1137988042746;832.7543374704477;590.1383979390096;596.2368168744015;596.6539407143846;598.6976576828673;599.1043390131738;14799.778003329959;14857.851421485755;14956.177410242432;15062.774058389134;15071.246437678183;12388.504459821595;12738.299393533352;12781.616551503377;13140.332925703182;13393;10387.948060259725;10584.470776461147;10657.78684426315;10723.410212438313;10994.34033957965;3653.5798383186007;3662.670359667616;3832.8275227614545;3908.2965066288057;3916.8629097981434;82444;82485.58757206236;83013.58493207555;84102.57948710218;86829.37071327158;9547.713568592953;9741.220702343795;9790.510474476248;9890.357126786736;10339.483025848827;21082.78917210808;21083.472913177295;21085.472863178544;21105.577888442145;21113.472163195736;8499.40504164715;8688.6524539019;8774.736757897273;8845.380823342433;9043.140901614335;4437.800298986554;4502.16709908668;4626.583607475343;4627.329037289574;4671.48613652498;3591.892243232655;3716.9814150929074;3729.9627003729615;3734.589195188527;3751.437284407306;578.0462237308475;582.7290310005783;584.9970750146307;599.4455129005652;606.4663096475161;619.1089005599783;622.2346513788066;713.6503113474464;722.0865605009667;731.7292601737284;9107.22588579965;9715.61137554504;9827.164691001344;9964.20286377088;9973.252006099572;591.899377105893;648.8961766117399;680.9795706128824;681.5127184063319;715.5349023135004;4152.584741525884;4307.892302692395;4677.95322046782;4681.81272749093;4777.8327758528285;126513.73486265204;128740;128861;132534;132625;105850;108766.64933402576;109597.45201273942;113019.43490282496;113644.43177784058;74300.62849685717;74315;74329.6283518579;93242.53378733063;97505.53741693881;9116.453012819253;9270.814583708423;9375.203107735646;9424.57589408492;9619.615215391306;51157.7442112787;51439.742801285756;52118.739406304245;53013.46986530085;54091;68500.6574967122;72305;75936.24063759291;76367.61816190883;76579.61710191413;11068.501917413574;11226.831597526207;11266.211365204357;11321.150913681671;11374.146938979444;14347.713045739236;14413.927930360282;14696.11823290606;14751.631209219855;14765.852341476448;12590.685232869251;12749.81430615313;13094.934525327693;13500.257485838372;13568.796468053184;12928.870711292766;13077.607671769862;13534.390952407362;13623;13960.860391395956;12997.870021299666;13592.45630174782;13664.590062298146;13833.334166445698;14055.086419382707;10161.339512931636;10657.840132398176;10668.1998850085;10709.518071686636;10806.189535785004;9035.638574456949;9907.207423406255;10871.67384978452;10911.781764364827;11135.72160695989 06:29:31 INFO - PROCESS | 19737 | __end_tp_report 06:29:31 INFO - PROCESS | 19737 | __start_cc_report 06:29:31 INFO - PROCESS | 19737 | _x_x_mozilla_cycle_collect,957 06:29:31 INFO - PROCESS | 19737 | __end_cc_report 06:29:31 INFO - PROCESS | 19737 | __startTimestamp1474810171506__endTimestamp 06:29:31 INFO - PROCESS | 19737 | 06:29:31 INFO - PROCESS | 19737 | ------- Summary: start ------- 06:29:31 INFO - PROCESS | 19737 | Number of tests: 6 06:29:31 INFO - PROCESS | 19737 | 06:29:31 INFO - PROCESS | 19737 | [#0] dojo.html Cycles:165 Average:5274.31 Median:5509.28 stddev:612.33 (11.1%) stddev-sans-first:587.24 06:29:31 INFO - PROCESS | 19737 | Values: 2983.1 3006.8 3013.5 3042.8 3052.5 5193.5 5200.5 5233.1 5240.8 5272.6 5279.3 5308.8 5323.1 5346.9 5371.7 4770.4 4785.2 4835.1 4854.8 4881.0 4856.5 4919.7 4923.1 4929.8 4983.5 4761.8 4764.2 4843.0 4906.7 4925.8 4791.9 4855.6 4863.7 4876.0 4939.3 4821.9 4822.8 4825.3 4849.8 4895.0 5213.7 5296.4 5323.0 5328.8 5347.4 5628.9 5638.0 5693.2 5705.0 5774.7 5725.4 5731.8 5732.3 5734.5 5737.5 5348.2 5351.8 5352.3 5353.4 5401.5 5707.7 5764.4 5770.1 5783.1 5813.1 5488.7 5567.5 5567.6 5634.7 5649.6 5648.9 5670.8 5672.0 5672.1 5681.3 5596.7 5651.7 5654.4 5656.1 5656.7 5533.3 5593.2 5594.0 5642.7 5671.8 4275.7 4280.0 4314.9 4316.4 4334.0 3817.6 3829.3 3831.1 3874.3 3875.6 5350.4 5361.8 5364.8 5366.5 5370.9 5566.7 5598.5 5613.0 5652.5 5661.1 5309.8 5336.4 5342.1 5359.7 5391.0 4696.9 4703.1 4704.7 4705.9 4758.5 5810.7 5849.9 5873.2 5876.6 5907.1 5739.2 5739.6 5741.5 5786.9 5803.3 5925.3 5935.2 5939.3 5942.4 5945.5 5437.5 5509.3 5525.1 5562.5 5631.1 5713.9 5743.2 5743.8 5812.9 5823.9 5556.2 5559.0 5559.1 5560.4 5561.9 5482.7 5533.7 5600.1 5614.3 5618.8 5479.6 5540.6 5542.4 5554.4 5615.9 5554.1 5604.8 5646.7 5647.8 5652.3 5411.9 5437.3 5466.5 5529.3 5538.9 06:29:31 INFO - PROCESS | 19737 | 06:29:31 INFO - PROCESS | 19737 | [#1] ext.html Cycles:180 Average:64112.04 Median:38686.41 stddev:137763.40 (356.1%) stddev-sans-first:138067.22 06:29:31 INFO - PROCESS | 19737 | Values: 558.1 590.8 605.2 612.1 617.4 31676.4 43011.8 43980.3 44009.3 44037.8 44625.8 44935.6 44942.0 45032.8 45072.1 8148.2 8363.0 8936.8 9091.1 9096.1 10498.5 10848.5 10858.2 11196.3 11196.9 11036.5 11145.9 11147.8 11150.2 11152.4 8210.5 8432.3 10749.4 10793.1 10861.0 10433.1 10819.7 10821.3 10825.4 10840.0 42233.0 42376.4 42550.0 42553.6 42617.4 2982.4 3078.2 3164.2 3183.0 3238.6 28712.7 28898.9 28902.3 29158.7 29356.3 4353.7 4397.8 4443.8 4478.6 4496.2 348010.0 348269.0 348645.0 348945.0 349774.0 57562.0 57988.0 58047.0 58061.0 58073.4 50674.0 50817.0 50848.2 50903.2 50938.7 15829.7 16273.3 16296.7 16330.4 16382.1 11200.0 11605.9 11678.5 11803.8 12313.0 16486.9 16877.6 16880.9 17420.4 17610.9 6082.4 6117.9 6249.7 6267.8 6283.6 921.5 981.1 985.2 1079.3 1090.6 30976.0 31061.3 31394.0 31518.4 31959.7 1029.4 1053.1 1055.0 1119.4 1123.9 15894.7 16544.3 16666.9 16704.7 16980.3 496957.0 723835.0 749321.0 750228.0 750777.0 56876.4 57522.7 57642.0 57685.0 57689.4 1185.6 1212.9 1276.3 1294.9 1306.6 27801.4 31698.2 33573.0 33760.0 33928.3 51904.2 52891.0 52912.0 52933.5 52959.0 423881.0 425695.0 426073.0 426210.0 426883.0 25123.7 25262.0 26104.5 27159.6 27565.0 37453.4 48548.8 51532.0 52774.7 55282.7 38213.4 39261.6 41526.4 42137.4 43206.4 42067.6 42267.6 42736.0 43007.6 43446.1 41549.4 42466.8 43064.1 43194.0 43439.6 35648.5 38194.9 38531.6 38841.2 38950.8 28219.0 28694.0 28862.9 28986.7 29112.7 06:29:31 INFO - PROCESS | 19737 | 06:29:31 INFO - PROCESS | 19737 | [#2] jquery.html Cycles:180 Average:27960.66 Median:1601.40 stddev:76804.17 (4796.1%) stddev-sans-first:76991.71 06:29:31 INFO - PROCESS | 19737 | Values: 384.4 386.8 394.5 401.3 401.7 14171.9 15590.5 17627.3 19212.6 19233.2 18117.4 18153.5 18489.0 18496.6 18584.6 5521.4 5595.2 5615.9 5713.3 5719.3 4042.8 4279.6 5627.6 5707.9 5712.7 5819.7 6144.8 6159.6 6169.8 6270.2 5992.4 6220.0 6236.3 6255.7 6283.7 5468.2 5566.8 5572.9 5581.7 5617.0 21595.4 22492.8 22528.4 22561.0 22731.2 2290.1 2349.6 2356.3 2419.7 2818.4 13491.9 14346.9 14640.9 14843.8 15290.2 1857.7 1906.7 1937.9 1965.7 2010.9 79840.2 79844.0 80331.0 81831.2 82184.6 10509.7 10592.0 10647.1 10648.9 10948.6 13193.3 15190.6 15194.8 15206.8 15243.5 6926.3 7113.8 7168.4 7329.9 7334.7 6893.6 7008.5 7158.6 7490.6 7539.2 6077.1 6083.5 6127.8 6213.5 6250.7 1904.2 1935.4 1938.3 1965.8 1972.4 833.5 962.4 1025.7 1039.3 1051.7 19315.4 19758.5 19886.7 20045.9 20177.6 939.8 971.7 981.3 993.2 1022.2 10521.7 11116.1 11117.4 11244.9 11288.5 445341.0 447863.0 473109.0 473588.0 484874.0 88296.6 89474.6 89511.6 90547.0 91054.5 998.7 999.6 1011.3 1011.6 1013.1 16766.7 17306.1 17865.6 17878.6 18048.8 39518.8 40858.2 40922.8 41314.0 42761.8 52696.0 53738.2 56197.2 57149.4 57627.4 7169.6 7190.5 7225.2 7307.7 7381.8 9428.5 11725.3 11910.9 12033.8 12330.8 10633.0 10769.1 10791.6 10829.7 11197.2 10437.2 10485.2 10814.1 10882.0 11374.7 10400.3 10577.2 10781.7 10871.8 11040.9 7183.9 7309.2 7339.5 7396.0 7496.1 10327.8 10575.8 10619.4 11075.9 11554.2 06:29:31 INFO - PROCESS | 19737 | 06:29:31 INFO - PROCESS | 19737 | [#3] mootools.html Cycles:180 Average:5657.25 Median:4467.09 stddev:3370.54 (75.5%) stddev-sans-first:3364.29 06:29:31 INFO - PROCESS | 19737 | Values: 1327.3 1366.7 1434.0 1435.1 1657.9 7736.7 8437.3 8838.8 8846.7 9048.0 8834.3 8905.3 8912.8 8914.7 8928.6 2044.3 2065.1 2068.8 2070.1 2071.2 2014.8 2021.5 2038.4 2121.6 2131.1 2048.8 2054.7 2055.8 2064.5 2077.4 1998.9 2022.0 2024.7 2028.2 2030.8 1938.2 1957.4 2001.7 2020.7 2023.6 8274.2 8509.2 8666.1 8667.6 8670.3 5038.0 5180.8 5235.9 5236.6 5239.5 3177.5 3291.8 3332.3 3348.3 3361.2 1110.8 1114.5 1120.5 1132.3 1140.9 12052.8 12194.6 12266.6 12270.3 12285.4 4312.7 4382.5 4466.6 4467.5 4555.4 9851.4 9852.2 9866.0 9867.0 9870.0 5209.6 5237.5 5244.4 5245.7 5250.9 4050.3 4333.2 4366.7 4828.6 4828.9 3902.3 4063.7 4071.6 4119.8 4131.1 1316.5 1325.6 1328.6 1340.6 1349.7 674.0 756.2 818.3 819.7 902.4 5433.3 5691.5 5776.5 5778.1 5819.6 389.8 401.0 402.0 406.0 413.3 3749.4 3765.0 3779.3 3780.4 3794.4 10854.9 11228.1 11286.8 11317.7 11334.0 11165.7 11245.6 11253.3 11263.0 11272.0 7686.7 8257.9 8315.2 8331.3 8334.2 5572.5 5580.7 5608.8 5670.9 5960.3 10008.4 10043.4 10256.0 10295.5 10298.1 10348.2 10409.8 10480.6 10507.4 10593.2 7287.2 7394.3 7398.0 7399.6 7401.4 8269.8 8307.0 8314.1 8371.4 8445.3 7083.5 7254.6 7257.7 7308.9 7354.6 7264.1 7369.9 7421.1 7548.5 7824.5 6405.2 6450.2 6485.4 6500.6 6599.6 4987.9 5036.8 5050.1 5089.7 5345.6 4964.8 4987.5 5051.5 5140.1 5231.2 06:29:31 INFO - PROCESS | 19737 | 06:29:31 INFO - PROCESS | 19737 | [#4] prototype.html Cycles:180 Average:4486.99 Median:4997.96 stddev:1319.23 (26.4%) stddev-sans-first:1285.04 06:29:31 INFO - PROCESS | 19737 | Values: 304.7 312.1 317.8 318.2 323.4 5023.6 5144.4 5172.2 5260.0 5268.2 4985.4 5077.5 5086.3 5106.5 5145.7 4045.5 4048.7 4057.9 4066.3 4066.5 3926.6 4053.5 4078.4 4080.7 4087.3 4006.3 4008.1 4013.3 4032.7 4040.6 3999.2 4006.2 4010.4 4011.5 4025.3 3522.2 3523.0 3537.2 3556.2 3572.4 4811.9 5008.9 5011.2 5015.8 5025.2 4586.2 4606.3 4610.4 4622.2 4645.8 5349.3 5361.6 5367.9 5384.3 5405.7 3736.6 3947.8 3958.3 3978.2 3987.6 5638.4 5675.6 5684.9 5696.1 5705.8 4070.3 4071.9 4085.1 4086.9 4088.1 3900.3 4068.8 4077.0 4119.8 4130.3 4614.7 4615.7 4617.5 4624.2 4632.3 5421.8 5429.2 5432.3 5483.6 5520.8 1324.4 1346.4 1395.3 1397.2 1407.3 893.3 906.1 919.4 933.4 938.5 4601.0 4657.8 4676.8 4679.8 4704.3 4899.9 4906.8 4927.6 4931.4 4959.0 4484.0 4636.1 4654.0 4678.1 4690.4 2594.1 2600.4 2604.6 2617.5 2628.9 5049.8 5059.7 5076.4 5080.4 5128.6 4906.0 4925.8 4950.2 4987.0 5341.9 5798.5 5799.5 5806.8 5811.6 5832.0 5599.6 5610.7 5616.5 5646.3 5647.2 5411.4 5517.7 5527.2 5559.6 5562.6 5726.3 5763.7 5776.9 5777.6 5779.0 3973.2 3975.0 3978.3 4017.0 4022.7 5308.2 5362.5 5606.8 5619.9 5667.4 5301.2 5353.3 5427.4 5451.6 5459.7 5442.7 5450.2 5455.8 5482.9 5509.4 5287.7 5349.2 5357.3 5371.7 5417.5 5449.4 5449.6 5458.4 5469.9 5482.6 5338.2 5363.8 5366.2 5398.7 5427.9 06:29:31 INFO - PROCESS | 19737 | 06:29:31 INFO - PROCESS | 19737 | [#5] yui.html Cycles:180 Average:21433.05 Median:4674.72 stddev:32427.35 (693.7%) stddev-sans-first:32480.74 06:29:31 INFO - PROCESS | 19737 | Values: 640.4 727.1 736.8 743.3 774.4 15976.9 16901.2 17141.8 17144.9 17184.4 14416.7 14516.9 14528.9 14538.7 14541.9 764.1 783.1 784.2 784.4 784.5 776.4 779.4 781.0 785.1 786.2 836.6 836.7 838.4 838.7 839.3 825.3 829.7 831.6 832.1 832.8 590.1 596.2 596.7 598.7 599.1 14799.8 14857.9 14956.2 15062.8 15071.2 12388.5 12738.3 12781.6 13140.3 13393.0 10387.9 10584.5 10657.8 10723.4 10994.3 3653.6 3662.7 3832.8 3908.3 3916.9 82444.0 82485.6 83013.6 84102.6 86829.4 9547.7 9741.2 9790.5 9890.4 10339.5 21082.8 21083.5 21085.5 21105.6 21113.5 8499.4 8688.7 8774.7 8845.4 9043.1 4437.8 4502.2 4626.6 4627.3 4671.5 3591.9 3717.0 3730.0 3734.6 3751.4 578.0 582.7 585.0 599.4 606.5 619.1 622.2 713.7 722.1 731.7 9107.2 9715.6 9827.2 9964.2 9973.3 591.9 648.9 681.0 681.5 715.5 4152.6 4307.9 4678.0 4681.8 4777.8 126513.7 128740.0 128861.0 132534.0 132625.0 105850.0 108766.6 109597.5 113019.4 113644.4 74300.6 74315.0 74329.6 93242.5 97505.5 9116.5 9270.8 9375.2 9424.6 9619.6 51157.7 51439.7 52118.7 53013.5 54091.0 68500.7 72305.0 75936.2 76367.6 76579.6 11068.5 11226.8 11266.2 11321.2 11374.1 14347.7 14413.9 14696.1 14751.6 14765.9 12590.7 12749.8 13094.9 13500.3 13568.8 12928.9 13077.6 13534.4 13623.0 13960.9 12997.9 13592.5 13664.6 13833.3 14055.1 10161.3 10657.8 10668.2 10709.5 10806.2 9035.6 9907.2 10871.7 10911.8 11135.7 06:29:31 INFO - PROCESS | 19737 | -------- Summary: end -------- 06:29:31 INFO - PROCESS | 19737 | 06:29:32 INFO - TEST-INFO | 19737: exit 0 06:29:32 INFO - TEST-OK | dromaeo_css | took 1116207ms 06:29:32 INFO - TEST-START | kraken 06:29:32 INFO - operating with platform_type : linux_ 06:29:32 INFO - Initialising browser for kraken test... 06:29:32 INFO - TEST-INFO | started process 20045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp940KWp/profile http://localhost:43108/getInfo.html) 06:29:36 INFO - PROCESS | 20045 | __metrics Screen width/height:1600/1200 06:29:36 INFO - PROCESS | 20045 | colorDepth:24 06:29:36 INFO - PROCESS | 20045 | Browser inner width/height: 1024/697 06:29:36 INFO - PROCESS | 20045 | __metrics 06:29:37 INFO - PROCESS | 20045 | 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" 06:29:37 INFO - PROCESS | 20045 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:29:38 INFO - PROCESS | 20045 | console.error: PushService: 06:29:38 INFO - PROCESS | 20045 | stateChangeProcessEnqueue: Error transitioning state 06:29:38 INFO - PROCESS | 20045 | UnknownError 06:29:38 INFO - TEST-INFO | 20045: exit 0 06:29:38 INFO - Browser initialized. 06:29:38 INFO - Running cycle 1/1 for kraken test... 06:29:38 INFO - TEST-INFO | started process 20127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp940KWp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:29:50 INFO - PROCESS | 20127 | RSS: Main: 174067712 06:29:50 INFO - PROCESS | 20127 | 06:29:53 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43108/tests/kraken/driver.html?testName=audio-beat-detection) 06:29:54 INFO - PROCESS | 20127 | RSS: Main: 232906752 06:29:54 INFO - PROCESS | 20127 | 06:29:56 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43108/tests/kraken/driver.html?testName=audio-dft) 06:29:57 INFO - PROCESS | 20127 | RSS: Main: 217772032 06:29:57 INFO - PROCESS | 20127 | 06:30:00 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43108/tests/kraken/driver.html?testName=audio-fft) 06:30:01 INFO - PROCESS | 20127 | RSS: Main: 298700800 06:30:01 INFO - PROCESS | 20127 | 06:30:03 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43108/tests/kraken/driver.html?testName=audio-oscillator) 06:30:03 INFO - PROCESS | 20127 | RSS: Main: 208404480 06:30:03 INFO - PROCESS | 20127 | 06:30:06 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43108/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:30:06 INFO - PROCESS | 20127 | RSS: Main: 212594688 06:30:06 INFO - PROCESS | 20127 | 06:30:09 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43108/tests/kraken/driver.html?testName=imaging-darkroom) 06:30:10 INFO - PROCESS | 20127 | RSS: Main: 249798656 06:30:10 INFO - PROCESS | 20127 | 06:30:13 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43108/tests/kraken/driver.html?testName=imaging-desaturate) 06:30:14 INFO - PROCESS | 20127 | RSS: Main: 248356864 06:30:14 INFO - PROCESS | 20127 | 06:30:17 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43108/tests/kraken/driver.html?testName=json-parse-financial) 06:30:17 INFO - PROCESS | 20127 | RSS: Main: 248401920 06:30:17 INFO - PROCESS | 20127 | 06:30:19 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43108/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:30:19 INFO - PROCESS | 20127 | RSS: Main: 210767872 06:30:19 INFO - PROCESS | 20127 | 06:30:21 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43108/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:30:22 INFO - PROCESS | 20127 | RSS: Main: 217468928 06:30:22 INFO - PROCESS | 20127 | 06:30:24 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43108/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:30:24 INFO - PROCESS | 20127 | RSS: Main: 222334976 06:30:24 INFO - PROCESS | 20127 | 06:30:27 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:30:27 INFO - PROCESS | 20127 | RSS: Main: 224202752 06:30:27 INFO - PROCESS | 20127 | 06:30:30 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:30:31 INFO - PROCESS | 20127 | RSS: Main: 221483008 06:30:31 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | Cycle 1(1): loaded http://localhost:43108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43108/tests/kraken/driver.html?testName=ai-astar) 06:30:33 INFO - PROCESS | 20127 | RSS: Main: 272846848 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | __start_tp_report 06:30:33 INFO - PROCESS | 20127 | _x_x_mozilla_page_load 06:30:33 INFO - PROCESS | 20127 | _x_x_mozilla_page_load_details 06:30:33 INFO - PROCESS | 20127 | |i|pagename|runs| 06:30:33 INFO - PROCESS | 20127 | |0;ai-astar;112;113;112;110;112;112;112;112;111;112 06:30:33 INFO - PROCESS | 20127 | |1;audio-beat-detection;142;118;121;154;123;119;121;117;156;123 06:30:33 INFO - PROCESS | 20127 | |2;audio-dft;159;159;160;161;160;160;161;161;162;162 06:30:33 INFO - PROCESS | 20127 | |3;audio-fft;75;74;73;107;76;76;74;76;98;75 06:30:33 INFO - PROCESS | 20127 | |4;audio-oscillator;84;82;115;84;83;83;103;82;83;116 06:30:33 INFO - PROCESS | 20127 | |5;imaging-gaussian-blur;118;117;117;117;118;117;117;118;118;117 06:30:33 INFO - PROCESS | 20127 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;145 06:30:33 INFO - PROCESS | 20127 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;94 06:30:33 INFO - PROCESS | 20127 | |8;json-parse-financial;52;52;51;49;51;51;52;52;52;51 06:30:33 INFO - PROCESS | 20127 | |9;json-stringify-tinderbox;61;60;59;60;60;61;60;61;60;61 06:30:33 INFO - PROCESS | 20127 | |10;stanford-crypto-aes;79;79;78;79;83;84;79;78;78;78 06:30:33 INFO - PROCESS | 20127 | |11;stanford-crypto-ccm;126;124;124;130;121;122;138;124;170;133 06:30:33 INFO - PROCESS | 20127 | |12;stanford-crypto-pbkdf2;169;166;167;165;166;168;167;170;165;169 06:30:33 INFO - PROCESS | 20127 | |13;stanford-crypto-sha256-iterative;66;67;67;66;66;66;66;67;64;64 06:30:33 INFO - PROCESS | 20127 | __end_tp_report 06:30:33 INFO - PROCESS | 20127 | __start_cc_report 06:30:33 INFO - PROCESS | 20127 | _x_x_mozilla_cycle_collect,1679 06:30:33 INFO - PROCESS | 20127 | __end_cc_report 06:30:33 INFO - PROCESS | 20127 | __startTimestamp1474810233316__endTimestamp 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | ------- Summary: start ------- 06:30:33 INFO - PROCESS | 20127 | Number of tests: 14 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 06:30:33 INFO - PROCESS | 20127 | Values: 112.0 113.0 112.0 110.0 112.0 112.0 112.0 112.0 111.0 112.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:123.00 stddev:15.23 (12.4%) stddev-sans-first:15.45 06:30:33 INFO - PROCESS | 20127 | Values: 142.0 118.0 121.0 154.0 123.0 119.0 121.0 117.0 156.0 123.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 06:30:33 INFO - PROCESS | 20127 | Values: 159.0 159.0 160.0 161.0 160.0 160.0 161.0 161.0 162.0 162.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.50 stddev:11.88 (15.7%) stddev-sans-first:12.44 06:30:33 INFO - PROCESS | 20127 | Values: 75.0 74.0 73.0 107.0 76.0 76.0 74.0 76.0 98.0 75.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:83.00 stddev:14.12 (17.0%) stddev-sans-first:14.71 06:30:33 INFO - PROCESS | 20127 | Values: 84.0 82.0 115.0 84.0 83.0 83.0 103.0 82.0 83.0 116.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:30:33 INFO - PROCESS | 20127 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 117.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:30:33 INFO - PROCESS | 20127 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:30:33 INFO - PROCESS | 20127 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:52.00 stddev:0.95 (1.8%) stddev-sans-first:0.97 06:30:33 INFO - PROCESS | 20127 | Values: 52.0 52.0 51.0 49.0 51.0 51.0 52.0 52.0 52.0 51.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.50 stddev:0.67 (1.1%) stddev-sans-first:0.67 06:30:33 INFO - PROCESS | 20127 | Values: 61.0 60.0 59.0 60.0 60.0 61.0 60.0 61.0 60.0 61.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:2.17 (2.8%) stddev-sans-first:2.30 06:30:33 INFO - PROCESS | 20127 | Values: 79.0 79.0 78.0 79.0 83.0 84.0 79.0 78.0 78.0 78.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:128.00 stddev:14.63 (11.4%) stddev-sans-first:15.40 06:30:33 INFO - PROCESS | 20127 | Values: 126.0 124.0 124.0 130.0 121.0 122.0 138.0 124.0 170.0 133.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.50 stddev:1.75 (1.0%) stddev-sans-first:1.73 06:30:33 INFO - PROCESS | 20127 | Values: 169.0 166.0 167.0 165.0 166.0 168.0 167.0 170.0 165.0 169.0 06:30:33 INFO - PROCESS | 20127 | 06:30:33 INFO - PROCESS | 20127 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 06:30:33 INFO - PROCESS | 20127 | Values: 66.0 67.0 67.0 66.0 66.0 66.0 66.0 67.0 64.0 64.0 06:30:33 INFO - PROCESS | 20127 | -------- Summary: end -------- 06:30:33 INFO - PROCESS | 20127 | 06:30:34 INFO - TEST-INFO | 20127: exit 0 06:30:34 INFO - TEST-OK | kraken | took 62036ms 06:30:34 INFO - SUITE-END | took 1178s 06:30:34 INFO - Completed test suite (00:19:38) 06:30:34 INFO - javascript benchmark 06:30:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2983.105068479456, 3006.7594592432592, 3013.457577636026, 3042.771792115592, 3052.496338104213, 5193.480651934809, 5200.453952335007, 5233.110371236894, 5240.764165612547, 5272.604554658396, 5279.340082489689, 5308.840734777953, 5323.148296272597, 5346.866328341784, 5371.677699338053, 4770.403699537558, 4785.2104402773675, 4835.10550548148, 4854.805807767702, 4881.0, 4856.514348565133, 4919.704817710949, 4923.113839508887, 4929.778159982791, 4983.451820299764, 4761.833335833264, 4764.190087685102, 4843.007183527368, 4906.730129842857, 4925.753712314406, 4791.856244312677, 4855.635827312965, 4863.708177509361, 4876.02479504097, 4939.333190019337, 4821.903561928777, 4822.7829747661435, 4825.324454576362, 4849.83025594106, 4894.975525122387, 5213.739313034371, 5296.390915044781, 5322.973385133049, 5328.8401347959625, 5347.358317001946, 5628.887422251573, 5638.0, 5693.174489699012, 5705.03014487534, 5774.711264436762, 5725.370209276976, 5731.770729170828, 5732.254806875079, 5734.455226753452, 5737.512311453532, 5348.224507446398, 5351.759170837322, 5352.330958630171, 5353.437889021675, 5401.459854014567, 5707.6575405475805, 5764.394738552475, 5770.105633626795, 5783.132530120515, 5813.069908814654, 5488.69812160327, 5567.47109024642, 5567.638103523258, 5634.7182640867795, 5649.604527683023, 5648.915266271009, 5670.8015219467125, 5672.0, 5672.149177623307, 5681.261436013292, 5596.664200148004, 5651.717414129277, 5654.4062873398525, 5656.095024796013, 5656.6888821115235, 5533.253010843485, 5593.244911936918, 5594.049011668027, 5642.746076426571, 5671.801486948019, 4275.722078064916, 4279.957200428018, 4314.935275970863, 4316.417283666728, 4334.003179268723, 3817.599152089046, 3829.2532956073296, 3831.099691572478, 3874.321993651156, 3875.5736868944396, 5350.38470575881, 5361.812336568201, 5364.785408583613, 5366.517013468729, 5370.91943620846, 5566.693831839207, 5598.468145526169, 5612.971935140298, 5652.491275785199, 5661.122526008476, 5309.814156504581, 5336.439673834191, 5342.065138600729, 5359.678419294854, 5391.002664507078, 4696.929546056812, 4703.0593881223895, 4704.670673052853, 4705.85882423521, 4758.500357462486, 5810.738516766755, 5849.853753656193, 5873.236479257669, 5876.6180198286975, 5907.054871220584, 5739.167820665896, 5739.598228123991, 5741.45456181662, 5786.913196302143, 5803.274590676166, 5925.288965324189, 5935.228420305332, 5939.346671866005, 5942.405759424023, 5945.524358051432, 5437.537809286255, 5509.283793106871, 5525.143602741581, 5562.471565201299, 5631.099024156116, 5713.942860571341, 5743.195952566561, 5743.827685169452, 5812.912806307993, 5823.854403639943, 5556.194351819045, 5559.027170245272, 5559.0827513461445, 5560.388357280777, 5561.944380556142, 5482.698451585201, 5533.723313834212, 5600.103983362643, 5614.2701448811395, 5618.775248990158, 5479.561635069264, 5540.63985840919, 5542.3903370630005, 5554.416786237387, 5615.915761263666, 5554.111342185231, 5604.775808967595, 5646.661200327993, 5647.830565083054, 5652.265205523256, 5411.944670789316, 5437.265969094122, 5466.508014278734, 5529.336479622471, 5538.889222215614], "value": 5231.627100816727, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.0739497634142, 590.8257064166071, 605.2313561776543, 612.1216054961129, 617.3918690090258, 31676.366472670532, 43011.78494107529, 43980.34029489556, 44009.339859902124, 44037.779811100896, 44625.7768711156, 44935.550644493545, 44942.0, 45032.77483612586, 45072.09855802882, 8148.185181481864, 8363.0, 8936.776580585489, 9091.090890910922, 9096.090390960917, 10498.475076246195, 10848.511816968215, 10858.23992320538, 11196.272242304265, 11196.888031119706, 11036.503357348938, 11145.888541114608, 11147.832782508269, 11150.219484636078, 11152.442377881114, 8210.548419836907, 8432.283255923254, 10749.408782516959, 10793.136549076095, 10860.99999999996, 10433.061024507755, 10819.67540973772, 10821.296615719953, 10825.350478971286, 10840.024397804236, 42233.0, 42376.36435453471, 42550.0, 42553.57446425558, 42617.360739588934, 2982.4482470742983, 3078.153507785377, 3164.17731389838, 3182.9681703182905, 3238.5951756030495, 28712.712872871212, 28898.855505722546, 28902.277443064093, 29158.708412916025, 29356.26609334762, 4353.673474489426, 4397.802098905557, 4443.777811109431, 4478.57453541913, 4496.168208881335, 348010.0, 348268.99999999744, 348645.0, 348945.0, 349774.0, 57562.0, 57988.0, 58047.0, 58061.0, 58073.4192658068, 50674.0, 50817.0, 50848.23727644089, 50903.23645145326, 50938.74530627323, 15829.68340633181, 16273.349066037463, 16296.674066518603, 16330.428435004955, 16382.098984555725, 11200.0, 11605.88394116065, 11678.474468648932, 11803.822942655866, 12313.0, 16486.917565412095, 16877.578060548585, 16880.915595421946, 17420.386941958554, 17610.91194544019, 6082.414973636275, 6117.877642447215, 6249.687515624291, 6267.780627678009, 6283.632875151726, 921.5438358012826, 981.1464026297167, 985.1970643925322, 1079.2984560035882, 1090.6291860767378, 30976.0, 31061.321815809708, 31394.0, 31518.36963260722, 31959.680403196136, 1029.3978022856713, 1053.0943388685723, 1054.984175237372, 1119.356370087203, 1123.859517560305, 15894.68210635804, 16544.338226471045, 16666.916665416837, 16704.74942875858, 16980.32078716862, 496957.0, 723835.0, 749321.0, 750228.0, 750777.0, 56876.431235687116, 57522.7123864378, 57642.0, 57685.0, 57689.423105769245, 1185.5731936502852, 1212.9090318226167, 1276.304414094321, 1294.9417276222594, 1306.5818937939957, 27801.44397112006, 31698.24791028411, 33573.0, 33760.0, 33928.321433570694, 51904.221436677726, 52891.0, 52912.0, 52933.47066529439, 52959.0, 423881.0, 425695.0, 426073.0, 426210.0, 426883.0, 25123.74876251287, 25262.0, 26104.477910441306, 27159.592606110527, 27565.0, 37453.4381984265, 48548.757256213496, 51532.0, 52774.73612632066, 55282.72358638181, 38213.42679859749, 39261.607383925795, 41526.37710434286, 42137.36793948032, 43206.351904720825, 42067.57932420759, 42267.5773242276, 42736.0, 43007.569924301606, 43446.13107737891, 41549.37675934924, 42466.78766606271, 43064.13871722611, 43194.0, 43439.56560434482, 35648.4652730204, 38194.866078093655, 38531.6146838528, 38841.21350087105, 38950.80524597359, 28219.0, 28694.0, 28862.855685722276, 28986.710132899243, 29112.708872911], "value": 20177.990278329602, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.3715525116435, 386.77760287834485, 394.4635295997443, 401.2736946127511, 401.7047470109469, 14171.885595755712, 15590.532284031497, 17627.294908203672, 19212.61574768504, 19233.23067077317, 18117.365892193775, 18153.45539633813, 18489.0, 18496.630067398644, 18584.628307433843, 5521.365043020044, 5595.160725891108, 5615.9157612635845, 5713.342965558952, 5719.313682358123, 4042.7574345539215, 4279.593438623326, 5627.577931655122, 5707.942920570783, 5712.657525481509, 5819.67991760453, 6144.8463788405425, 6159.568830181889, 6169.845753856144, 6270.184875966118, 5992.370801065891, 6220.0, 6236.345183755709, 6255.749770009194, 6283.748650053993, 5468.179773034037, 5566.777328906839, 5572.888542229132, 5581.748821303051, 5617.01702202113, 21595.352139435843, 22492.77507224923, 22528.3816817552, 22561.0, 22731.204407845646, 2290.1068583252545, 2349.5884732657046, 2356.29311206639, 2419.6733440985417, 2818.4363127374404, 13491.932540337333, 14346.856531434762, 14640.926795366062, 14843.777343339858, 15290.159041252728, 1857.674906891302, 1906.74258975038, 1937.883726976386, 1965.665836807746, 2010.883959402531, 79840.20159798386, 79844.0, 80331.0, 81831.18168818354, 82184.58907705483, 10509.737256568495, 10591.981285333643, 10647.094996925192, 10648.893511064945, 10948.616798412017, 13193.340332983504, 15190.620234494227, 15194.772078418833, 15206.771898421532, 15243.466478673194, 6926.341997510229, 7113.75101871432, 7168.354848063699, 7329.853402932018, 7334.743283985035, 6893.551919125241, 7008.474364422688, 7158.642067896689, 7490.550566966, 7539.246075392417, 6077.118817771398, 6083.513318934474, 6127.754889804358, 6213.545649468525, 6250.6874656267, 1904.2192700992528, 1935.4193741877662, 1938.3215874444113, 1965.7837637859825, 1972.3984184823767, 833.4999000599713, 962.4369743699874, 1025.7230547752065, 1039.26212389203, 1051.726551096705, 19315.4205373839, 19758.506037348892, 19886.70169947452, 20045.899770501055, 20177.59644807125, 939.7838497145558, 971.723058928202, 981.3228872078244, 993.1657407777501, 1022.2486472442748, 10521.684349469528, 11116.141840019529, 11117.444127793578, 11244.887551124548, 11288.492017859217, 445341.0, 447863.0, 473109.0, 473588.0, 484874.0, 88296.558517207, 89474.55262723645, 89511.55244223737, 90547.0, 91054.54472727726, 998.7465730508166, 999.645125980281, 1011.2769369900557, 1011.595361855249, 1013.0730381700808, 16766.748498772773, 17306.134693265034, 17865.553361165556, 17878.5530361742, 18048.819511804715, 39518.802405987786, 40858.182836342516, 40922.79538602288, 41314.0, 42761.786191068844, 52696.0, 53738.193927090346, 56197.15704264521, 57149.428505716074, 57627.42372576221, 7169.605671688108, 7190.5326153801925, 7225.205227424874, 7307.67115479794, 7381.778546643609, 9428.528573571431, 11725.296482211095, 11910.880891190976, 12033.75932481328, 12330.81503777462, 10633.0, 10769.084627806724, 10791.6222932197, 10829.67510974672, 11197.216194866282, 10437.21720870953, 10485.16118710486, 10814.134869210287, 10882.0, 11374.658760237206, 10400.271980961563, 10577.206709496664, 10781.676549703521, 10871.782564348827, 11040.889591103985, 7183.928160718535, 7309.232530584212, 7339.486235963432, 7395.963020184865, 7496.062992125984, 10327.793444130924, 10575.841362379417, 10619.36283822973, 11075.889241107809, 11554.248973816675], "value": 9046.670461166586, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.3495986966389, 1366.658335416146, 1434.0033676594771, 1435.0815478094019, 1657.850793428592, 7736.65185066672, 8437.282830959368, 8838.77903052424, 8846.734597962064, 9048.0, 8834.293256539477, 8905.287576993842, 8912.777180570489, 8914.687985920495, 8928.553572321374, 2044.2947183221765, 2065.0603975191325, 2068.803463670949, 2070.130545171032, 2071.2129390831537, 2014.8287395571394, 2021.4542073640182, 2038.4394291569788, 2121.596896589643, 2131.05168200151, 2048.795120487947, 2054.6917962305697, 2055.814976652101, 2064.4735592423986, 2077.40793873746, 1998.9100490477963, 2022.0496366707623, 2024.6861736430803, 2028.188724510193, 2030.7664618568906, 1938.2247101159508, 1957.4323446200726, 2001.6997450382414, 2020.6564883969613, 2023.5548179400507, 8274.213949674771, 8509.191626795444, 8666.090060543615, 8667.609957551926, 8670.263027642657, 5038.0, 5180.844574662766, 5235.921461178085, 5236.633435659505, 5239.502247286502, 3177.523371494271, 3291.8189499577516, 3332.3335332933266, 3348.3470723208984, 3361.1765117546356, 1110.8278216876397, 1114.5318966034285, 1120.548353449567, 1132.318507017079, 1140.931544107356, 12052.819207711891, 12194.634160975185, 12266.632001039983, 12270.32513211773, 12285.385730713519, 4312.741235525878, 4382.517923028464, 4466.642668586505, 4467.530909254547, 4555.407796986437, 9851.359661621971, 9852.16256618181, 9866.0267946411, 9867.0, 9869.950650246703, 5209.609279304067, 5237.450067742909, 5244.370675518886, 5245.659032162897, 5250.921236181461, 4050.311447054008, 4333.1766964276685, 4366.672499562545, 4828.565429111397, 4828.879278018007, 3902.3366027775346, 4063.7358571692744, 4071.633552980246, 4119.7940102994735, 4131.091159944807, 1316.5392112760649, 1325.5543522201522, 1328.5881376773038, 1340.6246251049722, 1349.7233067221196, 673.9561928474634, 756.2173150789017, 818.29217726666, 819.700809204648, 902.3638334973828, 5433.347998240158, 5691.459311365414, 5776.537876969833, 5778.133280007948, 5819.563532735062, 389.8421139438532, 400.969927255457, 401.9758814471141, 406.0093372171891, 413.31389892777844, 3749.362608356586, 3764.981175094107, 3779.3197224499304, 3780.4140358244517, 3794.354959656865, 10854.891451085547, 11228.101751859831, 11286.774264514665, 11317.660470185907, 11334.0, 11165.655212405485, 11245.550177992789, 11253.268537545033, 11263.04264137541, 11272.041876440595, 7686.692532298645, 8257.876131858027, 8315.168483151636, 8331.29184019353, 8334.249917507332, 5572.526335261548, 5580.665160090408, 5608.803691870765, 5670.9432905672065, 5960.254968128984, 10008.449535275338, 10043.443266293736, 10256.0, 10295.53670084863, 10298.124659404035, 10348.172146228435, 10409.843852342372, 10480.63317783874, 10507.369557826554, 10593.205509586658, 7287.198408174991, 7394.2975417335265, 7398.0, 7399.556026638419, 7401.444891633257, 8269.793255168668, 8307.0, 8314.127016663164, 8371.41400101987, 8445.324374049938, 7083.539569927938, 7254.5647261164495, 7257.709691612487, 7308.8903666443985, 7354.6322683866665, 7264.055672762507, 7369.889451658337, 7421.0723659542555, 7548.509346892434, 7824.530528168328, 6405.231372235362, 6450.161479007699, 6485.448736857231, 6500.6424646643, 6599.571027883172, 4987.925181122214, 5036.84889453317, 5050.090983622837, 5089.694618322913, 5345.572354211731, 4964.776585053609, 4987.476314986874, 5051.520105589963, 5140.074786538459, 5231.189165679326], "value": 4359.954663485703, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.6983486348516, 312.0809216856358, 317.8474332320486, 318.2473450290064, 323.3597476995547, 5023.623228257886, 5144.408393034802, 5172.224166375041, 5260.0, 5268.182477045418, 4985.351904252442, 5077.5176358246, 5086.262491938666, 5106.540411362977, 5145.665531740444, 4045.5145382553987, 4048.7165898387125, 4057.8985525361954, 4066.2883995300776, 4066.471358723362, 3926.646601805837, 4053.500204924182, 4078.4290199372113, 4080.6531444827224, 4087.305158123126, 4006.298897692907, 4008.118213992917, 4013.3377992631326, 4032.717709760318, 4040.5555388907196, 3999.200159967989, 4006.238814625212, 4010.375797801895, 4011.4785077939973, 4025.29557327468, 3522.20750331176, 3523.0487768302414, 3537.221811201557, 3556.1820781220204, 3572.4462708280257, 4811.855644330676, 5008.924866127011, 5011.198208286693, 5015.843187429404, 5025.195968644999, 4586.1515619610145, 4606.286025665993, 4610.395126753374, 4622.237330840408, 4645.814167433298, 5349.331333583302, 5361.640878013701, 5367.872746723154, 5384.300040994684, 5405.675659460445, 3736.57029441615, 3947.7631342119275, 3958.3270843956598, 3978.204359128186, 3987.5613682494904, 5638.351589567212, 5675.602707810455, 5684.914726279109, 5696.145578163268, 5705.800296989585, 4070.3487442009136, 4071.898202544901, 4085.101277718897, 4086.877393678135, 4088.0801819590356, 3900.278448486982, 4068.8372465101656, 4076.9592304077173, 4119.8352065917625, 4130.297849365615, 4614.700044497097, 4615.7076018714815, 4617.538246175355, 4624.190766615829, 4632.305154226893, 5421.810236641778, 5429.239906413105, 5432.29380180574, 5483.588730845203, 5520.751566179531, 1324.3973991833693, 1346.3604787725947, 1395.2814300635182, 1397.182648150843, 1407.268220525321, 893.2853717026483, 906.0667512462174, 919.3610440743619, 933.4352716606492, 938.5307346326837, 4601.032334144525, 4657.790399432034, 4676.766161691902, 4679.789409476582, 4704.341392205026, 4899.902001960012, 4906.779194936236, 4927.644897653103, 4931.432885218246, 4959.049365627446, 4483.977580112144, 4636.09919932826, 4653.976730116327, 4678.058605678673, 4690.437147542249, 2594.0920677762633, 2600.4409052053898, 2604.632567901867, 2617.5472612699755, 2628.921132366032, 5049.772760225798, 5059.747012649353, 5076.411030374462, 5080.3996741027195, 5128.615353848401, 4906.0, 4925.783397471152, 4950.232713929347, 4987.0, 5341.893162136736, 5798.507126894261, 5799.462327979844, 5806.82579522615, 5811.593188476766, 5831.999999999915, 5599.552035837041, 5610.691411972381, 5616.539699678031, 5646.2942132233475, 5647.1529270609735, 5411.404745478073, 5517.668939863621, 5527.231285988445, 5559.63862348946, 5562.582806289463, 5726.284214473191, 5763.740631671669, 5776.884462310814, 5777.566682498746, 5778.971105144447, 3973.2252210818615, 3974.960250397575, 3978.3037968356, 4016.9598304017754, 4022.727159155068, 5308.150695888639, 5362.463753624606, 5606.831795046155, 5619.9206293671605, 5667.433256674464, 5301.1783173608155, 5353.304070470814, 5427.421974562051, 5451.618386712892, 5459.7342103026795, 5442.727863606883, 5450.2369668247275, 5455.809046683347, 5482.862928426821, 5509.449055094458, 5287.68273903567, 5349.224362467343, 5357.276767636319, 5371.677699338053, 5417.458254174551, 5449.373322068013, 5449.591280654046, 5458.399576046552, 5469.917951230815, 5482.5613950884635, 5338.225957236256, 5363.785448582169, 5366.195070739421, 5398.730063496888, 5427.918581221364], "value": 4065.601142842029, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.356441776015, 727.0766127018686, 736.8305289783348, 743.2678811370799, 774.3727580659667, 15976.920115399422, 16901.239444225008, 17141.82858171418, 17144.914275428622, 17184.398546050892, 14416.711665766677, 14516.854831451683, 14528.927355363236, 14538.709225815477, 14541.92729036356, 764.094547960667, 783.0759703549809, 784.1531146361915, 784.4391260248921, 784.525362155896, 776.3750181104209, 779.3881802784815, 780.9648565814524, 785.0932173339802, 786.2098590916149, 836.602613758466, 836.7196989008689, 838.4089217101929, 838.7316058861136, 839.3495041342977, 825.2861274997144, 829.7054545636272, 831.6382373667444, 832.1137988042746, 832.7543374704477, 590.1383979390096, 596.2368168744015, 596.6539407143846, 598.6976576828673, 599.1043390131738, 14799.778003329959, 14857.851421485755, 14956.177410242432, 15062.774058389134, 15071.246437678183, 12388.504459821595, 12738.299393533352, 12781.616551503377, 13140.332925703182, 13393.0, 10387.948060259725, 10584.470776461147, 10657.78684426315, 10723.410212438313, 10994.34033957965, 3653.5798383186007, 3662.670359667616, 3832.8275227614545, 3908.2965066288057, 3916.8629097981434, 82444.0, 82485.58757206236, 83013.58493207555, 84102.57948710218, 86829.37071327158, 9547.713568592953, 9741.220702343795, 9790.510474476248, 9890.357126786736, 10339.483025848827, 21082.78917210808, 21083.472913177295, 21085.472863178544, 21105.577888442145, 21113.472163195736, 8499.40504164715, 8688.6524539019, 8774.736757897273, 8845.380823342433, 9043.140901614335, 4437.800298986554, 4502.16709908668, 4626.583607475343, 4627.329037289574, 4671.48613652498, 3591.892243232655, 3716.9814150929074, 3729.9627003729615, 3734.589195188527, 3751.437284407306, 578.0462237308475, 582.7290310005783, 584.9970750146307, 599.4455129005652, 606.4663096475161, 619.1089005599783, 622.2346513788066, 713.6503113474464, 722.0865605009667, 731.7292601737284, 9107.22588579965, 9715.61137554504, 9827.164691001344, 9964.20286377088, 9973.252006099572, 591.899377105893, 648.8961766117399, 680.9795706128824, 681.5127184063319, 715.5349023135004, 4152.584741525884, 4307.892302692395, 4677.95322046782, 4681.81272749093, 4777.8327758528285, 126513.73486265204, 128740.0, 128861.0, 132534.0, 132625.0, 105850.0, 108766.64933402576, 109597.45201273942, 113019.43490282496, 113644.43177784058, 74300.62849685717, 74315.0, 74329.6283518579, 93242.53378733063, 97505.53741693881, 9116.453012819253, 9270.814583708423, 9375.203107735646, 9424.57589408492, 9619.615215391306, 51157.7442112787, 51439.742801285756, 52118.739406304245, 53013.46986530085, 54091.0, 68500.6574967122, 72305.0, 75936.24063759291, 76367.61816190883, 76579.61710191413, 11068.501917413574, 11226.831597526207, 11266.211365204357, 11321.150913681671, 11374.146938979444, 14347.713045739236, 14413.927930360282, 14696.11823290606, 14751.631209219855, 14765.852341476448, 12590.685232869251, 12749.81430615313, 13094.934525327693, 13500.257485838372, 13568.796468053184, 12928.870711292766, 13077.607671769862, 13534.390952407362, 13623.0, 13960.860391395956, 12997.870021299666, 13592.45630174782, 13664.590062298146, 13833.334166445698, 14055.086419382707, 10161.339512931636, 10657.840132398176, 10668.1998850085, 10709.518071686636, 10806.189535785004, 9035.638574456949, 9907.207423406255, 10871.67384978452, 10911.781764364827, 11135.72160695989], "value": 7403.4819828942445, "unit": "score"}], "name": "dromaeo_css", "value": 7074.285520994012, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 110.0, 112.0, 112.0, 112.0, 112.0, 111.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 121.0, 154.0, 123.0, 119.0, 121.0, 117.0, 156.0, 123.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 107.0, 76.0, 76.0, 74.0, 76.0, 98.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 115.0, 84.0, 83.0, 83.0, 103.0, 82.0, 83.0, 116.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 49.0, 51.0, 51.0, 52.0, 52.0, 52.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 60.0, 60.0, 61.0, 60.0, 61.0, 60.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 83.0, 84.0, 79.0, 78.0, 78.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 124.0, 124.0, 130.0, 121.0, 122.0, 138.0, 124.0, 170.0, 133.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 167.0, 165.0, 166.0, 168.0, 167.0, 170.0, 165.0, 169.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0, 64.0, 64.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1486.2, "alertThreshold": 2.0}]} 06:30:35 INFO - Return code: 0 06:30:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:30:35 INFO - # TBPL SUCCESS # 06:30:35 INFO - Running post-action listener: _resource_record_post_action 06:30:35 INFO - [mozharness: 2016-09-25 13:30:35.134800Z] Finished run-tests step (success) 06:30:35 INFO - Running post-run listener: _resource_record_post_run 06:30:35 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 77824; Write bytes: 407793664; Read time: 212; Write time: 454044 06:30:35 INFO - TinderboxPrint: CPU usage
13.1% 06:30:35 INFO - TinderboxPrint: I/O read bytes / time
77,824 / 212 06:30:35 INFO - TinderboxPrint: I/O write bytes / time
407,793,664 / 454,044 06:30:35 INFO - TinderboxPrint: CPU idle
8,293.4 (86.9%) 06:30:35 INFO - TinderboxPrint: CPU user
1,197.0 (12.5%) 06:30:35 INFO - TinderboxPrint: Swap in / out
0 / 0 06:30:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104509440; Read time: 0; Write time: 145688 06:30:35 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 73728; Write bytes: 290385920; Read time: 208; Write time: 296944 06:30:35 INFO - Running post-run listener: _upload_blobber_files 06:30:35 INFO - Blob upload gear active. 06:30:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:30: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 06:30: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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:30: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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:30:36 INFO - (blobuploader) - INFO - Open directory for files ... 06:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:39 INFO - (blobuploader) - INFO - Done attempting. 06:30:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:30:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:30:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:40 INFO - (blobuploader) - INFO - Done attempting. 06:30:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:30:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:30:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:41 INFO - (blobuploader) - INFO - Done attempting. 06:30:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:30:41 INFO - Return code: 0 06:30:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:30:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:30:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7460d624ab5de450455b103e7fb52e642a69dd2a789a17b0732770e6bae92c3a2695e71959b904204b04aad1dd0419c81d5886079f519c8b013b9ca6e5aec690", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/725d692d7ea1ea39f0f90d969c84b516ea1b22805798b7abe2bb2ba39db55a4430331942f12918f6bfbbb6c9f8b644489aaf673b17a08b4511efa917e1c82508", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02ae0a65a3a081e8a76addd2fe4726bac15e6ebe24c29401e4c683272a7008c34cfe4245ba3d007cef811400e6c674e2127bec4c197cf2e0bf37c82c8df64a1a"} 06:30:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:30:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:30:41 INFO - Contents: 06:30:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7460d624ab5de450455b103e7fb52e642a69dd2a789a17b0732770e6bae92c3a2695e71959b904204b04aad1dd0419c81d5886079f519c8b013b9ca6e5aec690", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/725d692d7ea1ea39f0f90d969c84b516ea1b22805798b7abe2bb2ba39db55a4430331942f12918f6bfbbb6c9f8b644489aaf673b17a08b4511efa917e1c82508", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02ae0a65a3a081e8a76addd2fe4726bac15e6ebe24c29401e4c683272a7008c34cfe4245ba3d007cef811400e6c674e2127bec4c197cf2e0bf37c82c8df64a1a"} 06:30:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:30:41 INFO - Copying logs to upload dir... 06:30:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:30:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.506170 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-25 06:30:41.269995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-25 06:30:41.273535) ========= 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=df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7460d624ab5de450455b103e7fb52e642a69dd2a789a17b0732770e6bae92c3a2695e71959b904204b04aad1dd0419c81d5886079f519c8b013b9ca6e5aec690", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/725d692d7ea1ea39f0f90d969c84b516ea1b22805798b7abe2bb2ba39db55a4430331942f12918f6bfbbb6c9f8b644489aaf673b17a08b4511efa917e1c82508", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02ae0a65a3a081e8a76addd2fe4726bac15e6ebe24c29401e4c683272a7008c34cfe4245ba3d007cef811400e6c674e2127bec4c197cf2e0bf37c82c8df64a1a"} build_url:https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/Ck4W_zn3RGef7FKpcfa6Fg/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/Firefox/sha512/7460d624ab5de450455b103e7fb52e642a69dd2a789a17b0732770e6bae92c3a2695e71959b904204b04aad1dd0419c81d5886079f519c8b013b9ca6e5aec690", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/725d692d7ea1ea39f0f90d969c84b516ea1b22805798b7abe2bb2ba39db55a4430331942f12918f6bfbbb6c9f8b644489aaf673b17a08b4511efa917e1c82508", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02ae0a65a3a081e8a76addd2fe4726bac15e6ebe24c29401e4c683272a7008c34cfe4245ba3d007cef811400e6c674e2127bec4c197cf2e0bf37c82c8df64a1a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-25 06:30:41.299184) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 06:30:41.299474) ========= 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=df17445c3590ff7897617a0e00000225-1474804958.270797-1130669984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 06:30:41.382806) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-25 06:30:41.383097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-25 06:30:41.383370) ========= ========= Total master_lag: 0.17 =========