builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1480474291.88 results: success (0) buildid: 20161129155626 builduid: 3dd0b2d3b2e546459e7c14eb7df65d08 revision: 078cccdeb2e1b36b9b6d099e713f54639789527d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:31.879348) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:31.879910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:31.880226) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:31.895545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:31.895988) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 18:51:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 29.9M=0s 2016-11-29 18:51:32 (29.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:32.003236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:32.004004) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018445 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:32.058448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:32.059264) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 078cccdeb2e1b36b9b6d099e713f54639789527d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 078cccdeb2e1b36b9b6d099e713f54639789527d --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=e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 18:51:32,496 truncating revision to first 12 chars 2016-11-29 18:51:32,496 Setting DEBUG logging. 2016-11-29 18:51:32,497 attempt 1/10 2016-11-29 18:51:32,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/078cccdeb2e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 18:51:32,807 unpacking tar archive at: mozilla-beta-078cccdeb2e1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640962 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:32.717226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:32.717634) ========= script_repo_revision: 078cccdeb2e1b36b9b6d099e713f54639789527d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:32.718144) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:32.718775) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 18:51:32.729958) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-11-29 18:51:32.730458) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:51:33 INFO - MultiFileLogger online at 20161129 18:51:33 in /builds/slave/test 18:51:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 18:51:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:51:33 INFO - {'append_to_log': False, 18:51:33 INFO - 'base_work_dir': '/builds/slave/test', 18:51:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:51:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:51:33 INFO - 'branch': 'Mozilla-Beta', 18:51:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:51:33 INFO - 'config_files': ('talos/linux_config.py',), 18:51:33 INFO - 'default_actions': ('clobber', 18:51:33 INFO - 'read-buildbot-config', 18:51:33 INFO - 'download-and-extract', 18:51:33 INFO - 'populate-webroot', 18:51:33 INFO - 'create-virtualenv', 18:51:33 INFO - 'install', 18:51:33 INFO - 'run-tests'), 18:51:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:51:33 INFO - 'download_minidump_stackwalk': True, 18:51:33 INFO - 'download_symbols': 'ondemand', 18:51:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:51:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:51:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:51:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:51:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:51:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:51:33 INFO - 'installer_path': 'installer.exe', 18:51:33 INFO - 'log_level': 'info', 18:51:33 INFO - 'log_name': 'talos', 18:51:33 INFO - 'log_to_console': True, 18:51:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:51:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:51:33 INFO - 'opt_config_files': (), 18:51:33 INFO - 'pip_index': False, 18:51:33 INFO - 'sps_profile': False, 18:51:33 INFO - 'sps_profile_interval': 0, 18:51:33 INFO - 'suite': 'dromaeojs', 18:51:33 INFO - 'system_bits': '32', 18:51:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:51:33 INFO - 'title': 'talos-linux64-ix-006', 18:51:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:51:33 INFO - 'use_talos_json': True, 18:51:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:51:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:51:33 INFO - 'work_dir': 'build'} 18:51:33 INFO - [mozharness: 2016-11-30 02:51:33.257504Z] Running clobber step. 18:51:33 INFO - Running pre-action listener: _resource_record_pre_action 18:51:33 INFO - Running main action method: clobber 18:51:33 INFO - rmtree: /builds/slave/test/build 18:51:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:51:33 INFO - Running post-action listener: _resource_record_post_action 18:51:33 INFO - [mozharness: 2016-11-30 02:51:33.721633Z] Finished clobber step (success) 18:51:33 INFO - [mozharness: 2016-11-30 02:51:33.721733Z] Running read-buildbot-config step. 18:51:33 INFO - Running pre-action listener: _resource_record_pre_action 18:51:33 INFO - Running main action method: read_buildbot_config 18:51:33 INFO - Using buildbot properties: 18:51:33 INFO - { 18:51:33 INFO - "project": "", 18:51:33 INFO - "product": "firefox", 18:51:33 INFO - "script_repo_revision": "production", 18:51:33 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 18:51:33 INFO - "repository": "", 18:51:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 18:51:33 INFO - "buildid": "20161129155626", 18:51:33 INFO - "pgo_build": "True", 18:51:33 INFO - "basedir": "/builds/slave/test", 18:51:33 INFO - "buildnumber": 484, 18:51:33 INFO - "slavename": "talos-linux64-ix-006", 18:51:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:51:33 INFO - "platform": "ubuntu64_hw", 18:51:33 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 18:51:33 INFO - "branch": "mozilla-beta", 18:51:33 INFO - "repo_path": "releases/mozilla-beta", 18:51:33 INFO - "revision": "078cccdeb2e1b36b9b6d099e713f54639789527d", 18:51:33 INFO - "stage_platform": "linux64-pgo", 18:51:33 INFO - "builduid": "3dd0b2d3b2e546459e7c14eb7df65d08", 18:51:33 INFO - "slavebuilddir": "test" 18:51:33 INFO - } 18:51:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 18:51:33 INFO - Running post-action listener: _resource_record_post_action 18:51:33 INFO - [mozharness: 2016-11-30 02:51:33.724195Z] Finished read-buildbot-config step (success) 18:51:33 INFO - [mozharness: 2016-11-30 02:51:33.724285Z] Running download-and-extract step. 18:51:33 INFO - Running pre-action listener: _resource_record_pre_action 18:51:33 INFO - Running main action method: download_and_extract 18:51:33 INFO - mkdir: /builds/slave/test/build/tests 18:51:33 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')]} 18:51:33 INFO - trying https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 18:51:33 INFO - Downloading https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 18:51:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:51:34 INFO - Downloaded 1327 bytes. 18:51:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 18:51:34 INFO - Using the following test package requirements: 18:51:34 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 18:51:34 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:51:34 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 18:51:34 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:51:34 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 18:51:34 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:51:34 INFO - u'jsshell-linux-x86_64.zip'], 18:51:34 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:51:34 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 18:51:34 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 18:51:34 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:51:34 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 18:51:34 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:51:34 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 18:51:34 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:51:34 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 18:51:34 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:51:34 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 18:51:34 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:51:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 18:51:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:51:34 INFO - Fetch https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 18:51:34 INFO - Expected file size: 21963841 18:51:39 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:51:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 18:51:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:51:39 INFO - Fetch https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 18:51:39 INFO - Expected file size: 21963841 18:51:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 18:51:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:51:44 INFO - Fetch https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 18:51:44 INFO - Expected file size: 14414089 18:51:45 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')]} 18:51:45 INFO - trying https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 18:51:45 INFO - Downloading https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 18:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:51:46 INFO - Downloaded 56977439 bytes. 18:51:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 18:51:46 INFO - mkdir: /builds/slave/test/properties 18:51:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:51:46 INFO - Writing to file /builds/slave/test/properties/build_url 18:51:46 INFO - Contents: 18:51:46 INFO - build_url:https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 18:51:47 INFO - Running post-action listener: _resource_record_post_action 18:51:47 INFO - Running post-action listener: set_extra_try_arguments 18:51:47 INFO - [mozharness: 2016-11-30 02:51:47.041537Z] Finished download-and-extract step (success) 18:51:47 INFO - [mozharness: 2016-11-30 02:51:47.041765Z] Running populate-webroot step. 18:51:47 INFO - Running pre-action listener: _resource_record_pre_action 18:51:47 INFO - Running main action method: populate_webroot 18:51:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:51:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:51:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:51:47 INFO - '--tppagecycles', 18:51:47 INFO - '7'], 18:51:47 INFO - 'tests': ['tsvgm']}}, 18:51:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:51:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:51:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:51:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:51:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:51:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:51:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:47 INFO - 'talos_options': ['--disable-e10s'], 18:51:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:51:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:51:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:47 INFO - 'talos_options': ['--disable-e10s'], 18:51:47 INFO - 'tests': ['damp', 'tps']}, 18:51:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:47 INFO - 'tests': ['damp', 'tps']}, 18:51:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:51:47 INFO - 'tests': ['dromaeo_dom']}, 18:51:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:51:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:51:47 INFO - 'tests': ['basic_compositor_video']}, 18:51:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:51:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:51:47 INFO - 'tests': ['a11yr', 18:51:47 INFO - 'ts_paint', 18:51:47 INFO - 'tpaint', 18:51:47 INFO - 'sessionrestore', 18:51:47 INFO - 'sessionrestore_no_auto_restore', 18:51:47 INFO - 'tabpaint']}, 18:51:47 INFO - 'other-e10s': {'tests': ['a11yr', 18:51:47 INFO - 'ts_paint', 18:51:47 INFO - 'tpaint', 18:51:47 INFO - 'sessionrestore', 18:51:47 INFO - 'sessionrestore_no_auto_restore', 18:51:47 INFO - 'tabpaint']}, 18:51:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:51:47 INFO - 'ts_paint', 18:51:47 INFO - 'tpaint', 18:51:47 INFO - 'sessionrestore', 18:51:47 INFO - 'sessionrestore_no_auto_restore', 18:51:47 INFO - 'tabpaint']}, 18:51:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:51:47 INFO - 'ts_paint', 18:51:47 INFO - 'tpaint', 18:51:47 INFO - 'sessionrestore', 18:51:47 INFO - 'sessionrestore_no_auto_restore', 18:51:47 INFO - 'tabpaint']}, 18:51:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:51:47 INFO - 'tests': ['a11yr', 18:51:47 INFO - 'ts_paint', 18:51:47 INFO - 'tpaint', 18:51:47 INFO - 'sessionrestore', 18:51:47 INFO - 'sessionrestore_no_auto_restore', 18:51:47 INFO - 'tabpaint']}, 18:51:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:51:47 INFO - 'tests': ['a11yr', 18:51:47 INFO - 'ts_paint', 18:51:47 INFO - 'tpaint', 18:51:47 INFO - 'sessionrestore', 18:51:47 INFO - 'sessionrestore_no_auto_restore', 18:51:47 INFO - 'tabpaint']}, 18:51:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:51:47 INFO - 'tests': ['tsvgx', 18:51:47 INFO - 'tsvgr_opacity', 18:51:47 INFO - 'tart', 18:51:47 INFO - 'tscrollx', 18:51:47 INFO - 'cart']}, 18:51:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:51:47 INFO - 'tsvgr_opacity', 18:51:47 INFO - 'tart', 18:51:47 INFO - 'tscrollx', 18:51:47 INFO - 'cart']}, 18:51:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:47 INFO - 'talos_options': ['--disable-e10s'], 18:51:47 INFO - 'tests': ['tp5o']}, 18:51:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:47 INFO - 'tests': ['tp5o']}, 18:51:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:47 INFO - 'talos_options': ['--disable-e10s', 18:51:47 INFO - '--xperf_path', 18:51:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:51:47 INFO - 'tests': ['tp5n']}, 18:51:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:47 INFO - 'talos_options': ['--xperf_path', 18:51:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:51:47 INFO - 'tests': ['tp5n']}}, 18:51:47 INFO - 'talos.zip': {'path': '', 18:51:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:51:47 INFO - Running post-action listener: _resource_record_post_action 18:51:47 INFO - [mozharness: 2016-11-30 02:51:47.063668Z] Finished populate-webroot step (success) 18:51:47 INFO - [mozharness: 2016-11-30 02:51:47.063763Z] Running create-virtualenv step. 18:51:47 INFO - Running pre-action listener: _resource_record_pre_action 18:51:47 INFO - Running main action method: create_virtualenv 18:51:47 INFO - Creating virtualenv /builds/slave/test/build/venv 18:51:47 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 18:51:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:51:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:51:47 INFO - Using real prefix '/usr' 18:51:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:51:47 INFO - Installing distribute.............................................................................................................................................................................................done. 18:51:49 INFO - Installing pip.................done. 18:51:49 INFO - Return code: 0 18:51:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f444d80ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ef60>, '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 0x2a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a601d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', '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 18:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:51:49 INFO - Using env: {'DISPLAY': ':0', 18:51:49 INFO - 'HOME': '/home/cltbld', 18:51:49 INFO - 'LANG': 'en_US.UTF-8', 18:51:49 INFO - 'LANGUAGE': 'en_US:en', 18:51:49 INFO - 'LOGNAME': 'cltbld', 18:51:49 INFO - 'MAIL': '/var/mail/cltbld', 18:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:49 INFO - 'MOZ_NO_REMOTE': '1', 18:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:49 INFO - 'NO_EM_RESTART': '1', 18:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:49 INFO - 'PWD': '/builds/slave/test', 18:51:49 INFO - 'SHELL': '/bin/bash', 18:51:49 INFO - 'SHLVL': '1', 18:51:49 INFO - 'TERM': 'linux', 18:51:49 INFO - 'TMOUT': '86400', 18:51:49 INFO - 'USER': 'cltbld', 18:51:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', 18:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:49 INFO - '_': '/tools/buildbot/bin/python'} 18:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:49 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 18:51:49 INFO - Cleaning up... 18:51:49 INFO - Return code: 0 18:51:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f444d80ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ef60>, '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 0x2a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a601d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', '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 18:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:51:49 INFO - Using env: {'DISPLAY': ':0', 18:51:49 INFO - 'HOME': '/home/cltbld', 18:51:49 INFO - 'LANG': 'en_US.UTF-8', 18:51:49 INFO - 'LANGUAGE': 'en_US:en', 18:51:49 INFO - 'LOGNAME': 'cltbld', 18:51:49 INFO - 'MAIL': '/var/mail/cltbld', 18:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:49 INFO - 'MOZ_NO_REMOTE': '1', 18:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:49 INFO - 'NO_EM_RESTART': '1', 18:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:49 INFO - 'PWD': '/builds/slave/test', 18:51:49 INFO - 'SHELL': '/bin/bash', 18:51:49 INFO - 'SHLVL': '1', 18:51:49 INFO - 'TERM': 'linux', 18:51:49 INFO - 'TMOUT': '86400', 18:51:49 INFO - 'USER': 'cltbld', 18:51:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', 18:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:49 INFO - '_': '/tools/buildbot/bin/python'} 18:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:50 INFO - Downloading/unpacking psutil>=3.1.1 18:51:50 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 18:51:50 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 18:51:50 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 18:51:50 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 18:51:50 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 18:51:50 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 18:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:51:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:51:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:51:52 INFO - Installing collected packages: psutil 18:51:52 INFO - Running setup.py install for psutil 18:51:52 INFO - building 'psutil._psutil_linux' extension 18:51:52 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 18:51:52 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 18:51:52 INFO - building 'psutil._psutil_posix' extension 18:51:52 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 18:51:52 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 18:51:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:51:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:51:52 INFO - Successfully installed psutil 18:51:52 INFO - Cleaning up... 18:51:52 INFO - Return code: 0 18:51:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:52 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 0x7f444d80ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ef60>, '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 0x2a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a601d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', '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 18:51:52 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 18:51:52 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 18:51:52 INFO - Using env: {'DISPLAY': ':0', 18:51:52 INFO - 'HOME': '/home/cltbld', 18:51:52 INFO - 'LANG': 'en_US.UTF-8', 18:51:52 INFO - 'LANGUAGE': 'en_US:en', 18:51:52 INFO - 'LOGNAME': 'cltbld', 18:51:52 INFO - 'MAIL': '/var/mail/cltbld', 18:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:52 INFO - 'MOZ_NO_REMOTE': '1', 18:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:52 INFO - 'NO_EM_RESTART': '1', 18:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:52 INFO - 'PWD': '/builds/slave/test', 18:51:52 INFO - 'SHELL': '/bin/bash', 18:51:52 INFO - 'SHLVL': '1', 18:51:52 INFO - 'TERM': 'linux', 18:51:52 INFO - 'TMOUT': '86400', 18:51:52 INFO - 'USER': 'cltbld', 18:51:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', 18:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:52 INFO - '_': '/tools/buildbot/bin/python'} 18:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:51:52 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 18:51:52 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 18:51:52 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 18:51:52 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 18:51:52 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 18:51:52 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 18:51:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:51:55 INFO - Installing collected packages: mozsystemmonitor 18:51:55 INFO - Running setup.py install for mozsystemmonitor 18:51:55 INFO - Successfully installed mozsystemmonitor 18:51:55 INFO - Cleaning up... 18:51:55 INFO - Return code: 0 18:51:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:51: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')]} 18:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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')]} 18:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:55 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 0x7f444d80ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ef60>, '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 0x2a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a601d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', '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 18:51:55 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 18:51:55 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 18:51:55 INFO - Using env: {'DISPLAY': ':0', 18:51:55 INFO - 'HOME': '/home/cltbld', 18:51:55 INFO - 'LANG': 'en_US.UTF-8', 18:51:55 INFO - 'LANGUAGE': 'en_US:en', 18:51:55 INFO - 'LOGNAME': 'cltbld', 18:51:55 INFO - 'MAIL': '/var/mail/cltbld', 18:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:55 INFO - 'MOZ_NO_REMOTE': '1', 18:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:55 INFO - 'NO_EM_RESTART': '1', 18:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:55 INFO - 'PWD': '/builds/slave/test', 18:51:55 INFO - 'SHELL': '/bin/bash', 18:51:55 INFO - 'SHLVL': '1', 18:51:55 INFO - 'TERM': 'linux', 18:51:55 INFO - 'TMOUT': '86400', 18:51:55 INFO - 'USER': 'cltbld', 18:51:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', 18:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:55 INFO - '_': '/tools/buildbot/bin/python'} 18:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:55 INFO - Downloading/unpacking jsonschema==2.5.1 18:51:55 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 18:51:55 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 18:51:55 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 18:51:55 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 18:51:55 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 18:51:55 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 18:51:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:51:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:57 INFO - Downloading functools32-3.2.3-2.tar.gz 18:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:51:57 INFO - warning: no files found matching '*.txt' 18:51:57 INFO - no previously-included directories found matching 'build' 18:51:57 INFO - no previously-included directories found matching 'dist' 18:51:57 INFO - no previously-included directories found matching '.git*' 18:51:57 INFO - Installing collected packages: jsonschema, functools32 18:51:57 INFO - Running setup.py install for functools32 18:51:57 INFO - warning: no files found matching '*.txt' 18:51:57 INFO - no previously-included directories found matching 'build' 18:51:57 INFO - no previously-included directories found matching 'dist' 18:51:57 INFO - no previously-included directories found matching '.git*' 18:51:57 INFO - Successfully installed jsonschema functools32 18:51:57 INFO - Cleaning up... 18:51:57 INFO - Return code: 0 18:51:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:51:57 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')]} 18:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:57 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')]} 18:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:57 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 0x7f444d80ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ef60>, '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 0x2a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a601d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', '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 18:51:57 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 18:51:57 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 18:51:57 INFO - Using env: {'DISPLAY': ':0', 18:51:57 INFO - 'HOME': '/home/cltbld', 18:51:57 INFO - 'LANG': 'en_US.UTF-8', 18:51:57 INFO - 'LANGUAGE': 'en_US:en', 18:51:57 INFO - 'LOGNAME': 'cltbld', 18:51:57 INFO - 'MAIL': '/var/mail/cltbld', 18:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:57 INFO - 'MOZ_NO_REMOTE': '1', 18:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:57 INFO - 'NO_EM_RESTART': '1', 18:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:57 INFO - 'PWD': '/builds/slave/test', 18:51:57 INFO - 'SHELL': '/bin/bash', 18:51:57 INFO - 'SHLVL': '1', 18:51:57 INFO - 'TERM': 'linux', 18:51:57 INFO - 'TMOUT': '86400', 18:51:57 INFO - 'USER': 'cltbld', 18:51:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', 18:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:57 INFO - '_': '/tools/buildbot/bin/python'} 18:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:51:58 INFO - Cleaning up... 18:51:58 INFO - Return code: 0 18:51:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:51:58 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')]} 18:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:58 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')]} 18:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:58 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 0x7f444d80ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ef60>, '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 0x2a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a601d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', '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 18:51:58 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 18:51:58 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 18:51:58 INFO - Using env: {'DISPLAY': ':0', 18:51:58 INFO - 'HOME': '/home/cltbld', 18:51:58 INFO - 'LANG': 'en_US.UTF-8', 18:51:58 INFO - 'LANGUAGE': 'en_US:en', 18:51:58 INFO - 'LOGNAME': 'cltbld', 18:51:58 INFO - 'MAIL': '/var/mail/cltbld', 18:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:58 INFO - 'MOZ_NO_REMOTE': '1', 18:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:58 INFO - 'NO_EM_RESTART': '1', 18:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:58 INFO - 'PWD': '/builds/slave/test', 18:51:58 INFO - 'SHELL': '/bin/bash', 18:51:58 INFO - 'SHLVL': '1', 18:51:58 INFO - 'TERM': 'linux', 18:51:58 INFO - 'TMOUT': '86400', 18:51:58 INFO - 'USER': 'cltbld', 18:51:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', 18:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:58 INFO - '_': '/tools/buildbot/bin/python'} 18:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:58 INFO - Downloading/unpacking blobuploader==1.2.4 18:51:58 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 18:51:58 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 18:51:58 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 18:51:58 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 18:51:58 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 18:51:58 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 18:52:00 INFO - Downloading blobuploader-1.2.4.tar.gz 18:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:52:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:52:00 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 18:52:00 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 18:52:00 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 18:52:00 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 18:52:00 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 18:52:00 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 18:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:52:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:52:00 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 18:52:00 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 18:52:00 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 18:52:00 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 18:52:00 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 18:52:00 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 18:52:00 INFO - Downloading docopt-0.6.1.tar.gz 18:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:52:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:52:01 INFO - Running setup.py install for blobuploader 18:52:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:52:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:52:01 INFO - Running setup.py install for requests 18:52:01 INFO - Running setup.py install for docopt 18:52:01 INFO - Successfully installed blobuploader requests docopt 18:52:01 INFO - Cleaning up... 18:52:01 INFO - Return code: 0 18:52:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52: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')]} 18:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52: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')]} 18:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:01 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 0x7f444d80ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ef60>, '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 0x2a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a601d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', '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 18:52:01 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 18:52:01 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 18:52:01 INFO - Using env: {'DISPLAY': ':0', 18:52:01 INFO - 'HOME': '/home/cltbld', 18:52:01 INFO - 'LANG': 'en_US.UTF-8', 18:52:01 INFO - 'LANGUAGE': 'en_US:en', 18:52:01 INFO - 'LOGNAME': 'cltbld', 18:52:01 INFO - 'MAIL': '/var/mail/cltbld', 18:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:01 INFO - 'MOZ_NO_REMOTE': '1', 18:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:01 INFO - 'NO_EM_RESTART': '1', 18:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:01 INFO - 'PWD': '/builds/slave/test', 18:52:01 INFO - 'SHELL': '/bin/bash', 18:52:01 INFO - 'SHLVL': '1', 18:52:01 INFO - 'TERM': 'linux', 18:52:01 INFO - 'TMOUT': '86400', 18:52:01 INFO - 'USER': 'cltbld', 18:52:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', 18:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:01 INFO - '_': '/tools/buildbot/bin/python'} 18:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:52:01 INFO - Running setup.py (path:/tmp/pip-ogDXqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:52:01 INFO - Running setup.py (path:/tmp/pip-w5dl06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:52:02 INFO - Running setup.py (path:/tmp/pip-VBTC06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:52:02 INFO - Running setup.py (path:/tmp/pip-2HtZJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:52:02 INFO - Running setup.py (path:/tmp/pip-PkcCux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:52:02 INFO - Running setup.py (path:/tmp/pip-vPRfdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:52:02 INFO - Running setup.py (path:/tmp/pip-5Fp8ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:52:02 INFO - Running setup.py (path:/tmp/pip-kRPr_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:52:02 INFO - Running setup.py (path:/tmp/pip-Bfwu0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:52:02 INFO - Running setup.py (path:/tmp/pip-PKk7Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:52:02 INFO - Running setup.py (path:/tmp/pip-sYSY4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:52:02 INFO - Running setup.py (path:/tmp/pip-dLL2Zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:52:02 INFO - Running setup.py (path:/tmp/pip-8ZQAnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:52:02 INFO - Running setup.py (path:/tmp/pip-41LtPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:02 INFO - Running setup.py (path:/tmp/pip-KtdxVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:52:02 INFO - Running setup.py (path:/tmp/pip-67JY9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:52:03 INFO - Running setup.py (path:/tmp/pip-HgB3Zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:52:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:52:03 INFO - Running setup.py install for manifestparser 18:52:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:52:03 INFO - Running setup.py install for mozcrash 18:52:03 INFO - Running setup.py install for mozdebug 18:52:03 INFO - Running setup.py install for mozdevice 18:52:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:52:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:52:03 INFO - Running setup.py install for mozfile 18:52:03 INFO - Running setup.py install for mozhttpd 18:52:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:52:03 INFO - Running setup.py install for mozinfo 18:52:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:52:03 INFO - Running setup.py install for mozInstall 18:52:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:52:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:52:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:52:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:52:03 INFO - Running setup.py install for mozleak 18:52:03 INFO - Running setup.py install for mozlog 18:52:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:52:04 INFO - Running setup.py install for moznetwork 18:52:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:52:04 INFO - Running setup.py install for mozprocess 18:52:04 INFO - Running setup.py install for mozprofile 18:52:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:52:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:52:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:52:04 INFO - Running setup.py install for mozrunner 18:52:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:52:04 INFO - Running setup.py install for mozscreenshot 18:52:04 INFO - Running setup.py install for moztest 18:52:04 INFO - Running setup.py install for mozversion 18:52:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:52:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:52:04 INFO - Cleaning up... 18:52:04 INFO - Return code: 0 18:52:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52:04 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')]} 18:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:04 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')]} 18:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:04 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 0x7f444d80ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ef60>, '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 0x2a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a601d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', '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 18:52:04 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 18:52:04 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 18:52:04 INFO - Using env: {'DISPLAY': ':0', 18:52:04 INFO - 'HOME': '/home/cltbld', 18:52:04 INFO - 'LANG': 'en_US.UTF-8', 18:52:04 INFO - 'LANGUAGE': 'en_US:en', 18:52:04 INFO - 'LOGNAME': 'cltbld', 18:52:04 INFO - 'MAIL': '/var/mail/cltbld', 18:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:04 INFO - 'MOZ_NO_REMOTE': '1', 18:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:04 INFO - 'NO_EM_RESTART': '1', 18:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:04 INFO - 'PWD': '/builds/slave/test', 18:52:04 INFO - 'SHELL': '/bin/bash', 18:52:04 INFO - 'SHLVL': '1', 18:52:04 INFO - 'TERM': 'linux', 18:52:04 INFO - 'TMOUT': '86400', 18:52:04 INFO - 'USER': 'cltbld', 18:52:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', 18:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:04 INFO - '_': '/tools/buildbot/bin/python'} 18:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:52:05 INFO - Running setup.py (path:/tmp/pip-N00hqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:52:05 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)) 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:52:05 INFO - Running setup.py (path:/tmp/pip-Lw4l32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:52:05 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)) 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:52:05 INFO - Running setup.py (path:/tmp/pip-npOtJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:52:05 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)) 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:52:05 INFO - Running setup.py (path:/tmp/pip-x__f6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:52:05 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)) 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:52:05 INFO - Running setup.py (path:/tmp/pip-iW1iKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:52:05 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)) 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:52:05 INFO - Running setup.py (path:/tmp/pip-umy1y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:52:05 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)) 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:52:05 INFO - Running setup.py (path:/tmp/pip-gkV5LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:52:05 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)) 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:52:05 INFO - Running setup.py (path:/tmp/pip-UxmdCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:52:05 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)) 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:52:05 INFO - Running setup.py (path:/tmp/pip-swJMEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:52:05 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)) 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:52:05 INFO - Running setup.py (path:/tmp/pip-7HdYct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:52:05 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)) 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:52:05 INFO - Running setup.py (path:/tmp/pip-h90216-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:52:05 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)) 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:52:05 INFO - Running setup.py (path:/tmp/pip-pRtnfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:52:05 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)) 18:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:52:05 INFO - Running setup.py (path:/tmp/pip-51Z0Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:52:06 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)) 18:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:52:06 INFO - Running setup.py (path:/tmp/pip-cHYw7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:52:06 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)) 18:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:06 INFO - Running setup.py (path:/tmp/pip-O9YQwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:06 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)) 18:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:52:06 INFO - Running setup.py (path:/tmp/pip-fJmyZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:52:06 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)) 18:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:52:06 INFO - Running setup.py (path:/tmp/pip-3MPxTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:52:06 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)) 18:52:06 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)) 18:52:06 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)) 18:52:06 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)) 18:52:06 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)) 18:52:06 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)) 18:52:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:52:06 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 18:52:06 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 18:52:06 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 18:52:06 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 18:52:06 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 18:52:06 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 18:52:08 INFO - Downloading blessings-1.6.tar.gz 18:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:52:08 INFO - Installing collected packages: blessings 18:52:08 INFO - Running setup.py install for blessings 18:52:08 INFO - Successfully installed blessings 18:52:08 INFO - Cleaning up... 18:52:08 INFO - Return code: 0 18:52:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:52:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:52:08 INFO - Reading from file tmpfile_stdout 18:52:08 INFO - Current package versions: 18:52:08 INFO - argparse == 1.2.1 18:52:08 INFO - blessings == 1.6 18:52:08 INFO - blobuploader == 1.2.4 18:52:08 INFO - docopt == 0.6.1 18:52:08 INFO - functools32 == 3.2.3-2 18:52:08 INFO - jsonschema == 2.5.1 18:52:08 INFO - manifestparser == 1.1 18:52:08 INFO - mozInstall == 1.12 18:52:08 INFO - mozcrash == 0.17 18:52:08 INFO - mozdebug == 0.1 18:52:08 INFO - mozdevice == 0.48 18:52:08 INFO - mozfile == 1.2 18:52:08 INFO - mozhttpd == 0.7 18:52:08 INFO - mozinfo == 0.9 18:52:08 INFO - mozleak == 0.1 18:52:08 INFO - mozlog == 3.4 18:52:08 INFO - moznetwork == 0.27 18:52:08 INFO - mozprocess == 0.23 18:52:08 INFO - mozprofile == 0.28 18:52:08 INFO - mozrunner == 6.12 18:52:08 INFO - mozscreenshot == 0.1 18:52:08 INFO - mozsystemmonitor == 0.3 18:52:08 INFO - moztest == 0.7 18:52:08 INFO - mozversion == 1.4 18:52:08 INFO - psutil == 3.1.1 18:52:08 INFO - requests == 1.2.3 18:52:08 INFO - wsgiref == 0.1.2 18:52:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:08 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 0x7f444d80ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ef60>, '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 0x2a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a601d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', '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 18:52:08 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 18:52:08 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 18:52:08 INFO - Using env: {'DISPLAY': ':0', 18:52:08 INFO - 'HOME': '/home/cltbld', 18:52:08 INFO - 'LANG': 'en_US.UTF-8', 18:52:08 INFO - 'LANGUAGE': 'en_US:en', 18:52:08 INFO - 'LOGNAME': 'cltbld', 18:52:08 INFO - 'MAIL': '/var/mail/cltbld', 18:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:08 INFO - 'MOZ_NO_REMOTE': '1', 18:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:08 INFO - 'NO_EM_RESTART': '1', 18:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:08 INFO - 'PWD': '/builds/slave/test', 18:52:08 INFO - 'SHELL': '/bin/bash', 18:52:08 INFO - 'SHLVL': '1', 18:52:08 INFO - 'TERM': 'linux', 18:52:08 INFO - 'TMOUT': '86400', 18:52:08 INFO - 'USER': 'cltbld', 18:52:08 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', 18:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:08 INFO - '_': '/tools/buildbot/bin/python'} 18:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:08 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)) 18:52:08 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)) 18:52:08 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)) 18:52:08 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)) 18:52:08 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)) 18:52:08 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)) 18:52:08 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)) 18:52:08 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)) 18:52:08 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)) 18:52:08 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)) 18:52:08 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)) 18:52:08 INFO - Cleaning up... 18:52:08 INFO - Return code: 0 18:52:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f444d80ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ef60>, '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 0x2a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a601d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', '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 18:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:52:08 INFO - Using env: {'DISPLAY': ':0', 18:52:08 INFO - 'HOME': '/home/cltbld', 18:52:08 INFO - 'LANG': 'en_US.UTF-8', 18:52:08 INFO - 'LANGUAGE': 'en_US:en', 18:52:08 INFO - 'LOGNAME': 'cltbld', 18:52:08 INFO - 'MAIL': '/var/mail/cltbld', 18:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:08 INFO - 'MOZ_NO_REMOTE': '1', 18:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:08 INFO - 'NO_EM_RESTART': '1', 18:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:08 INFO - 'PWD': '/builds/slave/test', 18:52:08 INFO - 'SHELL': '/bin/bash', 18:52:08 INFO - 'SHLVL': '1', 18:52:08 INFO - 'TERM': 'linux', 18:52:08 INFO - 'TMOUT': '86400', 18:52:08 INFO - 'USER': 'cltbld', 18:52:08 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', 18:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:08 INFO - '_': '/tools/buildbot/bin/python'} 18:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:52:09 INFO - Cleaning up... 18:52:09 INFO - Return code: 0 18:52:09 INFO - Running post-action listener: _resource_record_post_action 18:52:09 INFO - Running post-action listener: _start_resource_monitoring 18:52:09 INFO - Starting resource monitoring. 18:52:09 INFO - [mozharness: 2016-11-30 02:52:09.236159Z] Finished create-virtualenv step (success) 18:52:09 INFO - [mozharness: 2016-11-30 02:52:09.236613Z] Running install step. 18:52:09 INFO - Running pre-action listener: _resource_record_pre_action 18:52:09 INFO - Running main action method: install 18:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:52:09 INFO - Reading from file tmpfile_stdout 18:52:09 INFO - Detecting whether we're running mozinstall >=1.0... 18:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:52:09 INFO - Reading from file tmpfile_stdout 18:52:09 INFO - Output received: 18:52:09 INFO - Usage: mozinstall [options] installer 18:52:09 INFO - Options: 18:52:09 INFO - -h, --help show this help message and exit 18:52:09 INFO - -d DEST, --destination=DEST 18:52:09 INFO - Directory to install application into. [default: 18:52:09 INFO - "/builds/slave/test"] 18:52:09 INFO - --app=APP Application being installed. [default: firefox] 18:52:09 INFO - mkdir: /builds/slave/test/build/application 18:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:52:23 INFO - Reading from file tmpfile_stdout 18:52:23 INFO - Output received: 18:52:23 INFO - /builds/slave/test/build/application/firefox/firefox 18:52:23 INFO - Running post-action listener: _resource_record_post_action 18:52:23 INFO - [mozharness: 2016-11-30 02:52:23.041737Z] Finished install step (success) 18:52:23 INFO - [mozharness: 2016-11-30 02:52:23.041983Z] Running run-tests step. 18:52:23 INFO - Running pre-action listener: _resource_record_pre_action 18:52:23 INFO - Running main action method: run_tests 18:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:52:23 INFO - Python 2.7.3 18:52:23 INFO - Return code: 0 18:52:23 INFO - grabbing minidump binary from tooltool 18:52:23 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')]} 18:52:23 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 0x2a5ef60>, '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 0x2a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a601d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:52:23 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 18:52:23 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 18:52:23 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 18:52:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:52:23 INFO - Return code: 0 18:52:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:52:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:52:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:52:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:52:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 18:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 18:52:23 INFO - Using env: {'DISPLAY': ':0', 18:52:23 INFO - 'HOME': '/home/cltbld', 18:52:23 INFO - 'LANG': 'en_US.UTF-8', 18:52:23 INFO - 'LANGUAGE': 'en_US:en', 18:52:23 INFO - 'LOGNAME': 'cltbld', 18:52:23 INFO - 'MAIL': '/var/mail/cltbld', 18:52:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:52:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:23 INFO - 'MOZ_NO_REMOTE': '1', 18:52:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:23 INFO - 'NO_EM_RESTART': '1', 18:52:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:23 INFO - 'PWD': '/builds/slave/test', 18:52:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:52:23 INFO - 'SHELL': '/bin/bash', 18:52:23 INFO - 'SHLVL': '1', 18:52:23 INFO - 'TERM': 'linux', 18:52:23 INFO - 'TMOUT': '86400', 18:52:23 INFO - 'USER': 'cltbld', 18:52:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382', 18:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:23 INFO - '_': '/tools/buildbot/bin/python'} 18:52:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 18:52:23 INFO - mozversion application_buildid: 20161129155626 18:52:23 INFO - mozversion application_changeset: 078cccdeb2e1b36b9b6d099e713f54639789527d 18:52:23 INFO - mozversion application_display_name: Firefox 18:52:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:52:23 INFO - mozversion application_name: Firefox 18:52:23 INFO - mozversion application_remotingname: firefox 18:52:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:52:23 INFO - mozversion application_vendor: Mozilla 18:52:23 INFO - mozversion application_version: 51.0 18:52:23 INFO - mozversion platform_buildid: 20161129155626 18:52:23 INFO - mozversion platform_changeset: 078cccdeb2e1b36b9b6d099e713f54639789527d 18:52:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:52:23 INFO - mozversion platform_version: 51.0 18:52:23 INFO - using testdate: 1480474343 18:52:23 INFO - actual date: 1480474343 18:52:23 INFO - starting webserver on 'localhost:49182' 18:52:23 INFO - SUITE-START | Running 2 tests 18:52:23 INFO - TEST-START | dromaeo_css 18:52:23 INFO - operating with platform_type : linux_ 18:52:23 INFO - Initialising browser for dromaeo_css test... 18:52:23 INFO - TEST-INFO | started process 2578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV0hx6C/profile http://localhost:49182/getInfo.html) 18:52:27 INFO - PROCESS | 2578 | __metrics Screen width/height:1600/1200 18:52:27 INFO - PROCESS | 2578 | colorDepth:24 18:52:27 INFO - PROCESS | 2578 | Browser inner width/height: 1024/697 18:52:27 INFO - PROCESS | 2578 | __metrics 18:52:27 INFO - PROCESS | 2578 | 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" 18:52:27 INFO - PROCESS | 2578 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:52:28 INFO - PROCESS | 2578 | console.error: PushService: 18:52:28 INFO - PROCESS | 2578 | stateChangeProcessEnqueue: Error transitioning state 18:52:28 INFO - PROCESS | 2578 | UnknownError 18:52:28 INFO - TEST-INFO | 2578: exit 0 18:52:28 INFO - Browser initialized. 18:52:28 INFO - Running cycle 1/1 for dromaeo_css test... 18:52:28 INFO - TEST-INFO | started process 2672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV0hx6C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:52:40 INFO - PROCESS | 2672 | RSS: Main: 142880768 18:52:40 INFO - PROCESS | 2672 | 18:53:31 INFO - PROCESS | 2672 | 1480474411677 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] 18:55:41 INFO - PROCESS | 2672 | Cycle 1(1): loaded http://localhost:49182/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49182/tests/dromaeo/cssquery-ext.html) 18:55:42 INFO - PROCESS | 2672 | RSS: Main: 250949632 18:55:42 INFO - PROCESS | 2672 | 18:58:44 INFO - PROCESS | 2672 | Cycle 1(1): loaded http://localhost:49182/tests/dromaeo/cssquery-ext.html (next: http://localhost:49182/tests/dromaeo/cssquery-jquery.html) 18:58:44 INFO - PROCESS | 2672 | RSS: Main: 240926720 18:58:44 INFO - PROCESS | 2672 | 19:01:46 INFO - PROCESS | 2672 | Cycle 1(1): loaded http://localhost:49182/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49182/tests/dromaeo/cssquery-mootools.html) 19:01:47 INFO - PROCESS | 2672 | RSS: Main: 198111232 19:01:47 INFO - PROCESS | 2672 | 19:04:49 INFO - PROCESS | 2672 | Cycle 1(1): loaded http://localhost:49182/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49182/tests/dromaeo/cssquery-prototype.html) 19:04:49 INFO - PROCESS | 2672 | RSS: Main: 224620544 19:04:49 INFO - PROCESS | 2672 | 19:07:52 INFO - PROCESS | 2672 | Cycle 1(1): loaded http://localhost:49182/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49182/tests/dromaeo/cssquery-yui.html) 19:07:53 INFO - PROCESS | 2672 | RSS: Main: 174080000 19:07:53 INFO - PROCESS | 2672 | 19:10:55 INFO - PROCESS | 2672 | Cycle 1(1): loaded http://localhost:49182/tests/dromaeo/cssquery-yui.html (next: http://localhost:49182/tests/dromaeo/cssquery-dojo.html) 19:10:55 INFO - PROCESS | 2672 | RSS: Main: 263516160 19:10:55 INFO - PROCESS | 2672 | 19:10:55 INFO - PROCESS | 2672 | __start_tp_report 19:10:55 INFO - PROCESS | 2672 | _x_x_mozilla_page_load 19:10:55 INFO - PROCESS | 2672 | _x_x_mozilla_page_load_details 19:10:55 INFO - PROCESS | 2672 | |i|pagename|runs| 19:10:55 INFO - PROCESS | 2672 | |0;dojo.html;3126.890558830441;3137.890173843916;3158.352537729765;3164.129864287322;3204.391165678521;5637.633553818999;5750.108733146359;5753.913691294634;5761.596688231825;5771.884562308751;5656.575756818234;5701.857453563653;5711.7144142792795;5717.714114294289;5733.913991290134;5138.794448222076;5191;5192.480751924815;5207.4792520747815;5253.185756207794;5239.161734122522;5277.12927366984;5284.313039304885;5316.680999140045;5347.46525347466;5184.481551844823;5190.7664155112925;5195.298634684326;5202.115640341132;5224.869378265555;5264.657797243167;5292.153255479124;5299.6025298102795;5370.43610420904;5374.5700343972385;5197.714125723083;5228.660137091115;5292.629515933848;5310.734463276821;5313;5520.723963801794;5568.805091821767;5637.3517045539875;5685.800996965087;5689.6586204827845;6149.292831324366;6238.313785483639;6245.219347581552;6272.874542509125;6275.02737075754;6290.779822706229;6307.211598550181;6316.6841657917375;6318.810435686891;6326.240851097898;5713;5756.971215143939;5764.596478246524;5787.016207244778;5789.421057894261;6381.361863813674;6383.1382763326355;6409.230892292955;6416.679166041679;6419.101325814389;5897.410258974069;6132.6933653317155;6150.692465376803;6151.938480615226;6154.661493617894;6034.969825150934;6101.389861013952;6115.240341084264;6137.96931015342;6170.7223174957235;6153.384661533811;6164.660943648053;6167.167432396659;6180.7527698891545;6184.536159788034;6142.662153581596;6177.382261773877;6200.100985357098;6202.72087756052;6203.844903877349;4394.318880573516;4637.652176086807;4648.093621743727;4689.50760170184;4715.552022557851;4182.790860456965;4183.205191013698;4184.03767133561;4187.685923555746;4210.34739615354;5916.26046744157;5928.762849485972;5931.406859314034;5932.3474417814;5933.940660593339;6094.360092190344;6109.131392048963;6110.4980065817745;6138.265785110703;6305.495560355161;5863.618864773776;5867.119932010147;5871.94128058714;5895.941040589625;5905.143754155623;5299.5760339172775;5299.920501192408;5346.759395827197;5350.357957045179;5362.490563396471;6074.271087469532;6116.113163591254;6219.875602488016;6230.345813689679;6286.717097730613;6189;6190.969045154746;6193.597416167935;6195.938040619536;6202.131701561875;6390.329015453311;6391.137196478602;6395.072714456471;6398.360163983751;6461.515386345949;5885.646861188342;5903.586748927534;6053.122297266959;6133.815985520441;6135.355787642234;6117.492485019787;6251.71867265965;6259.061140828912;6263.4362907338555;6264.59280146789;6063.242094738158;6096.8780624388155;6117.021276595723;6118.051701986199;6122.724477398617;5934;5968.970155149196;6053.3946605339115;6071.848203794763;6084.8783024340155;5984.850378740566;6027.065804800263;6027.819165425044;6100.938990610037;6128.356522565245;6121.816345509642;6126.417990290915;6128.63228206309;6133.6319820810895;6135.538906164888;5730.283714535683;5757.65454072757;5970.134330522137;5970.522358211246;5988.760449581968 19:10:55 INFO - PROCESS | 2672 | |1;ext.html;590.9852253693657;627.6955676496899;637.9681015949201;648.0635481728903;651.3258777165631;34586.30827383451;37398.25203495932;37568.436473452886;47656;48387.51612483874;49076;49691;49709.75145124278;49759.75120124394;49794;9252.1210485004;9412.670556530522;9423.10480504351;9429.057094290585;9430.622775088988;8662.913370866305;8843.425177363451;8856;9075.500847453388;9220.077992200793;11133.7216569586;11404.087672986183;11415.486303116339;11740.119491038206;11742.941285293562;11278.830817537702;11357.204995650307;11357.943210283896;11367.374794386305;11372.37451940143;10944.507497162647;11001.834972475419;11019.504122314514;11033.724156896142;11044.282121662067;45927;46224.53775462236;46246.53753462456;46402.767986160194;46454.53545464536;3832.7891965941863;4050.594940505926;4079.1637714268504;4213.978930105361;4490.416245888046;34715.82642086798;34919.82540087309;34965.12587185315;35522.64477355245;36624.81687591572;4692.249240121564;4736.857894263143;4761.2143996240575;4786.449558300805;4811.350467686888;386936.06531967444;390182;391213;391395;392372;66864.33135668679;67190;67438.66280668565;67483.32516674869;67588.32411675919;41025.58974410278;41674;41970.790146049076;44317.77841110774;69834;20007.59984800296;20152.69770953437;20182.596348072955;20198.798012019986;20208;15129.319180636898;15188.392464301525;15233.23833808305;15236.23818809055;15240.695186096216;18886.338978135973;19271.325503607586;20467.8976605116;21068;21074.05166767499;7738.7678369649;7766.728164514215;7781.766547003599;7861;7956.761297161094;990.5047476261869;1056.8731752189785;1063.7234319077095;1100.8128618134936;1115.9609413670482;34283.65716342805;34300.14249643729;34520.309593807986;34555;34572.65427345745;1132.5073592987078;1142.2518250545907;1152.4295473740385;1164.598213616301;1190.2501424102759;17574.912125439547;18070.5482362942;18167.63664726698;18248;18272.177752000927;641352;644189;645557;649529;650172;65132;65246.347536524976;65282.34717652858;65370;65376;1419.7231539849631;1442.4951267056447;1455.7234125516118;1456.8907331950147;1469.3681716861852;31841.522377164823;34234.65765342315;34317.14207144841;34577.654223457444;34776.65223347734;56936.71531642315;57493.42506575048;57497;57887.131693023795;57961.71019144877;467714;468355;469077;469142;469674;27900.72099278981;30483.847580762842;32386.35227295488;32482.675173247964;32657.673423266413;52054.1781037677;52397;52897.206541901134;53443.198352023974;53632.46367536275;43999.78000109979;44570.331445029;45162.77418612886;45456.09087818291;45961.31058034065;44027.77986110177;45251.32123018092;45856;46288.53711462842;47188;40609.59390406058;43942.56057439385;44352;44844.55155448404;44924.101517968804;36676.81661591675;39639.40540891831;40156;40672.38991415072;40678;28667.28331791722;29302.12093637109;29389.412211756073;29473.263168420963;29587.408251835273 19:10:55 INFO - PROCESS | 2672 | |2;jquery.html;401.20160879849107;402.4104786094924;412.4658567155534;413.3943772373473;422.0714428257834;19362.612747745054;20882.89558552209;20991.37025889222;21140.471488212763;21163.57672846544;19750.70373944392;20487.282945096926;20820.16719331225;20888.268910588133;21094.367168984918;5731.885362292762;5976.8505787355225;5985.311689155759;5988.670623115727;5992.880142397149;5744.195812586241;5889.499392551638;5897.233359663238;5918.911216331759;5974.641521508702;5863.530917526609;5873;5875.206847075633;5879.382664820197;5881.823545293648;5697.344805347376;5876.4123587641325;5912.526997840162;5914.585978981473;5917.940820591782;5300.125479295912;5303.496167864047;5307.840764777025;5312.1766126250495;5314.229436731653;22308.330750077523;22786;24542.50914981708;24707.25878223656;24963.251102466773;2463.2117722328862;2506.749325067497;2717.91846244613;3142.607174103237;3288.5067239914206;11505.884941150649;12799.87200127996;14715.705685886329;15401.075935443909;15615.375384984587;2006.1173083843062;2009.1461129020108;2061.505238742706;2082.7084208210863;2175.7824217578273;84671.57664211701;85527.57236213778;88059.55970220108;88222.5588872058;88226.99999999936;11910.94044529789;11992.880071199352;12004.639860804189;12056.336901470328;12149.392530373623;17405.216765245594;17443.302267909396;17446.389376371768;17454.389096381565;17455.912720436572;8615.827683446296;8864.601092950832;8933.910660893438;8971.596278167499;9083.636654533877;8437.156284371515;8497.49015059086;8535.701250456328;8706;8744.43161194533;5204.635675502755;5239.1093514102695;5242;5309.681419114865;5372.764264219251;2106.7050612914204;2114;2127.606392817334;2152.3865698275918;2230.721159855018;984.6110786239539;1001.5392919257077;1033.679559336608;1039.3711804358406;1053.7154968158554;18935.81064189368;19234;20067.59864802725;20285.89857050705;21183.78816211818;1001.1690297053428;1005.2962925951863;1010.7574182196367;1020.5101551255439;1079.8272276435732;10771.78456430867;11578.36319002463;11594.420278986017;11608.88391116078;11611.477483513263;492087;496445;498102;498179;530178;66345.44975249727;92537.53731231301;97077;106846;107408;987.7086259553449;1036.5439206749006;1102.0577406317484;1102.2064113838023;1110.6445937299986;18860.905695471985;18962.336318228794;19146.52133696669;19273.132709027846;19430.417087487396;47160.52839471561;47568.2864757022;47797.76101119472;48367;48496;63115.6844215776;63775.36224637694;65012.34987650063;65558.67220663866;65705;9079.228265597498;9136;9188.586513607037;9237.39956902826;9300.39547429415;13407.396667149807;13583.185008899498;13679.31603419845;13798.65503362424;14093.506727264497;12106.576269830513;12191.451384687532;12274.509019639114;12305.138640295094;12378.876211238132;11914.582989595323;11985.22096063753;12036.157468977088;12109.333986630467;12287.324197168884;11646.475908583965;11700.180987330805;11728.061755059403;12133.69665758363;12472.251664900135;9196.540172991457;9291.907080929375;9310.581023854078;9434.386764860263;9525.52372381392;11197.88802112001;11454.255473394536;11556.595519157125;11613;11745.942865141837 19:10:55 INFO - PROCESS | 2672 | |3;mootools.html;1491.970160596788;1562.4062856114679;1635.2968223663827;1762.1541660003206;1791.0567034767278;9291.674791382304;9987.051230133126;9999.650012249573;10007;10010.949945250282;8562.100979397152;8761.737147885558;9264;9540.33217674763;9778.902210977889;2526.5199612073693;2550.7321731218235;2551.8596477193746;2555.271747551948;2557.207265747615;2546.2997675639253;2599.493098845726;2599.519088968547;2603.06289735695;2606.6090086487084;2517.3580736912154;2535.1000394859834;2584.5606246938064;2594.092067776282;2603.687557493094;2482.2429159106464;2485.72657007729;2502.186789293478;2528.355269406308;2529.759672831078;2446.755324467557;2451.301379106964;2451.889664965063;2453.5338285725657;2483.3915690655904;9676.17752491039;9737.464439455827;9741.561629726679;9823.28092583795;9865.950670246675;5740.052891272935;5891.911621325684;5898.734556944948;5901.203337549418;5902;3396.3546926083964;3488.9127771805656;3548.7870727756417;3585.587657419378;3603.5315408996926;1272.8154417609487;1350.0751984890383;1380.4340220509644;1381.7581923163407;1388.1740364483117;13662.658433539242;13693.931530342385;13733.519326823613;13753.931230343784;13760.724785504333;5053.418856831438;5153.948460515422;5315.255864179018;5401.135818269058;5405.837824865261;11549.422528873523;11555.075593952632;11559.422028898522;11559.479823407966;11562.30626162433;5977.402259773988;5996.610220335664;6002.39976002405;6016.488598469179;6045.546584006129;4863.683860549053;5086.694798312114;5462.0987537056735;5498.615096943176;5514.6691198528215;4415.867523974286;4502.57225563571;4533.478649955231;4564.497905230422;4602.677812553089;1444;1472.8158980127484;1474.8303945046243;1474.852514748538;1486.2048803890084;873.4104479476455;958.726762872578;988.4958671077659;996.3125443444001;1006.285537268533;5904.084866845646;6034.094885767082;6131.478824299896;6280.842978925472;6293.653849038347;539.7166487594045;993.4883534979347;1059.0838924330553;1153.8269259610959;1166.912481563886;4096.692748043909;4237.851675191354;4244.702870799015;4299.957000429956;4416.29339305716;12138.271703697807;12578.182418142791;12589.622311330675;12591.748165036648;12607.180533265491;12028.578999734968;12270;12418.503259869685;12431.751364972832;12493.937530312473;8929.285657147413;9059.909400906039;9061.456312621396;9064.730937668732;9068.773280668036;6158.969205154125;6227.813165605039;6262.436380725757;6328.272248691459;6392.20097487814;11012.50443730018;11096.5561377544;11118.499667515143;11131.165162612675;11135.72160695989;11036.282641628268;11199.72000699989;11321;11385.089192864716;11495.655130346104;7463.514871533333;7708.113566939874;7712.614369281626;8105.067917189363;8399.790005249917;8896.110388961051;9181.311401644769;9352.906470935475;9442.055794420503;9695.951520242354;8682.91317086821;8707.129287071242;8724.607392667473;8859.822803544022;8869.423487473552;8336.499810011419;8490.278326342082;8501.14988501145;8501.362397820065;8638.222559969632;7905.841883162419;7910.683572657029;7913.366930645419;7917.920820791718;7936.127026027248;5434.673919564839;5516.448355164612;5522.22688823557;5563.05428077236;5661.065924122474;5439.184122381675;5533.750981205775;5578.051731205786;5604.327480702342;5617.719114044363 19:10:55 INFO - PROCESS | 2672 | |4;prototype.html;331.64679616208736;333.42983498218047;338.93405240518575;341.81541967337637;345.9775114617551;5418;5507.339119305679;5541.335039795225;5620.690862002588;5686.175504551838;5334.879675268188;5428.4300148484335;5445.420827959887;5455.672659640424;5462.426445223254;4369.912601747963;4374.650027997753;4380.6276466500385;4386.956130438687;4404.207242696313;4174.895627609319;4311.5472875348105;4355.651547876162;4394.582979361355;4396.812860527655;4314.935275970863;4321.28698764705;4324.372965919955;4326.632236259906;4326.913461730764;4307.784610769465;4335.523092459827;4338.349247612868;4338.804753786056;4369.300911854088;3729.962700372989;3817.2174704185577;3826.0243637872163;3843.6348546888003;3852.6917846572205;5286.123426183688;5365.302510673588;5373.919391209135;5381.246625472437;5397.084035167538;4959.6528243023;4963.255511673242;4966.379202599675;4972.975135124338;5003.724795136266;5600.775968961237;5767.971160144214;5768.798092066758;5784.797532086357;5816.447437493432;4221.387898754694;4234.153169366139;4237.7669228192435;4249.086446414036;4264.275073237526;5788.652680839121;6032.306284777263;6046.727897244635;6047.21386219793;6052;4231.217224813419;4248.851290204828;4251.702380833374;4272.9489844874015;4289.1850548395705;4345.283028300295;4361.302191649321;4368.759718215529;4369.279068953587;4386.122775444924;4971.279164521125;4982.950170498321;4983.950160498349;4999.3000979862845;5023.120953833065;5498.505134537911;5659.5755318351285;5789.305283366023;5810.477057064884;5867.266591676041;1422.9359678814478;1443.603009172486;1468.2952182952242;1477.6774786565963;1487.6206567325262;998.2962011781676;1000.314784372707;1019.2508506247901;1019.7909428567274;1026.2508368890751;5499.587530935196;5517.5585953123655;5517.69652669107;5527.447255274521;5556.91664625031;5823.388544202882;5843.561732870052;5845.590808643354;5876.236089308362;5912.645241285537;5463.945360546423;5611.382747897728;5620.185073164368;5675.574331925122;5715.371309155989;3144.7641426893074;3183.2996740717003;3197.328561002169;3204.5353423753427;3210.6628803975714;6094.775406976421;6104.908426373608;6220.294172035179;6246.93802053652;6250.343713909974;6137.36093479799;6157.415045570664;6158.876822463526;6159.552505161283;6169.691515424211;6133.9079913802225;6209.423089417931;6217.160683307786;6218.720157592919;6240.31356550779;5844.181814546052;5879.382664820132;5953.499530197241;5953.6780655545235;5960.225170727777;5862.970685146547;5877.911831322448;5878.2064421302575;5907.675077870758;5920.496757775637;5841.269841269841;6106.389361063858;6154.78458253959;6180.196574445294;6187.659678717714;4264.95735042658;4272.6154646082;4276.054395250216;4277.935830962476;4303.698741088219;5775.740091695968;5927.436893495111;6017.368176341596;6026.638401695912;6034.39656034393;5750.5112065474905;5835.824925252249;5843.532517398513;5850.561207909339;5865.090910908816;5839.328477225174;5858.209141765807;5863.472287494146;5878.824235152901;5887.764489420547;5665.376808550974;5831.387704290988;5848.853778655568;5863.794767183128;5875.089361149029;5831.35855055952;5835.387284335084;5846.590738648254;5872.148538461985;5891.23413956183;5470.425605311385;5736.483716465538;5746.109353050284;5756.568257380797;5757.65454072757 19:10:55 INFO - PROCESS | 2672 | |5;yui.html;743.2641684732115;749.8762704153814;753.3069575990089;783.5768684910149;868.6525389844065;15514.612134696625;16223.51329460115;16442.42451514197;16464.588385290375;16813.15934203288;14688.045277056985;14807.92596037021;14813.481528146516;14825.18461484618;14830.258487075631;727.4180655475625;858.935579831512;881.4711173296035;883.1830556734994;886;734.9485536012481;840.2941529115542;849.0448245723561;853.0957185383483;862.4997501449144;916.8624706294042;916.880805495288;917.4586993673731;919.0212423768666;921.2998121427696;915.2906497464452;916.2029034739752;916.3356566489275;916.8670542771295;916.9908300916973;679.6397909108181;680;680.0139797293944;680.1735890892589;680.4794332335767;16101.597460063475;16126.032438053755;16138.515844524683;16144;16157.192140392934;16223.73315718634;16403.261853216514;16768.161591920478;16924;17116.400925967533;11217.326960382403;11353.772924541545;11404.315741055563;11512.251703639236;11797.587084452003;3941.152652179795;4017.27689015977;4040.5151381834075;4058.2289365020847;4072.6945479089186;75804;86613.56693216557;86688;86692.13307866904;87167.56416217878;11778.293302401884;11941.52233910634;11986.64040078799;12062.758744825054;12135.393230338625;22407.43981400478;22422.663660045113;22440.551188976457;22453.10187592478;22464.663030054562;8794.824103517894;8846;9003.504807235666;9240.95379523098;9245.399049061789;5144.356955380577;5272.103742363807;5314.813981510629;5456.536194423518;5682.7442765075675;3703.4444833275224;3800.524934383202;3845.192509573021;3859.3439115350457;3865.632764887331;674.919009718827;679.3308591037824;680.7617333933084;685.2120061928822;699.4159876503076;696.7108649910332;724.77169691547;764.825932750794;782.2763943352377;800.2957397490288;9045.592948317342;9578.185854202471;9988.950055249823;10215.489225538693;10312.639057632947;634.6509419819081;649.8148027812051;661.3287513174132;732.6959311885614;741.5031928607846;4696.107739529479;4924.704517728947;4963.982383611423;4968.900621987612;5010.098182327143;128770;129309;131976.34011830072;133404.66488337674;133686;63911;111414;112848.43575782068;113193.43403283096;114592;96794;97461;98428.50785746025;99280.50359748155;99483.99999999856;9144.26845852317;9420.764480888032;9515.238780897373;9570.377925434825;9633.710988670351;40569;51511;57441;58476.4152358471;59060.70469647624;81077;86268.56865715631;86515;87203;89513;12165.08761842883;12281.140320177501;12299.200551964452;12365.567205147776;12497.56258530947;13320.800187996994;13337.799933001206;13709.245991470565;13822.792658110338;14335.283235838375;13072;13286.402111904794;13828.446862125402;13866.168029918237;13942.093763905314;12563.560275390317;12606.810897836724;12739.55411560591;13283.53507627267;13519.391627376988;11977.64067077989;12122.09084318662;12594.181378210387;12625.684357891127;12710.394065092474;10272.794544109225;10419.322744021614;10614.73463163427;10650.094741947021;11357.261777984404;10484.26610137283;10781.838272425763;11094.944525277322;11531.481083351102;11619.825702614637 19:10:55 INFO - PROCESS | 2672 | __end_tp_report 19:10:55 INFO - PROCESS | 2672 | __start_cc_report 19:10:55 INFO - PROCESS | 2672 | _x_x_mozilla_cycle_collect,925 19:10:55 INFO - PROCESS | 2672 | __end_cc_report 19:10:55 INFO - PROCESS | 2672 | __startTimestamp1480475455670__endTimestamp 19:10:55 INFO - PROCESS | 2672 | 19:10:55 INFO - PROCESS | 2672 | ------- Summary: start ------- 19:10:55 INFO - PROCESS | 2672 | Number of tests: 6 19:10:55 INFO - PROCESS | 2672 | 19:10:55 INFO - PROCESS | 2672 | [#0] dojo.html Cycles:165 Average:5730.48 Median:5970.13 stddev:683.61 (11.5%) stddev-sans-first:654.49 19:10:55 INFO - PROCESS | 2672 | Values: 3126.9 3137.9 3158.4 3164.1 3204.4 5637.6 5750.1 5753.9 5761.6 5771.9 5656.6 5701.9 5711.7 5717.7 5733.9 5138.8 5191.0 5192.5 5207.5 5253.2 5239.2 5277.1 5284.3 5316.7 5347.5 5184.5 5190.8 5195.3 5202.1 5224.9 5264.7 5292.2 5299.6 5370.4 5374.6 5197.7 5228.7 5292.6 5310.7 5313.0 5520.7 5568.8 5637.4 5685.8 5689.7 6149.3 6238.3 6245.2 6272.9 6275.0 6290.8 6307.2 6316.7 6318.8 6326.2 5713.0 5757.0 5764.6 5787.0 5789.4 6381.4 6383.1 6409.2 6416.7 6419.1 5897.4 6132.7 6150.7 6151.9 6154.7 6035.0 6101.4 6115.2 6138.0 6170.7 6153.4 6164.7 6167.2 6180.8 6184.5 6142.7 6177.4 6200.1 6202.7 6203.8 4394.3 4637.7 4648.1 4689.5 4715.6 4182.8 4183.2 4184.0 4187.7 4210.3 5916.3 5928.8 5931.4 5932.3 5933.9 6094.4 6109.1 6110.5 6138.3 6305.5 5863.6 5867.1 5871.9 5895.9 5905.1 5299.6 5299.9 5346.8 5350.4 5362.5 6074.3 6116.1 6219.9 6230.3 6286.7 6189.0 6191.0 6193.6 6195.9 6202.1 6390.3 6391.1 6395.1 6398.4 6461.5 5885.6 5903.6 6053.1 6133.8 6135.4 6117.5 6251.7 6259.1 6263.4 6264.6 6063.2 6096.9 6117.0 6118.1 6122.7 5934.0 5969.0 6053.4 6071.8 6084.9 5984.9 6027.1 6027.8 6100.9 6128.4 6121.8 6126.4 6128.6 6133.6 6135.5 5730.3 5757.7 5970.1 5970.5 5988.8 19:10:55 INFO - PROCESS | 2672 | 19:10:55 INFO - PROCESS | 2672 | [#1] ext.html Cycles:180 Average:67171.22 Median:22552.38 stddev:136392.47 (604.8%) stddev-sans-first:136683.47 19:10:55 INFO - PROCESS | 2672 | Values: 591.0 627.7 638.0 648.1 651.3 34586.3 37398.3 37568.4 47656.0 48387.5 49076.0 49691.0 49709.8 49759.8 49794.0 9252.1 9412.7 9423.1 9429.1 9430.6 8662.9 8843.4 8856.0 9075.5 9220.1 11133.7 11404.1 11415.5 11740.1 11742.9 11278.8 11357.2 11357.9 11367.4 11372.4 10944.5 11001.8 11019.5 11033.7 11044.3 45927.0 46224.5 46246.5 46402.8 46454.5 3832.8 4050.6 4079.2 4214.0 4490.4 34715.8 34919.8 34965.1 35522.6 36624.8 4692.2 4736.9 4761.2 4786.4 4811.4 386936.1 390182.0 391213.0 391395.0 392372.0 66864.3 67190.0 67438.7 67483.3 67588.3 41025.6 41674.0 41970.8 44317.8 69834.0 20007.6 20152.7 20182.6 20198.8 20208.0 15129.3 15188.4 15233.2 15236.2 15240.7 18886.3 19271.3 20467.9 21068.0 21074.1 7738.8 7766.7 7781.8 7861.0 7956.8 990.5 1056.9 1063.7 1100.8 1116.0 34283.7 34300.1 34520.3 34555.0 34572.7 1132.5 1142.3 1152.4 1164.6 1190.3 17574.9 18070.5 18167.6 18248.0 18272.2 641352.0 644189.0 645557.0 649529.0 650172.0 65132.0 65246.3 65282.3 65370.0 65376.0 1419.7 1442.5 1455.7 1456.9 1469.4 31841.5 34234.7 34317.1 34577.7 34776.7 56936.7 57493.4 57497.0 57887.1 57961.7 467714.0 468355.0 469077.0 469142.0 469674.0 27900.7 30483.8 32386.4 32482.7 32657.7 52054.2 52397.0 52897.2 53443.2 53632.5 43999.8 44570.3 45162.8 45456.1 45961.3 44027.8 45251.3 45856.0 46288.5 47188.0 40609.6 43942.6 44352.0 44844.6 44924.1 36676.8 39639.4 40156.0 40672.4 40678.0 28667.3 29302.1 29389.4 29473.3 29587.4 19:10:55 INFO - PROCESS | 2672 | 19:10:55 INFO - PROCESS | 2672 | [#2] jquery.html Cycles:180 Average:30495.87 Median:22547.17 stddev:83076.96 (368.5%) stddev-sans-first:83279.28 19:10:55 INFO - PROCESS | 2672 | Values: 401.2 402.4 412.5 413.4 422.1 19362.6 20882.9 20991.4 21140.5 21163.6 19750.7 20487.3 20820.2 20888.3 21094.4 5731.9 5976.9 5985.3 5988.7 5992.9 5744.2 5889.5 5897.2 5918.9 5974.6 5863.5 5873.0 5875.2 5879.4 5881.8 5697.3 5876.4 5912.5 5914.6 5917.9 5300.1 5303.5 5307.8 5312.2 5314.2 22308.3 22786.0 24542.5 24707.3 24963.3 2463.2 2506.7 2717.9 3142.6 3288.5 11505.9 12799.9 14715.7 15401.1 15615.4 2006.1 2009.1 2061.5 2082.7 2175.8 84671.6 85527.6 88059.6 88222.6 88227.0 11910.9 11992.9 12004.6 12056.3 12149.4 17405.2 17443.3 17446.4 17454.4 17455.9 8615.8 8864.6 8933.9 8971.6 9083.6 8437.2 8497.5 8535.7 8706.0 8744.4 5204.6 5239.1 5242.0 5309.7 5372.8 2106.7 2114.0 2127.6 2152.4 2230.7 984.6 1001.5 1033.7 1039.4 1053.7 18935.8 19234.0 20067.6 20285.9 21183.8 1001.2 1005.3 1010.8 1020.5 1079.8 10771.8 11578.4 11594.4 11608.9 11611.5 492087.0 496445.0 498102.0 498179.0 530178.0 66345.4 92537.5 97077.0 106846.0 107408.0 987.7 1036.5 1102.1 1102.2 1110.6 18860.9 18962.3 19146.5 19273.1 19430.4 47160.5 47568.3 47797.8 48367.0 48496.0 63115.7 63775.4 65012.3 65558.7 65705.0 9079.2 9136.0 9188.6 9237.4 9300.4 13407.4 13583.2 13679.3 13798.7 14093.5 12106.6 12191.5 12274.5 12305.1 12378.9 11914.6 11985.2 12036.2 12109.3 12287.3 11646.5 11700.2 11728.1 12133.7 12472.3 9196.5 9291.9 9310.6 9434.4 9525.5 11197.9 11454.3 11556.6 11613.0 11745.9 19:10:55 INFO - PROCESS | 2672 | 19:10:55 INFO - PROCESS | 2672 | [#3] mootools.html Cycles:180 Average:6389.76 Median:4733.18 stddev:3688.88 (77.9%) stddev-sans-first:3680.87 19:10:55 INFO - PROCESS | 2672 | Values: 1492.0 1562.4 1635.3 1762.2 1791.1 9291.7 9987.1 9999.7 10007.0 10010.9 8562.1 8761.7 9264.0 9540.3 9778.9 2526.5 2550.7 2551.9 2555.3 2557.2 2546.3 2599.5 2599.5 2603.1 2606.6 2517.4 2535.1 2584.6 2594.1 2603.7 2482.2 2485.7 2502.2 2528.4 2529.8 2446.8 2451.3 2451.9 2453.5 2483.4 9676.2 9737.5 9741.6 9823.3 9866.0 5740.1 5891.9 5898.7 5901.2 5902.0 3396.4 3488.9 3548.8 3585.6 3603.5 1272.8 1350.1 1380.4 1381.8 1388.2 13662.7 13693.9 13733.5 13753.9 13760.7 5053.4 5153.9 5315.3 5401.1 5405.8 11549.4 11555.1 11559.4 11559.5 11562.3 5977.4 5996.6 6002.4 6016.5 6045.5 4863.7 5086.7 5462.1 5498.6 5514.7 4415.9 4502.6 4533.5 4564.5 4602.7 1444.0 1472.8 1474.8 1474.9 1486.2 873.4 958.7 988.5 996.3 1006.3 5904.1 6034.1 6131.5 6280.8 6293.7 539.7 993.5 1059.1 1153.8 1166.9 4096.7 4237.9 4244.7 4300.0 4416.3 12138.3 12578.2 12589.6 12591.7 12607.2 12028.6 12270.0 12418.5 12431.8 12493.9 8929.3 9059.9 9061.5 9064.7 9068.8 6159.0 6227.8 6262.4 6328.3 6392.2 11012.5 11096.6 11118.5 11131.2 11135.7 11036.3 11199.7 11321.0 11385.1 11495.7 7463.5 7708.1 7712.6 8105.1 8399.8 8896.1 9181.3 9352.9 9442.1 9696.0 8682.9 8707.1 8724.6 8859.8 8869.4 8336.5 8490.3 8501.1 8501.4 8638.2 7905.8 7910.7 7913.4 7917.9 7936.1 5434.7 5516.4 5522.2 5563.1 5661.1 5439.2 5533.8 5578.1 5604.3 5617.7 19:10:55 INFO - PROCESS | 2672 | 19:10:55 INFO - PROCESS | 2672 | [#4] prototype.html Cycles:180 Average:4904.59 Median:5517.63 stddev:1435.37 (26.0%) stddev-sans-first:1397.76 19:10:55 INFO - PROCESS | 2672 | Values: 331.6 333.4 338.9 341.8 346.0 5418.0 5507.3 5541.3 5620.7 5686.2 5334.9 5428.4 5445.4 5455.7 5462.4 4369.9 4374.7 4380.6 4387.0 4404.2 4174.9 4311.5 4355.7 4394.6 4396.8 4314.9 4321.3 4324.4 4326.6 4326.9 4307.8 4335.5 4338.3 4338.8 4369.3 3730.0 3817.2 3826.0 3843.6 3852.7 5286.1 5365.3 5373.9 5381.2 5397.1 4959.7 4963.3 4966.4 4973.0 5003.7 5600.8 5768.0 5768.8 5784.8 5816.4 4221.4 4234.2 4237.8 4249.1 4264.3 5788.7 6032.3 6046.7 6047.2 6052.0 4231.2 4248.9 4251.7 4272.9 4289.2 4345.3 4361.3 4368.8 4369.3 4386.1 4971.3 4983.0 4984.0 4999.3 5023.1 5498.5 5659.6 5789.3 5810.5 5867.3 1422.9 1443.6 1468.3 1477.7 1487.6 998.3 1000.3 1019.3 1019.8 1026.3 5499.6 5517.6 5517.7 5527.4 5556.9 5823.4 5843.6 5845.6 5876.2 5912.6 5463.9 5611.4 5620.2 5675.6 5715.4 3144.8 3183.3 3197.3 3204.5 3210.7 6094.8 6104.9 6220.3 6246.9 6250.3 6137.4 6157.4 6158.9 6159.6 6169.7 6133.9 6209.4 6217.2 6218.7 6240.3 5844.2 5879.4 5953.5 5953.7 5960.2 5863.0 5877.9 5878.2 5907.7 5920.5 5841.3 6106.4 6154.8 6180.2 6187.7 4265.0 4272.6 4276.1 4277.9 4303.7 5775.7 5927.4 6017.4 6026.6 6034.4 5750.5 5835.8 5843.5 5850.6 5865.1 5839.3 5858.2 5863.5 5878.8 5887.8 5665.4 5831.4 5848.9 5863.8 5875.1 5831.4 5835.4 5846.6 5872.1 5891.2 5470.4 5736.5 5746.1 5756.6 5757.7 19:10:55 INFO - PROCESS | 2672 | 19:10:55 INFO - PROCESS | 2672 | [#5] yui.html Cycles:180 Average:22418.93 Median:4065.46 stddev:33686.00 (828.6%) stddev-sans-first:33741.18 19:10:55 INFO - PROCESS | 2672 | Values: 743.3 749.9 753.3 783.6 868.7 15514.6 16223.5 16442.4 16464.6 16813.2 14688.0 14807.9 14813.5 14825.2 14830.3 727.4 858.9 881.5 883.2 886.0 734.9 840.3 849.0 853.1 862.5 916.9 916.9 917.5 919.0 921.3 915.3 916.2 916.3 916.9 917.0 679.6 680.0 680.0 680.2 680.5 16101.6 16126.0 16138.5 16144.0 16157.2 16223.7 16403.3 16768.2 16924.0 17116.4 11217.3 11353.8 11404.3 11512.3 11797.6 3941.2 4017.3 4040.5 4058.2 4072.7 75804.0 86613.6 86688.0 86692.1 87167.6 11778.3 11941.5 11986.6 12062.8 12135.4 22407.4 22422.7 22440.6 22453.1 22464.7 8794.8 8846.0 9003.5 9241.0 9245.4 5144.4 5272.1 5314.8 5456.5 5682.7 3703.4 3800.5 3845.2 3859.3 3865.6 674.9 679.3 680.8 685.2 699.4 696.7 724.8 764.8 782.3 800.3 9045.6 9578.2 9989.0 10215.5 10312.6 634.7 649.8 661.3 732.7 741.5 4696.1 4924.7 4964.0 4968.9 5010.1 128770.0 129309.0 131976.3 133404.7 133686.0 63911.0 111414.0 112848.4 113193.4 114592.0 96794.0 97461.0 98428.5 99280.5 99484.0 9144.3 9420.8 9515.2 9570.4 9633.7 40569.0 51511.0 57441.0 58476.4 59060.7 81077.0 86268.6 86515.0 87203.0 89513.0 12165.1 12281.1 12299.2 12365.6 12497.6 13320.8 13337.8 13709.2 13822.8 14335.3 13072.0 13286.4 13828.4 13866.2 13942.1 12563.6 12606.8 12739.6 13283.5 13519.4 11977.6 12122.1 12594.2 12625.7 12710.4 10272.8 10419.3 10614.7 10650.1 11357.3 10484.3 10781.8 11094.9 11531.5 11619.8 19:10:55 INFO - PROCESS | 2672 | -------- Summary: end -------- 19:10:55 INFO - PROCESS | 2672 | 19:10:56 INFO - TEST-INFO | 2672: exit 0 19:10:56 INFO - TEST-OK | dromaeo_css | took 1113159ms 19:10:56 INFO - TEST-START | kraken 19:10:56 INFO - operating with platform_type : linux_ 19:10:56 INFO - Initialising browser for kraken test... 19:10:56 INFO - TEST-INFO | started process 3080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPZaGGk/profile http://localhost:49182/getInfo.html) 19:11:00 INFO - PROCESS | 3080 | __metrics Screen width/height:1600/1200 19:11:00 INFO - PROCESS | 3080 | colorDepth:24 19:11:00 INFO - PROCESS | 3080 | Browser inner width/height: 1024/697 19:11:00 INFO - PROCESS | 3080 | __metrics 19:11:00 INFO - PROCESS | 3080 | 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" 19:11:00 INFO - PROCESS | 3080 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:11:01 INFO - PROCESS | 3080 | console.error: PushService: 19:11:01 INFO - PROCESS | 3080 | stateChangeProcessEnqueue: Error transitioning state 19:11:01 INFO - PROCESS | 3080 | UnknownError 19:11:01 INFO - TEST-INFO | 3080: exit 0 19:11:01 INFO - Browser initialized. 19:11:01 INFO - Running cycle 1/1 for kraken test... 19:11:01 INFO - TEST-INFO | started process 3172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPZaGGk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:13 INFO - PROCESS | 3172 | RSS: Main: 144097280 19:11:13 INFO - PROCESS | 3172 | 19:11:16 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49182/tests/kraken/driver.html?testName=audio-beat-detection) 19:11:17 INFO - PROCESS | 3172 | RSS: Main: 186818560 19:11:17 INFO - PROCESS | 3172 | 19:11:19 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49182/tests/kraken/driver.html?testName=audio-dft) 19:11:20 INFO - PROCESS | 3172 | RSS: Main: 174952448 19:11:20 INFO - PROCESS | 3172 | 19:11:22 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49182/tests/kraken/driver.html?testName=audio-fft) 19:11:23 INFO - PROCESS | 3172 | RSS: Main: 265601024 19:11:23 INFO - PROCESS | 3172 | 19:11:25 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49182/tests/kraken/driver.html?testName=audio-oscillator) 19:11:26 INFO - PROCESS | 3172 | RSS: Main: 172425216 19:11:26 INFO - PROCESS | 3172 | 19:11:28 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49182/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:11:28 INFO - PROCESS | 3172 | RSS: Main: 173748224 19:11:28 INFO - PROCESS | 3172 | 19:11:31 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49182/tests/kraken/driver.html?testName=imaging-darkroom) 19:11:32 INFO - PROCESS | 3172 | RSS: Main: 209735680 19:11:32 INFO - PROCESS | 3172 | 19:11:35 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49182/tests/kraken/driver.html?testName=imaging-desaturate) 19:11:36 INFO - PROCESS | 3172 | RSS: Main: 208879616 19:11:36 INFO - PROCESS | 3172 | 19:11:39 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49182/tests/kraken/driver.html?testName=json-parse-financial) 19:11:39 INFO - PROCESS | 3172 | RSS: Main: 208445440 19:11:39 INFO - PROCESS | 3172 | 19:11:41 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49182/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:11:41 INFO - PROCESS | 3172 | RSS: Main: 170565632 19:11:41 INFO - PROCESS | 3172 | 19:11:43 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49182/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:11:44 INFO - PROCESS | 3172 | RSS: Main: 177020928 19:11:44 INFO - PROCESS | 3172 | 19:11:45 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49182/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:11:46 INFO - PROCESS | 3172 | RSS: Main: 187002880 19:11:46 INFO - PROCESS | 3172 | 19:11:48 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:11:49 INFO - PROCESS | 3172 | RSS: Main: 195379200 19:11:49 INFO - PROCESS | 3172 | 19:11:52 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:11:52 INFO - PROCESS | 3172 | RSS: Main: 192057344 19:11:52 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | Cycle 1(1): loaded http://localhost:49182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49182/tests/kraken/driver.html?testName=ai-astar) 19:11:54 INFO - PROCESS | 3172 | RSS: Main: 243204096 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | __start_tp_report 19:11:54 INFO - PROCESS | 3172 | _x_x_mozilla_page_load 19:11:54 INFO - PROCESS | 3172 | _x_x_mozilla_page_load_details 19:11:54 INFO - PROCESS | 3172 | |i|pagename|runs| 19:11:54 INFO - PROCESS | 3172 | |0;ai-astar;112;110;110;109;113;109;109;111;108;110 19:11:54 INFO - PROCESS | 3172 | |1;audio-beat-detection;142;116;121;151;122;117;113;120;146;118 19:11:54 INFO - PROCESS | 3172 | |2;audio-dft;161;161;163;159;160;163;161;159;160;161 19:11:54 INFO - PROCESS | 3172 | |3;audio-fft;74;75;75;110;75;74;75;76;102;75 19:11:54 INFO - PROCESS | 3172 | |4;audio-oscillator;81;81;124;81;82;81;110;83;84;106 19:11:54 INFO - PROCESS | 3172 | |5;imaging-gaussian-blur;116;116;117;117;117;117;116;117;117;116 19:11:54 INFO - PROCESS | 3172 | |6;imaging-darkroom;145;145;145;147;146;146;145;146;146;145 19:11:54 INFO - PROCESS | 3172 | |7;imaging-desaturate;94;95;95;95;95;95;94;95;95;95 19:11:54 INFO - PROCESS | 3172 | |8;json-parse-financial;48;49;51;50;48;50;50;49;49;49 19:11:54 INFO - PROCESS | 3172 | |9;json-stringify-tinderbox;56;57;57;57;58;56;57;57;57;58 19:11:54 INFO - PROCESS | 3172 | |10;stanford-crypto-aes;73;76;77;74;74;74;73;72;72;73 19:11:54 INFO - PROCESS | 3172 | |11;stanford-crypto-ccm;122;122;120;120;121;128;117;120;160;127 19:11:54 INFO - PROCESS | 3172 | |12;stanford-crypto-pbkdf2;154;150;153;155;156;156;155;156;150;155 19:11:54 INFO - PROCESS | 3172 | |13;stanford-crypto-sha256-iterative;66;66;63;63;64;61;62;61;60;61 19:11:54 INFO - PROCESS | 3172 | __end_tp_report 19:11:54 INFO - PROCESS | 3172 | __start_cc_report 19:11:54 INFO - PROCESS | 3172 | _x_x_mozilla_cycle_collect,1620 19:11:54 INFO - PROCESS | 3172 | __end_cc_report 19:11:54 INFO - PROCESS | 3172 | __startTimestamp1480475514811__endTimestamp 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | ------- Summary: start ------- 19:11:54 INFO - PROCESS | 3172 | Number of tests: 14 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:1.52 (1.4%) stddev-sans-first:1.45 19:11:54 INFO - PROCESS | 3172 | Values: 112.0 110.0 110.0 109.0 113.0 109.0 109.0 111.0 108.0 110.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:121.50 stddev:14.02 (11.5%) stddev-sans-first:13.72 19:11:54 INFO - PROCESS | 3172 | Values: 142.0 116.0 121.0 151.0 122.0 117.0 113.0 120.0 146.0 118.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 19:11:54 INFO - PROCESS | 3172 | Values: 161.0 161.0 163.0 159.0 160.0 163.0 161.0 159.0 160.0 161.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:13.27 (17.7%) stddev-sans-first:13.82 19:11:54 INFO - PROCESS | 3172 | Values: 74.0 75.0 75.0 110.0 75.0 74.0 75.0 76.0 102.0 75.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:81.00 stddev:15.87 (19.6%) stddev-sans-first:16.39 19:11:54 INFO - PROCESS | 3172 | Values: 81.0 81.0 124.0 81.0 82.0 81.0 110.0 83.0 84.0 106.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:11:54 INFO - PROCESS | 3172 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 19:11:54 INFO - PROCESS | 3172 | Values: 145.0 145.0 145.0 147.0 146.0 146.0 145.0 146.0 146.0 145.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 19:11:54 INFO - PROCESS | 3172 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:49.50 stddev:0.95 (1.9%) stddev-sans-first:0.88 19:11:54 INFO - PROCESS | 3172 | Values: 48.0 49.0 51.0 50.0 48.0 50.0 50.0 49.0 49.0 49.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 19:11:54 INFO - PROCESS | 3172 | Values: 56.0 57.0 57.0 57.0 58.0 56.0 57.0 57.0 57.0 58.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:74.00 stddev:1.62 (2.2%) stddev-sans-first:1.69 19:11:54 INFO - PROCESS | 3172 | Values: 73.0 76.0 77.0 74.0 74.0 74.0 73.0 72.0 72.0 73.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:122.00 stddev:12.50 (10.2%) stddev-sans-first:13.19 19:11:54 INFO - PROCESS | 3172 | Values: 122.0 122.0 120.0 120.0 121.0 128.0 117.0 120.0 160.0 127.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:155.00 stddev:2.31 (1.5%) stddev-sans-first:2.45 19:11:54 INFO - PROCESS | 3172 | Values: 154.0 150.0 153.0 155.0 156.0 156.0 155.0 156.0 150.0 155.0 19:11:54 INFO - PROCESS | 3172 | 19:11:54 INFO - PROCESS | 3172 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:2.11 (3.4%) stddev-sans-first:1.87 19:11:54 INFO - PROCESS | 3172 | Values: 66.0 66.0 63.0 63.0 64.0 61.0 62.0 61.0 60.0 61.0 19:11:54 INFO - PROCESS | 3172 | -------- Summary: end -------- 19:11:54 INFO - PROCESS | 3172 | 19:11:55 INFO - TEST-INFO | 3172: exit 0 19:11:55 INFO - TEST-OK | kraken | took 59340ms 19:11:55 INFO - SUITE-END | took 1172s 19:11:55 INFO - Completed test suite (00:19:32) 19:11:55 INFO - javascript benchmark 19:11:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.890558830441, 3137.890173843916, 3158.352537729765, 3164.129864287322, 3204.391165678521, 5637.633553818999, 5750.108733146359, 5753.913691294634, 5761.596688231825, 5771.884562308751, 5656.575756818234, 5701.857453563653, 5711.7144142792795, 5717.714114294289, 5733.913991290134, 5138.794448222076, 5191.0, 5192.480751924815, 5207.4792520747815, 5253.185756207794, 5239.161734122522, 5277.12927366984, 5284.313039304885, 5316.680999140045, 5347.46525347466, 5184.481551844823, 5190.7664155112925, 5195.298634684326, 5202.115640341132, 5224.869378265555, 5264.657797243167, 5292.153255479124, 5299.6025298102795, 5370.43610420904, 5374.5700343972385, 5197.714125723083, 5228.660137091115, 5292.629515933848, 5310.734463276821, 5313.0, 5520.723963801794, 5568.805091821767, 5637.3517045539875, 5685.800996965087, 5689.6586204827845, 6149.292831324366, 6238.313785483639, 6245.219347581552, 6272.874542509125, 6275.02737075754, 6290.779822706229, 6307.211598550181, 6316.6841657917375, 6318.810435686891, 6326.240851097898, 5713.0, 5756.971215143939, 5764.596478246524, 5787.016207244778, 5789.421057894261, 6381.361863813674, 6383.1382763326355, 6409.230892292955, 6416.679166041679, 6419.101325814389, 5897.410258974069, 6132.6933653317155, 6150.692465376803, 6151.938480615226, 6154.661493617894, 6034.969825150934, 6101.389861013952, 6115.240341084264, 6137.96931015342, 6170.7223174957235, 6153.384661533811, 6164.660943648053, 6167.167432396659, 6180.7527698891545, 6184.536159788034, 6142.662153581596, 6177.382261773877, 6200.100985357098, 6202.72087756052, 6203.844903877349, 4394.318880573516, 4637.652176086807, 4648.093621743727, 4689.50760170184, 4715.552022557851, 4182.790860456965, 4183.205191013698, 4184.03767133561, 4187.685923555746, 4210.34739615354, 5916.26046744157, 5928.762849485972, 5931.406859314034, 5932.3474417814, 5933.940660593339, 6094.360092190344, 6109.131392048963, 6110.4980065817745, 6138.265785110703, 6305.495560355161, 5863.618864773776, 5867.119932010147, 5871.94128058714, 5895.941040589625, 5905.143754155623, 5299.5760339172775, 5299.920501192408, 5346.759395827197, 5350.357957045179, 5362.490563396471, 6074.271087469532, 6116.113163591254, 6219.875602488016, 6230.345813689679, 6286.717097730613, 6189.0, 6190.969045154746, 6193.597416167935, 6195.938040619536, 6202.131701561875, 6390.329015453311, 6391.137196478602, 6395.072714456471, 6398.360163983751, 6461.515386345949, 5885.646861188342, 5903.586748927534, 6053.122297266959, 6133.815985520441, 6135.355787642234, 6117.492485019787, 6251.71867265965, 6259.061140828912, 6263.4362907338555, 6264.59280146789, 6063.242094738158, 6096.8780624388155, 6117.021276595723, 6118.051701986199, 6122.724477398617, 5934.0, 5968.970155149196, 6053.3946605339115, 6071.848203794763, 6084.8783024340155, 5984.850378740566, 6027.065804800263, 6027.819165425044, 6100.938990610037, 6128.356522565245, 6121.816345509642, 6126.417990290915, 6128.63228206309, 6133.6319820810895, 6135.538906164888, 5730.283714535683, 5757.65454072757, 5970.134330522137, 5970.522358211246, 5988.760449581968], "value": 5680.821524543802, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.9852253693657, 627.6955676496899, 637.9681015949201, 648.0635481728903, 651.3258777165631, 34586.30827383451, 37398.25203495932, 37568.436473452886, 47656.0, 48387.51612483874, 49076.0, 49691.0, 49709.75145124278, 49759.75120124394, 49794.0, 9252.1210485004, 9412.670556530522, 9423.10480504351, 9429.057094290585, 9430.622775088988, 8662.913370866305, 8843.425177363451, 8856.0, 9075.500847453388, 9220.077992200793, 11133.7216569586, 11404.087672986183, 11415.486303116339, 11740.119491038206, 11742.941285293562, 11278.830817537702, 11357.204995650307, 11357.943210283896, 11367.374794386305, 11372.37451940143, 10944.507497162647, 11001.834972475419, 11019.504122314514, 11033.724156896142, 11044.282121662067, 45927.0, 46224.53775462236, 46246.53753462456, 46402.767986160194, 46454.53545464536, 3832.7891965941863, 4050.594940505926, 4079.1637714268504, 4213.978930105361, 4490.416245888046, 34715.82642086798, 34919.82540087309, 34965.12587185315, 35522.64477355245, 36624.81687591572, 4692.249240121564, 4736.857894263143, 4761.2143996240575, 4786.449558300805, 4811.350467686888, 386936.06531967444, 390182.0, 391213.0, 391395.0, 392372.0, 66864.33135668679, 67190.0, 67438.66280668565, 67483.32516674869, 67588.32411675919, 41025.58974410278, 41674.0, 41970.790146049076, 44317.77841110774, 69834.0, 20007.59984800296, 20152.69770953437, 20182.596348072955, 20198.798012019986, 20208.0, 15129.319180636898, 15188.392464301525, 15233.23833808305, 15236.23818809055, 15240.695186096216, 18886.338978135973, 19271.325503607586, 20467.8976605116, 21068.0, 21074.05166767499, 7738.7678369649, 7766.728164514215, 7781.766547003599, 7861.0, 7956.761297161094, 990.5047476261869, 1056.8731752189785, 1063.7234319077095, 1100.8128618134936, 1115.9609413670482, 34283.65716342805, 34300.14249643729, 34520.309593807986, 34555.0, 34572.65427345745, 1132.5073592987078, 1142.2518250545907, 1152.4295473740385, 1164.598213616301, 1190.2501424102759, 17574.912125439547, 18070.5482362942, 18167.63664726698, 18248.0, 18272.177752000927, 641352.0, 644189.0, 645557.0, 649529.0, 650172.0, 65132.0, 65246.347536524976, 65282.34717652858, 65370.0, 65376.0, 1419.7231539849631, 1442.4951267056447, 1455.7234125516118, 1456.8907331950147, 1469.3681716861852, 31841.522377164823, 34234.65765342315, 34317.14207144841, 34577.654223457444, 34776.65223347734, 56936.71531642315, 57493.42506575048, 57497.0, 57887.131693023795, 57961.71019144877, 467714.0, 468355.0, 469077.0, 469142.0, 469674.0, 27900.72099278981, 30483.847580762842, 32386.35227295488, 32482.675173247964, 32657.673423266413, 52054.1781037677, 52397.0, 52897.206541901134, 53443.198352023974, 53632.46367536275, 43999.78000109979, 44570.331445029, 45162.77418612886, 45456.09087818291, 45961.31058034065, 44027.77986110177, 45251.32123018092, 45856.0, 46288.53711462842, 47188.0, 40609.59390406058, 43942.56057439385, 44352.0, 44844.55155448404, 44924.101517968804, 36676.81661591675, 39639.40540891831, 40156.0, 40672.38991415072, 40678.0, 28667.28331791722, 29302.12093637109, 29389.412211756073, 29473.263168420963, 29587.408251835273], "value": 22032.318272949, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.20160879849107, 402.4104786094924, 412.4658567155534, 413.3943772373473, 422.0714428257834, 19362.612747745054, 20882.89558552209, 20991.37025889222, 21140.471488212763, 21163.57672846544, 19750.70373944392, 20487.282945096926, 20820.16719331225, 20888.268910588133, 21094.367168984918, 5731.885362292762, 5976.8505787355225, 5985.311689155759, 5988.670623115727, 5992.880142397149, 5744.195812586241, 5889.499392551638, 5897.233359663238, 5918.911216331759, 5974.641521508702, 5863.530917526609, 5873.0, 5875.206847075633, 5879.382664820197, 5881.823545293648, 5697.344805347376, 5876.4123587641325, 5912.526997840162, 5914.585978981473, 5917.940820591782, 5300.125479295912, 5303.496167864047, 5307.840764777025, 5312.1766126250495, 5314.229436731653, 22308.330750077523, 22786.0, 24542.50914981708, 24707.25878223656, 24963.251102466773, 2463.2117722328862, 2506.749325067497, 2717.91846244613, 3142.607174103237, 3288.5067239914206, 11505.884941150649, 12799.87200127996, 14715.705685886329, 15401.075935443909, 15615.375384984587, 2006.1173083843062, 2009.1461129020108, 2061.505238742706, 2082.7084208210863, 2175.7824217578273, 84671.57664211701, 85527.57236213778, 88059.55970220108, 88222.5588872058, 88226.99999999936, 11910.94044529789, 11992.880071199352, 12004.639860804189, 12056.336901470328, 12149.392530373623, 17405.216765245594, 17443.302267909396, 17446.389376371768, 17454.389096381565, 17455.912720436572, 8615.827683446296, 8864.601092950832, 8933.910660893438, 8971.596278167499, 9083.636654533877, 8437.156284371515, 8497.49015059086, 8535.701250456328, 8706.0, 8744.43161194533, 5204.635675502755, 5239.1093514102695, 5242.0, 5309.681419114865, 5372.764264219251, 2106.7050612914204, 2114.0, 2127.606392817334, 2152.3865698275918, 2230.721159855018, 984.6110786239539, 1001.5392919257077, 1033.679559336608, 1039.3711804358406, 1053.7154968158554, 18935.81064189368, 19234.0, 20067.59864802725, 20285.89857050705, 21183.78816211818, 1001.1690297053428, 1005.2962925951863, 1010.7574182196367, 1020.5101551255439, 1079.8272276435732, 10771.78456430867, 11578.36319002463, 11594.420278986017, 11608.88391116078, 11611.477483513263, 492087.0, 496445.0, 498102.0, 498179.0, 530178.0, 66345.44975249727, 92537.53731231301, 97077.0, 106846.0, 107408.0, 987.7086259553449, 1036.5439206749006, 1102.0577406317484, 1102.2064113838023, 1110.6445937299986, 18860.905695471985, 18962.336318228794, 19146.52133696669, 19273.132709027846, 19430.417087487396, 47160.52839471561, 47568.2864757022, 47797.76101119472, 48367.0, 48496.0, 63115.6844215776, 63775.36224637694, 65012.34987650063, 65558.67220663866, 65705.0, 9079.228265597498, 9136.0, 9188.586513607037, 9237.39956902826, 9300.39547429415, 13407.396667149807, 13583.185008899498, 13679.31603419845, 13798.65503362424, 14093.506727264497, 12106.576269830513, 12191.451384687532, 12274.509019639114, 12305.138640295094, 12378.876211238132, 11914.582989595323, 11985.22096063753, 12036.157468977088, 12109.333986630467, 12287.324197168884, 11646.475908583965, 11700.180987330805, 11728.061755059403, 12133.69665758363, 12472.251664900135, 9196.540172991457, 9291.907080929375, 9310.581023854078, 9434.386764860263, 9525.52372381392, 11197.88802112001, 11454.255473394536, 11556.595519157125, 11613.0, 11745.942865141837], "value": 9854.679867724675, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.970160596788, 1562.4062856114679, 1635.2968223663827, 1762.1541660003206, 1791.0567034767278, 9291.674791382304, 9987.051230133126, 9999.650012249573, 10007.0, 10010.949945250282, 8562.100979397152, 8761.737147885558, 9264.0, 9540.33217674763, 9778.902210977889, 2526.5199612073693, 2550.7321731218235, 2551.8596477193746, 2555.271747551948, 2557.207265747615, 2546.2997675639253, 2599.493098845726, 2599.519088968547, 2603.06289735695, 2606.6090086487084, 2517.3580736912154, 2535.1000394859834, 2584.5606246938064, 2594.092067776282, 2603.687557493094, 2482.2429159106464, 2485.72657007729, 2502.186789293478, 2528.355269406308, 2529.759672831078, 2446.755324467557, 2451.301379106964, 2451.889664965063, 2453.5338285725657, 2483.3915690655904, 9676.17752491039, 9737.464439455827, 9741.561629726679, 9823.28092583795, 9865.950670246675, 5740.052891272935, 5891.911621325684, 5898.734556944948, 5901.203337549418, 5902.0, 3396.3546926083964, 3488.9127771805656, 3548.7870727756417, 3585.587657419378, 3603.5315408996926, 1272.8154417609487, 1350.0751984890383, 1380.4340220509644, 1381.7581923163407, 1388.1740364483117, 13662.658433539242, 13693.931530342385, 13733.519326823613, 13753.931230343784, 13760.724785504333, 5053.418856831438, 5153.948460515422, 5315.255864179018, 5401.135818269058, 5405.837824865261, 11549.422528873523, 11555.075593952632, 11559.422028898522, 11559.479823407966, 11562.30626162433, 5977.402259773988, 5996.610220335664, 6002.39976002405, 6016.488598469179, 6045.546584006129, 4863.683860549053, 5086.694798312114, 5462.0987537056735, 5498.615096943176, 5514.6691198528215, 4415.867523974286, 4502.57225563571, 4533.478649955231, 4564.497905230422, 4602.677812553089, 1444.0, 1472.8158980127484, 1474.8303945046243, 1474.852514748538, 1486.2048803890084, 873.4104479476455, 958.726762872578, 988.4958671077659, 996.3125443444001, 1006.285537268533, 5904.084866845646, 6034.094885767082, 6131.478824299896, 6280.842978925472, 6293.653849038347, 539.7166487594045, 993.4883534979347, 1059.0838924330553, 1153.8269259610959, 1166.912481563886, 4096.692748043909, 4237.851675191354, 4244.702870799015, 4299.957000429956, 4416.29339305716, 12138.271703697807, 12578.182418142791, 12589.622311330675, 12591.748165036648, 12607.180533265491, 12028.578999734968, 12270.0, 12418.503259869685, 12431.751364972832, 12493.937530312473, 8929.285657147413, 9059.909400906039, 9061.456312621396, 9064.730937668732, 9068.773280668036, 6158.969205154125, 6227.813165605039, 6262.436380725757, 6328.272248691459, 6392.20097487814, 11012.50443730018, 11096.5561377544, 11118.499667515143, 11131.165162612675, 11135.72160695989, 11036.282641628268, 11199.72000699989, 11321.0, 11385.089192864716, 11495.655130346104, 7463.514871533333, 7708.113566939874, 7712.614369281626, 8105.067917189363, 8399.790005249917, 8896.110388961051, 9181.311401644769, 9352.906470935475, 9442.055794420503, 9695.951520242354, 8682.91317086821, 8707.129287071242, 8724.607392667473, 8859.822803544022, 8869.423487473552, 8336.499810011419, 8490.278326342082, 8501.14988501145, 8501.362397820065, 8638.222559969632, 7905.841883162419, 7910.683572657029, 7913.366930645419, 7917.920820791718, 7936.127026027248, 5434.673919564839, 5516.448355164612, 5522.22688823557, 5563.05428077236, 5661.065924122474, 5439.184122381675, 5533.750981205775, 5578.051731205786, 5604.327480702342, 5617.719114044363], "value": 5087.4938437052315, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.64679616208736, 333.42983498218047, 338.93405240518575, 341.81541967337637, 345.9775114617551, 5418.0, 5507.339119305679, 5541.335039795225, 5620.690862002588, 5686.175504551838, 5334.879675268188, 5428.4300148484335, 5445.420827959887, 5455.672659640424, 5462.426445223254, 4369.912601747963, 4374.650027997753, 4380.6276466500385, 4386.956130438687, 4404.207242696313, 4174.895627609319, 4311.5472875348105, 4355.651547876162, 4394.582979361355, 4396.812860527655, 4314.935275970863, 4321.28698764705, 4324.372965919955, 4326.632236259906, 4326.913461730764, 4307.784610769465, 4335.523092459827, 4338.349247612868, 4338.804753786056, 4369.300911854088, 3729.962700372989, 3817.2174704185577, 3826.0243637872163, 3843.6348546888003, 3852.6917846572205, 5286.123426183688, 5365.302510673588, 5373.919391209135, 5381.246625472437, 5397.084035167538, 4959.6528243023, 4963.255511673242, 4966.379202599675, 4972.975135124338, 5003.724795136266, 5600.775968961237, 5767.971160144214, 5768.798092066758, 5784.797532086357, 5816.447437493432, 4221.387898754694, 4234.153169366139, 4237.7669228192435, 4249.086446414036, 4264.275073237526, 5788.652680839121, 6032.306284777263, 6046.727897244635, 6047.21386219793, 6052.0, 4231.217224813419, 4248.851290204828, 4251.702380833374, 4272.9489844874015, 4289.1850548395705, 4345.283028300295, 4361.302191649321, 4368.759718215529, 4369.279068953587, 4386.122775444924, 4971.279164521125, 4982.950170498321, 4983.950160498349, 4999.3000979862845, 5023.120953833065, 5498.505134537911, 5659.5755318351285, 5789.305283366023, 5810.477057064884, 5867.266591676041, 1422.9359678814478, 1443.603009172486, 1468.2952182952242, 1477.6774786565963, 1487.6206567325262, 998.2962011781676, 1000.314784372707, 1019.2508506247901, 1019.7909428567274, 1026.2508368890751, 5499.587530935196, 5517.5585953123655, 5517.69652669107, 5527.447255274521, 5556.91664625031, 5823.388544202882, 5843.561732870052, 5845.590808643354, 5876.236089308362, 5912.645241285537, 5463.945360546423, 5611.382747897728, 5620.185073164368, 5675.574331925122, 5715.371309155989, 3144.7641426893074, 3183.2996740717003, 3197.328561002169, 3204.5353423753427, 3210.6628803975714, 6094.775406976421, 6104.908426373608, 6220.294172035179, 6246.93802053652, 6250.343713909974, 6137.36093479799, 6157.415045570664, 6158.876822463526, 6159.552505161283, 6169.691515424211, 6133.9079913802225, 6209.423089417931, 6217.160683307786, 6218.720157592919, 6240.31356550779, 5844.181814546052, 5879.382664820132, 5953.499530197241, 5953.6780655545235, 5960.225170727777, 5862.970685146547, 5877.911831322448, 5878.2064421302575, 5907.675077870758, 5920.496757775637, 5841.269841269841, 6106.389361063858, 6154.78458253959, 6180.196574445294, 6187.659678717714, 4264.95735042658, 4272.6154646082, 4276.054395250216, 4277.935830962476, 4303.698741088219, 5775.740091695968, 5927.436893495111, 6017.368176341596, 6026.638401695912, 6034.39656034393, 5750.5112065474905, 5835.824925252249, 5843.532517398513, 5850.561207909339, 5865.090910908816, 5839.328477225174, 5858.209141765807, 5863.472287494146, 5878.824235152901, 5887.764489420547, 5665.376808550974, 5831.387704290988, 5848.853778655568, 5863.794767183128, 5875.089361149029, 5831.35855055952, 5835.387284335084, 5846.590738648254, 5872.148538461985, 5891.23413956183, 5470.425605311385, 5736.483716465538, 5746.109353050284, 5756.568257380797, 5757.65454072757], "value": 4443.88811169271, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.2641684732115, 749.8762704153814, 753.3069575990089, 783.5768684910149, 868.6525389844065, 15514.612134696625, 16223.51329460115, 16442.42451514197, 16464.588385290375, 16813.15934203288, 14688.045277056985, 14807.92596037021, 14813.481528146516, 14825.18461484618, 14830.258487075631, 727.4180655475625, 858.935579831512, 881.4711173296035, 883.1830556734994, 886.0, 734.9485536012481, 840.2941529115542, 849.0448245723561, 853.0957185383483, 862.4997501449144, 916.8624706294042, 916.880805495288, 917.4586993673731, 919.0212423768666, 921.2998121427696, 915.2906497464452, 916.2029034739752, 916.3356566489275, 916.8670542771295, 916.9908300916973, 679.6397909108181, 680.0, 680.0139797293944, 680.1735890892589, 680.4794332335767, 16101.597460063475, 16126.032438053755, 16138.515844524683, 16144.0, 16157.192140392934, 16223.73315718634, 16403.261853216514, 16768.161591920478, 16924.0, 17116.400925967533, 11217.326960382403, 11353.772924541545, 11404.315741055563, 11512.251703639236, 11797.587084452003, 3941.152652179795, 4017.27689015977, 4040.5151381834075, 4058.2289365020847, 4072.6945479089186, 75804.0, 86613.56693216557, 86688.0, 86692.13307866904, 87167.56416217878, 11778.293302401884, 11941.52233910634, 11986.64040078799, 12062.758744825054, 12135.393230338625, 22407.43981400478, 22422.663660045113, 22440.551188976457, 22453.10187592478, 22464.663030054562, 8794.824103517894, 8846.0, 9003.504807235666, 9240.95379523098, 9245.399049061789, 5144.356955380577, 5272.103742363807, 5314.813981510629, 5456.536194423518, 5682.7442765075675, 3703.4444833275224, 3800.524934383202, 3845.192509573021, 3859.3439115350457, 3865.632764887331, 674.919009718827, 679.3308591037824, 680.7617333933084, 685.2120061928822, 699.4159876503076, 696.7108649910332, 724.77169691547, 764.825932750794, 782.2763943352377, 800.2957397490288, 9045.592948317342, 9578.185854202471, 9988.950055249823, 10215.489225538693, 10312.639057632947, 634.6509419819081, 649.8148027812051, 661.3287513174132, 732.6959311885614, 741.5031928607846, 4696.107739529479, 4924.704517728947, 4963.982383611423, 4968.900621987612, 5010.098182327143, 128770.0, 129309.0, 131976.34011830072, 133404.66488337674, 133686.0, 63911.0, 111414.0, 112848.43575782068, 113193.43403283096, 114592.0, 96794.0, 97461.0, 98428.50785746025, 99280.50359748155, 99483.99999999856, 9144.26845852317, 9420.764480888032, 9515.238780897373, 9570.377925434825, 9633.710988670351, 40569.0, 51511.0, 57441.0, 58476.4152358471, 59060.70469647624, 81077.0, 86268.56865715631, 86515.0, 87203.0, 89513.0, 12165.08761842883, 12281.140320177501, 12299.200551964452, 12365.567205147776, 12497.56258530947, 13320.800187996994, 13337.799933001206, 13709.245991470565, 13822.792658110338, 14335.283235838375, 13072.0, 13286.402111904794, 13828.446862125402, 13866.168029918237, 13942.093763905314, 12563.560275390317, 12606.810897836724, 12739.55411560591, 13283.53507627267, 13519.391627376988, 11977.64067077989, 12122.09084318662, 12594.181378210387, 12625.684357891127, 12710.394065092474, 10272.794544109225, 10419.322744021614, 10614.73463163427, 10650.094741947021, 11357.261777984404, 10484.26610137283, 10781.838272425763, 11094.944525277322, 11531.481083351102, 11619.825702614637], "value": 7859.526601823027, "unit": "score"}], "name": "dromaeo_css", "value": 7764.915046888745, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 110.0, 109.0, 113.0, 109.0, 109.0, 111.0, 108.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 121.0, 151.0, 122.0, 117.0, 113.0, 120.0, 146.0, 118.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 159.0, 160.0, 163.0, 161.0, 159.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 110.0, 75.0, 74.0, 75.0, 76.0, 102.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 124.0, 81.0, 82.0, 81.0, 110.0, 83.0, 84.0, 106.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 51.0, 50.0, 48.0, 50.0, 50.0, 49.0, 49.0, 49.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 58.0, 56.0, 57.0, 57.0, 57.0, 58.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 77.0, 74.0, 74.0, 74.0, 73.0, 72.0, 72.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 120.0, 120.0, 121.0, 128.0, 117.0, 120.0, 160.0, 127.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 153.0, 155.0, 156.0, 156.0, 155.0, 156.0, 150.0, 155.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 63.0, 63.0, 64.0, 61.0, 62.0, 61.0, 60.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1449.3999999999999, "alertThreshold": 2.0}]} 19:11:56 INFO - Return code: 0 19:11:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:11:56 INFO - # TBPL SUCCESS # 19:11:56 INFO - Running post-action listener: _resource_record_post_action 19:11:56 INFO - [mozharness: 2016-11-30 03:11:56.134728Z] Finished run-tests step (success) 19:11:56 INFO - Running post-run listener: _resource_record_post_run 19:11:56 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309137408; Read time: 12; Write time: 162868 19:11:56 INFO - TinderboxPrint: CPU usage
12.9% 19:11:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:11:56 INFO - TinderboxPrint: I/O write bytes / time
309,137,408 / 162,868 19:11:56 INFO - TinderboxPrint: CPU idle
8,245.8 (87.1%) 19:11:56 INFO - TinderboxPrint: CPU user
1,179.2 (12.5%) 19:11:56 INFO - TinderboxPrint: Swap in / out
0 / 0 19:11:56 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100564992; Read time: 0; Write time: 52460 19:11:56 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 208572416; Read time: 12; Write time: 110408 19:11:56 INFO - Running post-run listener: _upload_blobber_files 19:11:56 INFO - Blob upload gear active. 19:11:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:11:56 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 19:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:11:57 INFO - (blobuploader) - INFO - Open directory for files ... 19:11:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:11:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:11:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:12:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:00 INFO - (blobuploader) - INFO - Done attempting. 19:12:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:12:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:12:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:01 INFO - (blobuploader) - INFO - Done attempting. 19:12:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:12:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:12:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:02 INFO - (blobuploader) - INFO - Done attempting. 19:12:02 INFO - (blobuploader) - INFO - Iteration through files over. 19:12:02 INFO - Return code: 0 19:12:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:12:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:12:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87caeb05a6da6e393a4d2690e86c2df80683097119a5b2e849d64dda16a94d37efbccbe430e61977cdb2c27ad382f4e348b08961891b41edc0efb4c8a4a8d097", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa346e640235c4a730c87fb2f1c8e52820020d43ecdee6d8e4d8b99ec3108bee0a776d107ae3a5829da4bae26f5a2b78be0d190632017c1352f72fcb0da88f9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71a527d3dd0d62449f0a8d916d7f30f5566477e5c2d8ef3f394fc107bd940639cec0aabb8f8603531d9b6f1d4803ad5d6b9e5970fcd52e8feb95e5a93f8580f6"} 19:12:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:12:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:12:02 INFO - Contents: 19:12:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87caeb05a6da6e393a4d2690e86c2df80683097119a5b2e849d64dda16a94d37efbccbe430e61977cdb2c27ad382f4e348b08961891b41edc0efb4c8a4a8d097", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa346e640235c4a730c87fb2f1c8e52820020d43ecdee6d8e4d8b99ec3108bee0a776d107ae3a5829da4bae26f5a2b78be0d190632017c1352f72fcb0da88f9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71a527d3dd0d62449f0a8d916d7f30f5566477e5c2d8ef3f394fc107bd940639cec0aabb8f8603531d9b6f1d4803ad5d6b9e5970fcd52e8feb95e5a93f8580f6"} 19:12:02 INFO - Running post-run listener: copy_logs_to_upload_dir 19:12:02 INFO - Copying logs to upload dir... 19:12:02 INFO - mkdir: /builds/slave/test/build/upload/logs 19:12:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.944298 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-11-29 19:12:01.686059) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 19:12:01.689120) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87caeb05a6da6e393a4d2690e86c2df80683097119a5b2e849d64dda16a94d37efbccbe430e61977cdb2c27ad382f4e348b08961891b41edc0efb4c8a4a8d097", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa346e640235c4a730c87fb2f1c8e52820020d43ecdee6d8e4d8b99ec3108bee0a776d107ae3a5829da4bae26f5a2b78be0d190632017c1352f72fcb0da88f9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71a527d3dd0d62449f0a8d916d7f30f5566477e5c2d8ef3f394fc107bd940639cec0aabb8f8603531d9b6f1d4803ad5d6b9e5970fcd52e8feb95e5a93f8580f6"} build_url:https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/buI2YnR3Rr6rk8LbXT0qwA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87caeb05a6da6e393a4d2690e86c2df80683097119a5b2e849d64dda16a94d37efbccbe430e61977cdb2c27ad382f4e348b08961891b41edc0efb4c8a4a8d097", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa346e640235c4a730c87fb2f1c8e52820020d43ecdee6d8e4d8b99ec3108bee0a776d107ae3a5829da4bae26f5a2b78be0d190632017c1352f72fcb0da88f9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71a527d3dd0d62449f0a8d916d7f30f5566477e5c2d8ef3f394fc107bd940639cec0aabb8f8603531d9b6f1d4803ad5d6b9e5970fcd52e8feb95e5a93f8580f6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 19:12:01.714135) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:12:01.714451) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1480474291.370721-1980278382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:12:01.797453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 19:12:01.797830) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 19:12:01.798130) ========= ========= Total master_lag: 0.17 =========