builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1475004249.3 results: success (0) buildid: 20160927092620 builduid: 8fbd330bea8441f9b66f4e174ddfec7a revision: 6dd548d6b45aa8aed064d185d1a92d8944cdef5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:09.297039) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:09.297449) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:09.297774) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:09.340829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:09.341109) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 12:24:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-09-27 12:24:09 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117296 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:09.475498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:09.478863) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020624 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:09.528373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:09.529858) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6dd548d6b45aa8aed064d185d1a92d8944cdef5c --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-aurora --rev 6dd548d6b45aa8aed064d185d1a92d8944cdef5c --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=2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 12:24:09,962 truncating revision to first 12 chars 2016-09-27 12:24:09,962 Setting DEBUG logging. 2016-09-27 12:24:09,962 attempt 1/10 2016-09-27 12:24:09,962 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6dd548d6b45a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 12:24:10,297 unpacking tar archive at: mozilla-aurora-6dd548d6b45a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677248 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:10.230432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:10.230722) ========= script_repo_revision: 6dd548d6b45aa8aed064d185d1a92d8944cdef5c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:10.231107) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:10.231376) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 12:24:10.251804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-09-27 12:24:10.252161) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:24:10 INFO - MultiFileLogger online at 20160927 12:24:10 in /builds/slave/test 12:24:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:24:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:24:10 INFO - {'append_to_log': False, 12:24:10 INFO - 'base_work_dir': '/builds/slave/test', 12:24:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:24:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:24:10 INFO - 'branch': 'Mozilla-Aurora', 12:24:10 INFO - 'buildbot_json_path': 'buildprops.json', 12:24:10 INFO - 'config_files': ('talos/linux_config.py',), 12:24:10 INFO - 'default_actions': ('clobber', 12:24:10 INFO - 'read-buildbot-config', 12:24:10 INFO - 'download-and-extract', 12:24:10 INFO - 'populate-webroot', 12:24:10 INFO - 'create-virtualenv', 12:24:10 INFO - 'install', 12:24:10 INFO - 'run-tests'), 12:24:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:24:10 INFO - 'download_minidump_stackwalk': True, 12:24:10 INFO - 'download_symbols': 'ondemand', 12:24:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:24:10 INFO - 'tooltool.py': '/tools/tooltool.py', 12:24:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:24:10 INFO - '/tools/misc-python/virtualenv.py')}, 12:24:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:24:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:24:10 INFO - 'installer_path': 'installer.exe', 12:24:10 INFO - 'log_level': 'info', 12:24:10 INFO - 'log_name': 'talos', 12:24:10 INFO - 'log_to_console': True, 12:24:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:24:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:24:10 INFO - 'opt_config_files': (), 12:24:10 INFO - 'pip_index': False, 12:24:10 INFO - 'sps_profile': False, 12:24:10 INFO - 'sps_profile_interval': 0, 12:24:10 INFO - 'suite': 'dromaeojs', 12:24:10 INFO - 'system_bits': '32', 12:24:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:24:10 INFO - 'title': 'talos-linux64-ix-012', 12:24:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:24:10 INFO - 'use_talos_json': True, 12:24:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:24:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:24:10 INFO - 'work_dir': 'build'} 12:24:10 INFO - [mozharness: 2016-09-27 19:24:10.789197Z] Running clobber step. 12:24:10 INFO - Running pre-action listener: _resource_record_pre_action 12:24:10 INFO - Running main action method: clobber 12:24:10 INFO - rmtree: /builds/slave/test/build 12:24:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:24:11 INFO - Running post-action listener: _resource_record_post_action 12:24:11 INFO - [mozharness: 2016-09-27 19:24:11.253881Z] Finished clobber step (success) 12:24:11 INFO - [mozharness: 2016-09-27 19:24:11.253982Z] Running read-buildbot-config step. 12:24:11 INFO - Running pre-action listener: _resource_record_pre_action 12:24:11 INFO - Running main action method: read_buildbot_config 12:24:11 INFO - Using buildbot properties: 12:24:11 INFO - { 12:24:11 INFO - "project": "", 12:24:11 INFO - "product": "firefox", 12:24:11 INFO - "script_repo_revision": "production", 12:24:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:24:11 INFO - "repository": "", 12:24:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:24:11 INFO - "buildid": "20160927092620", 12:24:11 INFO - "pgo_build": "True", 12:24:11 INFO - "basedir": "/builds/slave/test", 12:24:11 INFO - "buildnumber": 535, 12:24:11 INFO - "slavename": "talos-linux64-ix-012", 12:24:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:24:11 INFO - "platform": "ubuntu64_hw", 12:24:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:24:11 INFO - "branch": "mozilla-aurora", 12:24:11 INFO - "repo_path": "releases/mozilla-aurora", 12:24:11 INFO - "revision": "6dd548d6b45aa8aed064d185d1a92d8944cdef5c", 12:24:11 INFO - "stage_platform": "linux64-pgo", 12:24:11 INFO - "builduid": "8fbd330bea8441f9b66f4e174ddfec7a", 12:24:11 INFO - "slavebuilddir": "test" 12:24:11 INFO - } 12:24:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 12:24:11 INFO - Running post-action listener: _resource_record_post_action 12:24:11 INFO - [mozharness: 2016-09-27 19:24:11.256446Z] Finished read-buildbot-config step (success) 12:24:11 INFO - [mozharness: 2016-09-27 19:24:11.256536Z] Running download-and-extract step. 12:24:11 INFO - Running pre-action listener: _resource_record_pre_action 12:24:11 INFO - Running main action method: download_and_extract 12:24:11 INFO - mkdir: /builds/slave/test/build/tests 12:24:11 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')]} 12:24:11 INFO - trying https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 12:24:11 INFO - Downloading https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 12:24:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:24:11 INFO - Downloaded 1361 bytes. 12:24:11 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 12:24:11 INFO - Using the following test package requirements: 12:24:11 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 12:24:11 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:24:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:24:11 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:24:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:24:11 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:24:11 INFO - u'jsshell-linux-x86_64.zip'], 12:24:11 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:24:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:24:11 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 12:24:11 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:24:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:24:11 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:24:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:24:11 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:24:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:24:11 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:24:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:24:11 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:24:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 12:24:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:24:11 INFO - Fetch https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 12:24:12 INFO - Expected file size: 21899117 12:24:16 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:24:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 12:24:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:24:16 INFO - Fetch https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 12:24:17 INFO - Expected file size: 21899117 12:24:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 12:24:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:24:22 INFO - Fetch https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 12:24:22 INFO - Expected file size: 14414059 12:24: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')]} 12:24:23 INFO - trying https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:24:23 INFO - Downloading https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:24:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:24:24 INFO - Downloaded 63967464 bytes. 12:24:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:24:24 INFO - mkdir: /builds/slave/test/properties 12:24:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:24:24 INFO - Writing to file /builds/slave/test/properties/build_url 12:24:24 INFO - Contents: 12:24:24 INFO - build_url:https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:24:25 INFO - Running post-action listener: _resource_record_post_action 12:24:25 INFO - Running post-action listener: set_extra_try_arguments 12:24:25 INFO - [mozharness: 2016-09-27 19:24:25.008432Z] Finished download-and-extract step (success) 12:24:25 INFO - [mozharness: 2016-09-27 19:24:25.008733Z] Running populate-webroot step. 12:24:25 INFO - Running pre-action listener: _resource_record_pre_action 12:24:25 INFO - Running main action method: populate_webroot 12:24:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:24:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:24:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:24:25 INFO - '--tppagecycles', 12:24:25 INFO - '7'], 12:24:25 INFO - 'tests': ['tsvgm']}}, 12:24:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:24:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:24:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:24:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:24:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:24:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:24:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:25 INFO - 'talos_options': ['--disable-e10s'], 12:24:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:24:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:24:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:25 INFO - 'talos_options': ['--disable-e10s'], 12:24:25 INFO - 'tests': ['damp', 'tps']}, 12:24:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:25 INFO - 'tests': ['damp', 'tps']}, 12:24:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:24:25 INFO - 'tests': ['dromaeo_dom']}, 12:24:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:24:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:24:25 INFO - 'tests': ['basic_compositor_video']}, 12:24:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:24:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:24:25 INFO - 'tests': ['a11yr', 12:24:25 INFO - 'ts_paint', 12:24:25 INFO - 'tpaint', 12:24:25 INFO - 'sessionrestore', 12:24:25 INFO - 'sessionrestore_no_auto_restore', 12:24:25 INFO - 'tabpaint']}, 12:24:25 INFO - 'other-e10s': {'tests': ['a11yr', 12:24:25 INFO - 'ts_paint', 12:24:25 INFO - 'tpaint', 12:24:25 INFO - 'sessionrestore', 12:24:25 INFO - 'sessionrestore_no_auto_restore', 12:24:25 INFO - 'tabpaint']}, 12:24:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:24:25 INFO - 'ts_paint', 12:24:25 INFO - 'tpaint', 12:24:25 INFO - 'sessionrestore', 12:24:25 INFO - 'sessionrestore_no_auto_restore', 12:24:25 INFO - 'tabpaint']}, 12:24:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:24:25 INFO - 'ts_paint', 12:24:25 INFO - 'tpaint', 12:24:25 INFO - 'sessionrestore', 12:24:25 INFO - 'sessionrestore_no_auto_restore', 12:24:25 INFO - 'tabpaint']}, 12:24:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:24:25 INFO - 'tests': ['a11yr', 12:24:25 INFO - 'ts_paint', 12:24:25 INFO - 'tpaint', 12:24:25 INFO - 'sessionrestore', 12:24:25 INFO - 'sessionrestore_no_auto_restore', 12:24:25 INFO - 'tabpaint']}, 12:24:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:24:25 INFO - 'tests': ['a11yr', 12:24:25 INFO - 'ts_paint', 12:24:25 INFO - 'tpaint', 12:24:25 INFO - 'sessionrestore', 12:24:25 INFO - 'sessionrestore_no_auto_restore', 12:24:25 INFO - 'tabpaint']}, 12:24:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:24:25 INFO - 'tests': ['tsvgx', 12:24:25 INFO - 'tsvgr_opacity', 12:24:25 INFO - 'tart', 12:24:25 INFO - 'tscrollx', 12:24:25 INFO - 'cart']}, 12:24:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:24:25 INFO - 'tsvgr_opacity', 12:24:25 INFO - 'tart', 12:24:25 INFO - 'tscrollx', 12:24:25 INFO - 'cart']}, 12:24:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:25 INFO - 'talos_options': ['--disable-e10s'], 12:24:25 INFO - 'tests': ['tp5o']}, 12:24:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:25 INFO - 'tests': ['tp5o']}, 12:24:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:25 INFO - 'talos_options': ['--disable-e10s', 12:24:25 INFO - '--xperf_path', 12:24:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:24:25 INFO - 'tests': ['tp5n']}, 12:24:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:25 INFO - 'talos_options': ['--xperf_path', 12:24:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:24:25 INFO - 'tests': ['tp5n']}}, 12:24:25 INFO - 'talos.zip': {'path': '', 12:24:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:24:25 INFO - Running post-action listener: _resource_record_post_action 12:24:25 INFO - [mozharness: 2016-09-27 19:24:25.032530Z] Finished populate-webroot step (success) 12:24:25 INFO - [mozharness: 2016-09-27 19:24:25.032624Z] Running create-virtualenv step. 12:24:25 INFO - Running pre-action listener: _resource_record_pre_action 12:24:25 INFO - Running main action method: create_virtualenv 12:24:25 INFO - Creating virtualenv /builds/slave/test/build/venv 12:24:25 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 12:24:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:24:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:24:25 INFO - Using real prefix '/usr' 12:24:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:24:25 INFO - Installing distribute.............................................................................................................................................................................................done. 12:24:27 INFO - Installing pip.................done. 12:24:27 INFO - Return code: 0 12:24:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb14435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ef60>, '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 0x1d9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da01d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', '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 12:24:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:24:27 INFO - Using env: {'DISPLAY': ':0', 12:24:27 INFO - 'HOME': '/home/cltbld', 12:24:27 INFO - 'LANG': 'en_US.UTF-8', 12:24:27 INFO - 'LANGUAGE': 'en_US:en', 12:24:27 INFO - 'LOGNAME': 'cltbld', 12:24:27 INFO - 'MAIL': '/var/mail/cltbld', 12:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:27 INFO - 'MOZ_NO_REMOTE': '1', 12:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:27 INFO - 'NO_EM_RESTART': '1', 12:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:27 INFO - 'PWD': '/builds/slave/test', 12:24:27 INFO - 'SHELL': '/bin/bash', 12:24:27 INFO - 'SHLVL': '1', 12:24:27 INFO - 'TERM': 'linux', 12:24:27 INFO - 'TMOUT': '86400', 12:24:27 INFO - 'USER': 'cltbld', 12:24:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', 12:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:27 INFO - '_': '/tools/buildbot/bin/python'} 12:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:24:27 INFO - Cleaning up... 12:24:27 INFO - Return code: 0 12:24:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb14435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ef60>, '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 0x1d9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da01d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', '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 12:24:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:24:27 INFO - Using env: {'DISPLAY': ':0', 12:24:27 INFO - 'HOME': '/home/cltbld', 12:24:27 INFO - 'LANG': 'en_US.UTF-8', 12:24:27 INFO - 'LANGUAGE': 'en_US:en', 12:24:27 INFO - 'LOGNAME': 'cltbld', 12:24:27 INFO - 'MAIL': '/var/mail/cltbld', 12:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:27 INFO - 'MOZ_NO_REMOTE': '1', 12:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:27 INFO - 'NO_EM_RESTART': '1', 12:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:27 INFO - 'PWD': '/builds/slave/test', 12:24:27 INFO - 'SHELL': '/bin/bash', 12:24:27 INFO - 'SHLVL': '1', 12:24:27 INFO - 'TERM': 'linux', 12:24:27 INFO - 'TMOUT': '86400', 12:24:27 INFO - 'USER': 'cltbld', 12:24:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', 12:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:27 INFO - '_': '/tools/buildbot/bin/python'} 12:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:28 INFO - Downloading/unpacking psutil>=3.1.1 12:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:24:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:30 INFO - Installing collected packages: psutil 12:24:30 INFO - Running setup.py install for psutil 12:24:30 INFO - building 'psutil._psutil_linux' extension 12:24:30 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 12:24:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:24:30 INFO - building 'psutil._psutil_posix' extension 12:24:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:24:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:24:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:30 INFO - Successfully installed psutil 12:24:30 INFO - Cleaning up... 12:24:30 INFO - Return code: 0 12:24:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb14435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ef60>, '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 0x1d9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da01d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', '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 12:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:24:30 INFO - Using env: {'DISPLAY': ':0', 12:24:30 INFO - 'HOME': '/home/cltbld', 12:24:30 INFO - 'LANG': 'en_US.UTF-8', 12:24:30 INFO - 'LANGUAGE': 'en_US:en', 12:24:30 INFO - 'LOGNAME': 'cltbld', 12:24:30 INFO - 'MAIL': '/var/mail/cltbld', 12:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:30 INFO - 'MOZ_NO_REMOTE': '1', 12:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:30 INFO - 'NO_EM_RESTART': '1', 12:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:30 INFO - 'PWD': '/builds/slave/test', 12:24:30 INFO - 'SHELL': '/bin/bash', 12:24:30 INFO - 'SHLVL': '1', 12:24:30 INFO - 'TERM': 'linux', 12:24:30 INFO - 'TMOUT': '86400', 12:24:30 INFO - 'USER': 'cltbld', 12:24:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', 12:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:30 INFO - '_': '/tools/buildbot/bin/python'} 12:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:24:32 INFO - Installing collected packages: mozsystemmonitor 12:24:32 INFO - Running setup.py install for mozsystemmonitor 12:24:32 INFO - Successfully installed mozsystemmonitor 12:24:32 INFO - Cleaning up... 12:24:32 INFO - Return code: 0 12:24:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb14435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ef60>, '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 0x1d9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da01d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', '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 12:24:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:24:32 INFO - Using env: {'DISPLAY': ':0', 12:24:32 INFO - 'HOME': '/home/cltbld', 12:24:32 INFO - 'LANG': 'en_US.UTF-8', 12:24:32 INFO - 'LANGUAGE': 'en_US:en', 12:24:32 INFO - 'LOGNAME': 'cltbld', 12:24:32 INFO - 'MAIL': '/var/mail/cltbld', 12:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:32 INFO - 'MOZ_NO_REMOTE': '1', 12:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:32 INFO - 'NO_EM_RESTART': '1', 12:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:32 INFO - 'PWD': '/builds/slave/test', 12:24:32 INFO - 'SHELL': '/bin/bash', 12:24:32 INFO - 'SHLVL': '1', 12:24:32 INFO - 'TERM': 'linux', 12:24:32 INFO - 'TMOUT': '86400', 12:24:32 INFO - 'USER': 'cltbld', 12:24:32 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', 12:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:32 INFO - '_': '/tools/buildbot/bin/python'} 12:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:33 INFO - Downloading/unpacking jsonschema==2.5.1 12:24:33 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 12:24:33 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 12:24:33 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 12:24:33 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 12:24:33 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 12:24:33 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 12:24:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:24:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:35 INFO - Downloading functools32-3.2.3-2.tar.gz 12:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:24:35 INFO - warning: no files found matching '*.txt' 12:24:35 INFO - no previously-included directories found matching 'build' 12:24:35 INFO - no previously-included directories found matching 'dist' 12:24:35 INFO - no previously-included directories found matching '.git*' 12:24:35 INFO - Installing collected packages: jsonschema, functools32 12:24:35 INFO - Running setup.py install for functools32 12:24:35 INFO - warning: no files found matching '*.txt' 12:24:35 INFO - no previously-included directories found matching 'build' 12:24:35 INFO - no previously-included directories found matching 'dist' 12:24:35 INFO - no previously-included directories found matching '.git*' 12:24:35 INFO - Successfully installed jsonschema functools32 12:24:35 INFO - Cleaning up... 12:24:35 INFO - Return code: 0 12:24:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb14435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ef60>, '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 0x1d9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da01d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', '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 12:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:24:35 INFO - Using env: {'DISPLAY': ':0', 12:24:35 INFO - 'HOME': '/home/cltbld', 12:24:35 INFO - 'LANG': 'en_US.UTF-8', 12:24:35 INFO - 'LANGUAGE': 'en_US:en', 12:24:35 INFO - 'LOGNAME': 'cltbld', 12:24:35 INFO - 'MAIL': '/var/mail/cltbld', 12:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:35 INFO - 'MOZ_NO_REMOTE': '1', 12:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:35 INFO - 'NO_EM_RESTART': '1', 12:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:35 INFO - 'PWD': '/builds/slave/test', 12:24:35 INFO - 'SHELL': '/bin/bash', 12:24:35 INFO - 'SHLVL': '1', 12:24:35 INFO - 'TERM': 'linux', 12:24:35 INFO - 'TMOUT': '86400', 12:24:35 INFO - 'USER': 'cltbld', 12:24:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', 12:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:35 INFO - '_': '/tools/buildbot/bin/python'} 12:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:24:35 INFO - Cleaning up... 12:24:35 INFO - Return code: 0 12:24:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb14435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ef60>, '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 0x1d9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da01d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', '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 12:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:24:35 INFO - Using env: {'DISPLAY': ':0', 12:24:35 INFO - 'HOME': '/home/cltbld', 12:24:35 INFO - 'LANG': 'en_US.UTF-8', 12:24:35 INFO - 'LANGUAGE': 'en_US:en', 12:24:35 INFO - 'LOGNAME': 'cltbld', 12:24:35 INFO - 'MAIL': '/var/mail/cltbld', 12:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:35 INFO - 'MOZ_NO_REMOTE': '1', 12:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:35 INFO - 'NO_EM_RESTART': '1', 12:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:35 INFO - 'PWD': '/builds/slave/test', 12:24:35 INFO - 'SHELL': '/bin/bash', 12:24:35 INFO - 'SHLVL': '1', 12:24:35 INFO - 'TERM': 'linux', 12:24:35 INFO - 'TMOUT': '86400', 12:24:35 INFO - 'USER': 'cltbld', 12:24:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', 12:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:35 INFO - '_': '/tools/buildbot/bin/python'} 12:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:35 INFO - Downloading/unpacking blobuploader==1.2.4 12:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:37 INFO - Downloading blobuploader-1.2.4.tar.gz 12:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:24:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:24:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:38 INFO - Downloading docopt-0.6.1.tar.gz 12:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:24:38 INFO - Installing collected packages: blobuploader, requests, docopt 12:24:38 INFO - Running setup.py install for blobuploader 12:24:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:24:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:24:38 INFO - Running setup.py install for requests 12:24:39 INFO - Running setup.py install for docopt 12:24:39 INFO - Successfully installed blobuploader requests docopt 12:24:39 INFO - Cleaning up... 12:24:39 INFO - Return code: 0 12:24:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb14435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ef60>, '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 0x1d9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da01d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', '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 12:24:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:24:39 INFO - Using env: {'DISPLAY': ':0', 12:24:39 INFO - 'HOME': '/home/cltbld', 12:24:39 INFO - 'LANG': 'en_US.UTF-8', 12:24:39 INFO - 'LANGUAGE': 'en_US:en', 12:24:39 INFO - 'LOGNAME': 'cltbld', 12:24:39 INFO - 'MAIL': '/var/mail/cltbld', 12:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:39 INFO - 'MOZ_NO_REMOTE': '1', 12:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:39 INFO - 'NO_EM_RESTART': '1', 12:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:39 INFO - 'PWD': '/builds/slave/test', 12:24:39 INFO - 'SHELL': '/bin/bash', 12:24:39 INFO - 'SHLVL': '1', 12:24:39 INFO - 'TERM': 'linux', 12:24:39 INFO - 'TMOUT': '86400', 12:24:39 INFO - 'USER': 'cltbld', 12:24:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', 12:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:39 INFO - '_': '/tools/buildbot/bin/python'} 12:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:39 INFO - Running setup.py (path:/tmp/pip-voWFOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:39 INFO - Running setup.py (path:/tmp/pip-EMYShm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:39 INFO - Running setup.py (path:/tmp/pip-W__wRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:39 INFO - Running setup.py (path:/tmp/pip-bwJzI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:39 INFO - Running setup.py (path:/tmp/pip-nIVQGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:39 INFO - Running setup.py (path:/tmp/pip-9_fD_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:40 INFO - Running setup.py (path:/tmp/pip-fp3FOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:40 INFO - Running setup.py (path:/tmp/pip-HAxAFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:40 INFO - Running setup.py (path:/tmp/pip-8Q8llE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:40 INFO - Running setup.py (path:/tmp/pip-rFTmEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:40 INFO - Running setup.py (path:/tmp/pip-zoakLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:40 INFO - Running setup.py (path:/tmp/pip-GIIneS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:40 INFO - Running setup.py (path:/tmp/pip-CJbNEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:40 INFO - Running setup.py (path:/tmp/pip-c61QJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:40 INFO - Running setup.py (path:/tmp/pip-_QCRNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:40 INFO - Running setup.py (path:/tmp/pip-l8UIVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:40 INFO - Running setup.py (path:/tmp/pip-HdbKQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:24:40 INFO - Running setup.py install for manifestparser 12:24:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:24:40 INFO - Running setup.py install for mozcrash 12:24:41 INFO - Running setup.py install for mozdebug 12:24:41 INFO - Running setup.py install for mozdevice 12:24:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:24:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:24:41 INFO - Running setup.py install for mozfile 12:24:41 INFO - Running setup.py install for mozhttpd 12:24:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:24:41 INFO - Running setup.py install for mozinfo 12:24:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:24:41 INFO - Running setup.py install for mozInstall 12:24:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:24:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:24:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:24:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:24:41 INFO - Running setup.py install for mozleak 12:24:41 INFO - Running setup.py install for mozlog 12:24:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:24:41 INFO - Running setup.py install for moznetwork 12:24:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:24:41 INFO - Running setup.py install for mozprocess 12:24:42 INFO - Running setup.py install for mozprofile 12:24:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:24:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:24:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:24:42 INFO - Running setup.py install for mozrunner 12:24:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:24:42 INFO - Running setup.py install for mozscreenshot 12:24:42 INFO - Running setup.py install for moztest 12:24:42 INFO - Running setup.py install for mozversion 12:24:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:24:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:24:42 INFO - Cleaning up... 12:24:42 INFO - Return code: 0 12:24:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb14435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ef60>, '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 0x1d9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da01d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', '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 12:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:24:42 INFO - Using env: {'DISPLAY': ':0', 12:24:42 INFO - 'HOME': '/home/cltbld', 12:24:42 INFO - 'LANG': 'en_US.UTF-8', 12:24:42 INFO - 'LANGUAGE': 'en_US:en', 12:24:42 INFO - 'LOGNAME': 'cltbld', 12:24:42 INFO - 'MAIL': '/var/mail/cltbld', 12:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:42 INFO - 'MOZ_NO_REMOTE': '1', 12:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:42 INFO - 'NO_EM_RESTART': '1', 12:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:42 INFO - 'PWD': '/builds/slave/test', 12:24:42 INFO - 'SHELL': '/bin/bash', 12:24:42 INFO - 'SHLVL': '1', 12:24:42 INFO - 'TERM': 'linux', 12:24:42 INFO - 'TMOUT': '86400', 12:24:42 INFO - 'USER': 'cltbld', 12:24:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', 12:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:42 INFO - '_': '/tools/buildbot/bin/python'} 12:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:42 INFO - Running setup.py (path:/tmp/pip-LKvLIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:42 INFO - Running setup.py (path:/tmp/pip-BAXdTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:43 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)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:43 INFO - Running setup.py (path:/tmp/pip-7HImvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:43 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)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:43 INFO - Running setup.py (path:/tmp/pip-QIQutn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:43 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)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:43 INFO - Running setup.py (path:/tmp/pip-Ncb6Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:43 INFO - Running setup.py (path:/tmp/pip-H1h7YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:43 INFO - Running setup.py (path:/tmp/pip-V2UBVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:43 INFO - Running setup.py (path:/tmp/pip-6FZf4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:43 INFO - Running setup.py (path:/tmp/pip-0Oecuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:43 INFO - Running setup.py (path:/tmp/pip-JkySzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:43 INFO - Running setup.py (path:/tmp/pip-fgMuuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:43 INFO - Running setup.py (path:/tmp/pip-jhp0dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:43 INFO - Running setup.py (path:/tmp/pip-4dpcaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:43 INFO - Running setup.py (path:/tmp/pip-kXmT6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:43 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)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:43 INFO - Running setup.py (path:/tmp/pip-lhq6G8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:43 INFO - Running setup.py (path:/tmp/pip-TxRkV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:44 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)) 12:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:44 INFO - Running setup.py (path:/tmp/pip-dqVhdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:44 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)) 12:24:44 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)) 12:24:44 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)) 12:24:44 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)) 12:24:44 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)) 12:24:44 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)) 12:24:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:24:44 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 12:24:44 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 12:24:44 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 12:24:44 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 12:24:44 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 12:24:44 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 12:24:45 INFO - Downloading blessings-1.6.tar.gz 12:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:24:46 INFO - Installing collected packages: blessings 12:24:46 INFO - Running setup.py install for blessings 12:24:46 INFO - Successfully installed blessings 12:24:46 INFO - Cleaning up... 12:24:46 INFO - Return code: 0 12:24:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:24:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:24:46 INFO - Reading from file tmpfile_stdout 12:24:46 INFO - Current package versions: 12:24:46 INFO - argparse == 1.2.1 12:24:46 INFO - blessings == 1.6 12:24:46 INFO - blobuploader == 1.2.4 12:24:46 INFO - docopt == 0.6.1 12:24:46 INFO - functools32 == 3.2.3-2 12:24:46 INFO - jsonschema == 2.5.1 12:24:46 INFO - manifestparser == 1.1 12:24:46 INFO - mozInstall == 1.12 12:24:46 INFO - mozcrash == 0.17 12:24:46 INFO - mozdebug == 0.1 12:24:46 INFO - mozdevice == 0.48 12:24:46 INFO - mozfile == 1.2 12:24:46 INFO - mozhttpd == 0.7 12:24:46 INFO - mozinfo == 0.9 12:24:46 INFO - mozleak == 0.1 12:24:46 INFO - mozlog == 3.4 12:24:46 INFO - moznetwork == 0.27 12:24:46 INFO - mozprocess == 0.23 12:24:46 INFO - mozprofile == 0.28 12:24:46 INFO - mozrunner == 6.12 12:24:46 INFO - mozscreenshot == 0.1 12:24:46 INFO - mozsystemmonitor == 0.3 12:24:46 INFO - moztest == 0.7 12:24:46 INFO - mozversion == 1.4 12:24:46 INFO - psutil == 3.1.1 12:24:46 INFO - requests == 1.2.3 12:24:46 INFO - wsgiref == 0.1.2 12:24:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb14435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ef60>, '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 0x1d9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da01d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', '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 12:24:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:24:46 INFO - Using env: {'DISPLAY': ':0', 12:24:46 INFO - 'HOME': '/home/cltbld', 12:24:46 INFO - 'LANG': 'en_US.UTF-8', 12:24:46 INFO - 'LANGUAGE': 'en_US:en', 12:24:46 INFO - 'LOGNAME': 'cltbld', 12:24:46 INFO - 'MAIL': '/var/mail/cltbld', 12:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:46 INFO - 'MOZ_NO_REMOTE': '1', 12:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:46 INFO - 'NO_EM_RESTART': '1', 12:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:46 INFO - 'PWD': '/builds/slave/test', 12:24:46 INFO - 'SHELL': '/bin/bash', 12:24:46 INFO - 'SHLVL': '1', 12:24:46 INFO - 'TERM': 'linux', 12:24:46 INFO - 'TMOUT': '86400', 12:24:46 INFO - 'USER': 'cltbld', 12:24:46 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', 12:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:46 INFO - '_': '/tools/buildbot/bin/python'} 12:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:24:46 INFO - Cleaning up... 12:24:46 INFO - Return code: 0 12:24:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb14435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ef60>, '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 0x1d9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da01d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', '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 12:24:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:24:46 INFO - Using env: {'DISPLAY': ':0', 12:24:46 INFO - 'HOME': '/home/cltbld', 12:24:46 INFO - 'LANG': 'en_US.UTF-8', 12:24:46 INFO - 'LANGUAGE': 'en_US:en', 12:24:46 INFO - 'LOGNAME': 'cltbld', 12:24:46 INFO - 'MAIL': '/var/mail/cltbld', 12:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:46 INFO - 'MOZ_NO_REMOTE': '1', 12:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:46 INFO - 'NO_EM_RESTART': '1', 12:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:46 INFO - 'PWD': '/builds/slave/test', 12:24:46 INFO - 'SHELL': '/bin/bash', 12:24:46 INFO - 'SHLVL': '1', 12:24:46 INFO - 'TERM': 'linux', 12:24:46 INFO - 'TMOUT': '86400', 12:24:46 INFO - 'USER': 'cltbld', 12:24:46 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', 12:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:46 INFO - '_': '/tools/buildbot/bin/python'} 12:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:24:46 INFO - Cleaning up... 12:24:46 INFO - Return code: 0 12:24:46 INFO - Running post-action listener: _resource_record_post_action 12:24:46 INFO - Running post-action listener: _start_resource_monitoring 12:24:46 INFO - Starting resource monitoring. 12:24:46 INFO - [mozharness: 2016-09-27 19:24:46.939670Z] Finished create-virtualenv step (success) 12:24:46 INFO - [mozharness: 2016-09-27 19:24:46.940214Z] Running install step. 12:24:46 INFO - Running pre-action listener: _resource_record_pre_action 12:24:46 INFO - Running main action method: install 12:24:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:24:47 INFO - Reading from file tmpfile_stdout 12:24:47 INFO - Detecting whether we're running mozinstall >=1.0... 12:24:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:24:47 INFO - Reading from file tmpfile_stdout 12:24:47 INFO - Output received: 12:24:47 INFO - Usage: mozinstall [options] installer 12:24:47 INFO - Options: 12:24:47 INFO - -h, --help show this help message and exit 12:24:47 INFO - -d DEST, --destination=DEST 12:24:47 INFO - Directory to install application into. [default: 12:24:47 INFO - "/builds/slave/test"] 12:24:47 INFO - --app=APP Application being installed. [default: firefox] 12:24:47 INFO - mkdir: /builds/slave/test/build/application 12:24:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:25:03 INFO - Reading from file tmpfile_stdout 12:25:03 INFO - Output received: 12:25:03 INFO - /builds/slave/test/build/application/firefox/firefox 12:25:03 INFO - Running post-action listener: _resource_record_post_action 12:25:03 INFO - [mozharness: 2016-09-27 19:25:03.197567Z] Finished install step (success) 12:25:03 INFO - [mozharness: 2016-09-27 19:25:03.197814Z] Running run-tests step. 12:25:03 INFO - Running pre-action listener: _resource_record_pre_action 12:25:03 INFO - Running main action method: run_tests 12:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:25:03 INFO - Python 2.7.3 12:25:03 INFO - Return code: 0 12:25:03 INFO - grabbing minidump binary from tooltool 12:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:03 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ef60>, '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 0x1d9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:25:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:25:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:25:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:25:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:25:03 INFO - Return code: 0 12:25:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:25:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:25:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:25:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:25:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 12:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 12:25:03 INFO - Using env: {'DISPLAY': ':0', 12:25:03 INFO - 'HOME': '/home/cltbld', 12:25:03 INFO - 'LANG': 'en_US.UTF-8', 12:25:03 INFO - 'LANGUAGE': 'en_US:en', 12:25:03 INFO - 'LOGNAME': 'cltbld', 12:25:03 INFO - 'MAIL': '/var/mail/cltbld', 12:25:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:25:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:03 INFO - 'MOZ_NO_REMOTE': '1', 12:25:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:03 INFO - 'NO_EM_RESTART': '1', 12:25:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:03 INFO - 'PWD': '/builds/slave/test', 12:25:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:25:03 INFO - 'SHELL': '/bin/bash', 12:25:03 INFO - 'SHLVL': '1', 12:25:03 INFO - 'TERM': 'linux', 12:25:03 INFO - 'TMOUT': '86400', 12:25:03 INFO - 'USER': 'cltbld', 12:25:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740', 12:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:03 INFO - '_': '/tools/buildbot/bin/python'} 12:25:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 12:25:03 INFO - mozversion application_buildid: 20160927092620 12:25:03 INFO - mozversion application_changeset: 6dd548d6b45aa8aed064d185d1a92d8944cdef5c 12:25:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:25:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:25:03 INFO - mozversion application_name: Firefox 12:25:03 INFO - mozversion application_remotingname: firefox-dev 12:25:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:25:03 INFO - mozversion application_vendor: Mozilla 12:25:03 INFO - mozversion application_version: 51.0a2 12:25:03 INFO - mozversion platform_buildid: 20160927092620 12:25:03 INFO - mozversion platform_changeset: 6dd548d6b45aa8aed064d185d1a92d8944cdef5c 12:25:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:25:03 INFO - mozversion platform_version: 51.0a2 12:25:03 INFO - using testdate: 1475004303 12:25:03 INFO - actual date: 1475004303 12:25:03 INFO - starting webserver on 'localhost:48231' 12:25:03 INFO - SUITE-START | Running 2 tests 12:25:03 INFO - TEST-START | dromaeo_css 12:25:03 INFO - operating with platform_type : linux_ 12:25:03 INFO - Initialising browser for dromaeo_css test... 12:25:03 INFO - TEST-INFO | started process 7891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOT7SgB/profile http://localhost:48231/getInfo.html) 12:25:06 INFO - PROCESS | 7891 | __metrics Screen width/height:1600/1200 12:25:06 INFO - PROCESS | 7891 | colorDepth:24 12:25:06 INFO - PROCESS | 7891 | Browser inner width/height: 1024/697 12:25:06 INFO - PROCESS | 7891 | __metrics 12:25:07 INFO - PROCESS | 7891 | 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" 12:25:07 INFO - PROCESS | 7891 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:25:07 INFO - PROCESS | 7891 | console.error: PushService: 12:25:07 INFO - PROCESS | 7891 | stateChangeProcessEnqueue: Error transitioning state 12:25:07 INFO - PROCESS | 7891 | UnknownError 12:25:08 INFO - TEST-INFO | 7891: exit 0 12:25:08 INFO - Browser initialized. 12:25:08 INFO - Running cycle 1/1 for dromaeo_css test... 12:25:08 INFO - TEST-INFO | started process 7986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOT7SgB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:25:20 INFO - PROCESS | 7986 | RSS: Main: 144613376 12:25:20 INFO - PROCESS | 7986 | 12:26:11 INFO - PROCESS | 7986 | 1475004371373 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] 12:28:20 INFO - PROCESS | 7986 | Cycle 1(1): loaded http://localhost:48231/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48231/tests/dromaeo/cssquery-ext.html) 12:28:22 INFO - PROCESS | 7986 | RSS: Main: 241635328 12:28:22 INFO - PROCESS | 7986 | 12:31:24 INFO - PROCESS | 7986 | Cycle 1(1): loaded http://localhost:48231/tests/dromaeo/cssquery-ext.html (next: http://localhost:48231/tests/dromaeo/cssquery-jquery.html) 12:31:24 INFO - PROCESS | 7986 | RSS: Main: 235024384 12:31:24 INFO - PROCESS | 7986 | 12:34:26 INFO - PROCESS | 7986 | Cycle 1(1): loaded http://localhost:48231/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48231/tests/dromaeo/cssquery-mootools.html) 12:34:27 INFO - PROCESS | 7986 | RSS: Main: 230793216 12:34:27 INFO - PROCESS | 7986 | 12:37:29 INFO - PROCESS | 7986 | Cycle 1(1): loaded http://localhost:48231/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48231/tests/dromaeo/cssquery-prototype.html) 12:37:29 INFO - PROCESS | 7986 | RSS: Main: 174632960 12:37:29 INFO - PROCESS | 7986 | 12:40:32 INFO - PROCESS | 7986 | Cycle 1(1): loaded http://localhost:48231/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48231/tests/dromaeo/cssquery-yui.html) 12:40:33 INFO - PROCESS | 7986 | RSS: Main: 177844224 12:40:33 INFO - PROCESS | 7986 | 12:43:35 INFO - PROCESS | 7986 | Cycle 1(1): loaded http://localhost:48231/tests/dromaeo/cssquery-yui.html (next: http://localhost:48231/tests/dromaeo/cssquery-dojo.html) 12:43:36 INFO - PROCESS | 7986 | RSS: Main: 264978432 12:43:36 INFO - PROCESS | 7986 | 12:43:36 INFO - PROCESS | 7986 | __start_tp_report 12:43:36 INFO - PROCESS | 7986 | _x_x_mozilla_page_load 12:43:36 INFO - PROCESS | 7986 | _x_x_mozilla_page_load_details 12:43:36 INFO - PROCESS | 7986 | |i|pagename|runs| 12:43:36 INFO - PROCESS | 7986 | |0;dojo.html;3148.8897888573897;3169.0809665197085;3187.394395064936;3207.7433805295577;3227.4997375406806;5655.349634792;5689.8577535561635;5698.971505142474;5746.281714785652;5759.856003599912;5693.572982026344;5772.855678608037;5774.797882074128;5780.450857168562;5781;5200.635955483108;5206.3231779868565;5217.139172036628;5243.764030618631;5278.894422111555;4993.475685053071;5289.20661900716;5291.3385826771655;5304.045271851065;5328.17413300939;4945.950540494603;5147.7426128693605;5186.118359878829;5225.895482090375;5239.947600523984;5184.792608295664;5207.869803254911;5209.088409528336;5244.763985620656;5249.790008399659;5128.871778205537;5167.741612919376;5235.136202526579;5245.737713114329;5273.762680679379;5533.861653458655;5548.306461692288;5601.215829783833;5615.241942337814;5674.375818659944;6021.909671354933;6051.697415129226;6056.031035034417;6145.446909778097;6162.630242185483;6188.164597779287;6189.87620247597;6203.472704820096;6203.751849925998;6215;5487.478689524489;5530.087535556629;5658.066419040894;5716.971415142898;5779.190913272145;6256.562040657111;6296.8425789354715;6298.0552917062805;6302.527310451735;6302.936970630235;6064.06007068905;6067.332593414721;6075.969620151871;6078.422549857756;6078.939210607926;5758.654480731169;5791.333996590446;6065.2418447694035;6127.142200091991;6164.352742962014;6161.291451483047;6164.044573091178;6172.629642221481;6178.320384757673;6180.103884936659;6136.938630613726;6157.199564056644;6173.629582225081;6192.845178870564;6203.2556093269095;4533.569310915458;4597.4712908015335;4646.3495110684535;4724.95275047252;4764.857054288377;4142.212979533879;4161.750294982311;4164.583541645872;4176.812043458051;4199.601037901394;5951.464368206882;5964.493018093423;5966.701664916737;5967.761289548456;6005.099235114768;6023.548233882477;6065.848353791191;6245.843853903598;6248.656323902229;6262.091996660459;5786.652800831964;5806.44838740319;5820.3888591698105;5822.796202132905;5862.14998825168;5157.896842063138;5161.2516185152945;5191.532762051434;5201.947980520222;5207.635465517377;6205.875882482234;6369.363063693686;6392.776252831129;6424.903626445701;6442.2591401989375;6082.2701275847185;6097.054956481752;6133.1510485532735;6137.744733333838;6214.782482613267;6424.2933277338525;6434.871302573829;6436.324185960407;6441.066045423481;6446.355364463516;6067.423594758491;6089.360617135314;6097.725602347817;6098.0852872069545;6107.664078475549;5924.644521328734;6026.186464827192;6088.665123418255;6103.206583144163;6132.846678832886;6071.848203794941;6077.149199112217;6077.726502307319;6087.878242435215;6112.205413296243;6038.003729384603;6063.484603808725;6076.635401875901;6088.208532890696;6090.786822461193;5780.884382312246;5805.535557155333;5806.2451881255165;5810.331811841692;5814.767409303749;5899.351071382231;5929.673867937305;5943.58394912352;5946.137810017437;5946.613470124601;5638.802641907513;5737.397573254748;5790.449907258803;5791.131330300489;5797.768089276382 12:43:36 INFO - PROCESS | 7986 | |1;ext.html;591.7218907113655;619.1610367951425;653.6927644007318;654.6268626882679;672.4351544702455;34018.65981340186;44915.10169796606;46804.531954680446;46873.29690054652;46882.76558617202;48901.266481002815;49139;49497.75251123739;49502.00995980078;49597;8592.828143437127;9355.76610584734;9503.239740820718;9509.762255943588;9511.667091651794;8570.957145214265;11094.778104437906;11330.773384532304;11343.205975581712;11825.586104486345;11532.71168220797;11557.65327040186;11587.826182607268;11601.593944211954;11612.303261804276;11335.773284534303;11372.943135284353;11379.203455758101;11396.088312934946;11417.42912854354;11155.944220278929;11183.273087249303;11225.158113141466;11251;11260.324380537195;45786;46096.07807843858;46100.07799843985;46175.76912115418;46194.307085393746;3746.269477451871;3987.023179321056;4047.1703300823556;4172.499300083979;4583.335416364642;34686.47970280448;35296.470552941726;35354.469682954776;35434.46848297278;37335.25329493395;4787.377640906695;4867.683600565952;4870.634702397334;4892;4933.70397776131;365394;366287.9999999973;366696;367077;367389;64592;64760.35239647637;64850;65030;65042;40197.59802401997;41882;42122.57877421186;44293.33559996603;44374.778126109806;19658.508537286398;19679.31122410709;19699.507512312306;19832.90083549573;19840.404787856387;13237.139585926883;13686;14656.926715366355;15038.473653422077;15125;20457.2839950601;21209.89395053046;21226.575468490544;21237.256696015564;21276.893615531822;7594.7469417125485;7660.310572048543;7711.113221979432;7732.806679833049;7808.960955195188;988.9406635601887;1075.3924032921532;1078.013617539942;1116.6538373104202;1157.7163594919298;34201.82899085488;34657.72428316213;34979.4753078704;34985;35055.29889402198;1126.9436528173721;1169.1465230381698;1171;1232.8226543650792;1267.6513958661258;18112.45662630123;18166.27334906589;18167.909160454114;18224;18225;602757;603735;603813;605159;606404;63011.369886301465;63704.36295636984;63787.36212637907;63978.36021639817;64003.679981600726;1297.1568480487758;1331.6803967048033;1370.616227456314;1400.5588239704462;1424.8432672406234;33609.327813444084;35748;35874;36060;36103.45844812277;54734;55301.170482441994;55436.72281638566;55491;55568.72215639058;431137;433461;434416;434491;517484;44710.3293450592;47889.5211047899;48075;48515.5148448511;48965.26552101793;52807.623656936295;52890;53008.73495632497;53317.200241995626;53414.465855340946;43153;43457.60983145957;44273.33589996217;47995.28007079827;48265;44433.33349999688;45210.547894520634;45587.316190257836;45808.77095614634;46613.533864660916;44045.77977110222;44279.55720442755;45046.77476612596;45495.545044550454;45631;38731;40645.593544064184;40753.1849363017;40798.79600601978;41678.58321416747;30383.240418989702;30531;30561.388772224876;30573.694263057085;30656.846715766278 12:43:36 INFO - PROCESS | 7986 | |2;jquery.html;400.7235007844589;413.80551140963735;426.7823410060869;431.37019950871723;447.4742177940919;15389.923050384747;19486.1231244594;21488.785112148893;21515.892420537915;21911.890440547813;18571;18689.90655046726;18777.906110469463;19277.614447711036;20511.589768204627;5791.189233507302;5990.430909063653;5995.910061349084;5997.85005374867;6000.18997435345;5662.433756624346;5927.644341339512;5963.910541341883;6061.66660833654;6062.605930614496;5920.674362910038;6044.304904935944;6050.757969681207;6063.454289113979;6065.150878876961;6110.20567326247;6289.276733175698;6300.401461861139;6305.842353941142;6311.558190926637;5942.405759424067;6093.939060609426;6111.724972376253;6161.630302181883;6162.67502486963;15262.23688815566;15292.158931258777;15417;15447.768283475756;15632.765508517381;2293.7820907013806;2452.509498100369;2549.8342607730438;2552.8851201695784;2736.261209473451;15949.760753588705;16451.91774041122;16754.246058927376;16861.747073793904;17434.564135896577;1988.9005549722601;1991.6713742232514;2123.1507397041305;2246.0903334149693;2307.180950762489;96263.51868240684;96597;97180.51409742906;98651;99758;14684.237891453095;18950.336738214373;19208.423747287605;19300.420987370402;19539.706904396444;30705.539416908763;34323.141921451665;34448.48327275093;34465;34476.655233447345;10865.619703310345;11002.284851484788;11078.390688512049;11176.888231117584;11232;9424;9441.15029647335;9484.0515948406;9497.667581634609;9720.125188733047;9170.67902623405;9281.076460914925;9459.19596834263;9592.616295348247;9656.806863862825;3274.9672503274664;3319.8008119512906;3406.8316465686653;3617.3127105849803;3638.636136386393;957.3250858144991;968.7239136845965;969.1132613658565;1000.1099021870541;1006.285537268533;19555.924424156525;20167.899160504396;20479.488012799502;20543;20687.241584465188;1021.3514418344405;1021.5556233038652;1039.0752230514847;1052.6947185316174;1066.5520481397832;10439.269251152498;11345;11431.885681143249;11506.827397589042;11542.59600913964;444401;446935;449721;482354;509001;94280.52859735658;94653;96057;97631.51184244176;98129.50935245278;1013.2603199664286;1039.184240371305;1057.8254587992894;1064.4784055812752;1080.0873262093519;17451.912740436725;17811.287548497916;17846.553836153682;18104.547386315448;18278.177482013074;33397.49903751397;34915.82542087375;39903.80048099741;40184.799076004434;43407.782961084995;57970;59002.40997589969;59025.70487147537;60317;62575.6871215641;8671.566421679017;9204.401713888576;9345.392549484262;9586;9633.421994680342;7566.281203285679;11127.332360058423;12195.878041219474;13372.665683357995;13890.30548472552;12071.818922716342;12368.1960672556;12428.192167509083;12536.310502922426;12568;11444.484998175269;11848.822267666164;12278.140530162802;12484.12611117213;12549.184303020274;6303.968480157753;9676.9032309676;11183.378410130648;12296.569620063256;12680.6829829255;9259.259259259108;9294.581743821409;9322.300827437834;9503.66737164196;9582.856257156009;11668.766624667629;12325.445354958869;12526.218184883566;12625;12757.93621031926 12:43:36 INFO - PROCESS | 7986 | |3;mootools.html;1548.2723120133533;1549.6435819761455;1692.7884014498188;1788.669096217199;1819.590592116774;9361.391509551875;10064.24518161138;10067.144292735107;10068.69793906183;10073.143782778472;8215.301699355561;8449.493030418163;9327.533623318841;9581.137697607213;9823.65617203398;2593.7924966002674;2611.0469678567374;2626.579747240442;2627.238100950722;2629.447815958651;2549.961750573743;2644.2067379786085;2644.920652380422;2647.2058382485275;2648.1525911708263;2602.3233959170657;2617.5419301622237;2640.221134765239;2646.140004498536;2647.3116989582654;2569.0494517028724;2574.652421923035;2621.7247189045065;2621.89512419503;2627.8948842046293;2492.7756501914732;2530.6204069389737;2543.9364015899564;2545.389106614418;2565.3714839864165;9848;9912;9922.156616687591;9938.9503052485;9943.801123977551;5827.475527202572;5996.100584912255;6004;6006.039033754622;6017.187679663233;3616.150204701893;3634.0914771307175;3660.816959152058;3665.6700896919137;3669.541307336583;1186.1993154620682;1246.7070238493948;1251.1179618369029;1270.8538518070447;1283.8844503994685;13867.930660346734;13917.164970101827;13918.164910105426;13928.37322320498;13956.93021534896;5014.122528557488;5128.948710512847;5206.843794686166;5273.866118784403;5294.729264976378;11470.025047870857;11511.136664750009;11526.711832204262;11623.360715160747;11624.709382265512;5768.3654797972185;5773.509251713652;5775.104858746901;5776.729119593682;5779.768809247583;4526.841560545365;4615.16926953145;5294.285271488377;5373.35519737634;5416.458354164631;4389.6927215095275;4398.846040388571;4448.977755111204;4467.285234362486;4502.077074199781;1368.6304697731557;1415.1509094543192;1421.9360128794228;1428.7713965765427;1429.5854202281223;1016.4917541229386;1026.4457193115634;1032.7108409645311;1037.5071840875523;1042.8435734639866;6281.560290779602;6525.086487891699;6612.07430959666;6630.867382652416;6780.627065511346;484.91513985053183;487.11831584831566;492.0454318621862;502.5175831202014;503.6826799116606;4410.42664453619;4423.51341352451;4455;4496.5503449655425;4617.8383756568355;11923.880761192451;12229.938850305869;12322.075844311534;12326.938365308117;12347;11973.700657483458;12190.2076365036;12198.085143614264;12198.634040978784;12390.070744694183;9069.818603627758;9120.543972801333;9203.723888283363;9215.585298661576;9220.170184683411;6373.8725225496155;6432.067350234283;6466.838329041811;6522.934770652422;6542.771003014872;10923.344599324066;11253.268537545033;11325.15061370417;11328.886711132784;11336.94331528337;11260.83108753353;11326.773464530828;11422.31466112036;11552.191346605658;11579.594714184963;8406.243438090602;8501.064882862756;8634.309255259439;8705.303575714055;8752.91247087521;9351.766205844908;9375.671851485165;9421.905780942378;9467.621295148392;9467.905320946702;8252.21603947624;8272.958635206785;8330.416870818985;8353;8373.958130209554;7837.13791482925;7877.251661092187;7881.172476890073;8031.678732850621;8103.83792324162;7514.023176986957;7532.39740820744;7639.121501027453;7758.224177582197;7874.3306818918745;5203.687778733288;5212.530872221519;5214.113600687968;5334.51989320963;5558.194061860927;5345.812896548602;5368.32895888014;5385.838424847261;5441.129419293053;5559.805406810742 12:43:36 INFO - PROCESS | 7986 | |4;prototype.html;335.05013287330416;350.51803769816513;356.43149177062594;367.979761113139;371.94048952167657;5570.86072848179;5578.470045345691;5591.245181900442;5591.944080559193;5626.324841019084;5526.447355264471;5528.032594296003;5548.9722551387285;5549.278593782813;5554.222408862763;3813.656770890619;4139.917201655965;4298.355246713002;4354.976580503595;4362.541933097027;4364.236258654739;4369.213541562517;4370.453693288339;4377;4380.299152135643;4364.629006534448;4364.759938203398;4365.759883206439;4366.8253269869165;4371.235033869076;4105.5894410559;4155.854545090938;4299;4357.607815296638;4380.364847097169;3885.7862817545024;3892.610738926113;3893.299206142893;3894.6884249259992;3899.908025752794;5349.411564727877;5352.223927530486;5355.357357117132;5363.302770639831;5363.980843639735;4838.250071238928;4980.452150263468;5006.249062640633;5008.373953255843;5023.79904803811;5771.653700777967;5771.884562308773;5772.134179873053;5789.855253618651;5793.73928173229;4278.679099067551;4290.785460726951;4298.548652391516;4310;4313.784310784479;5652.660840349551;5806.361300256968;5853.824385268449;5942.712055858482;5996.880062398727;4308.590683885026;4405.867823965286;4408.669349798778;4414.977925110354;4427.826625944127;4460.754658493814;4501.344206917935;4501.774911254424;4506.3916371290115;4508.233600287959;4880;4987.900241995212;5037.69773813565;5051.292819005343;5059.544640982329;5852.098068127875;5856.326522449887;5859.44335288147;5890.440408161217;5899.734511946973;1548.4889986304493;1563.8045244344457;1565.3425561264296;1566.4517418903292;1569.7566877134063;965.7054598347431;994.7416518104603;995.8705368302075;1017.7760892603616;1026.1226651213105;5088.872778180501;5104.41299250591;5105.668131571436;5110.897782044338;5119.59043276537;5296.364436267672;5320.940459235955;5324.361076670824;5343.519083282523;5348.438413966477;4857.271409288635;4991.126552853236;5064.518870707277;5104.489551044866;5106.259592359087;2810.943781124366;2832.5751137329567;2833;2839.872205750746;2847.9145625631263;5405.432424596823;5416.3750874737425;5417.916416716594;5434.945650543523;5436.836894893159;4947.911459478909;5342.385625653022;5348.331458567679;5413.242146099549;5427.294451721251;5475.7262136893;5492.752826122834;5494;5494.560435165177;5520.91718624221;4944;5308.859089909876;5313.548348390275;5314.468553144655;5335.439778823167;5152.948470515397;5205.609579281493;5217.399999000164;5231.869203269949;5233.136532472252;5895.764169433174;6064.302605200459;6095.969520152371;6213.1922850029205;6228.657423841551;4459.665525085697;4460.910781784281;4463.776811159494;4472.485664148665;4473.821047158077;5780.306363236438;5947.137665038632;6011.633485248275;6026.578139530191;6045.455908968214;5909.261342332208;5921.733521991435;5925.703714814156;5928.525717942468;5932.406759324033;5885.175595565388;5917.437843404869;5940.702964851654;5942.257217847769;5963.2844058713235;5720.685362305113;5868.354481007001;5927.614705044159;5929.377415371497;5934.7922822701;5866.919867069651;5916.940830591639;5958.76164953397;5962.314333851663;5967.880642387215;5631.774729010794;5772.729999400125;5772.913406298993;5784.132380143013;5789.623674461147 12:43:36 INFO - PROCESS | 7986 | |5;yui.html;797.5374282915909;860.5697151424284;884.5311984648137;900.1988230474878;913.3971578758013;16981.660366792672;17755.822441775577;18043;18115;18125.456236312915;16210.270537825796;16241.83758162421;16370.345186192568;16380.426685066024;16382.918085409556;718.3821913154683;740.3484933258725;839.5214727605268;866.536403024382;889.4929889962724;876.7983363826323;883.8718385834051;883.9381243312938;884.1732979664034;885.0706757904208;945.2154711589365;945.8202941441104;946.2713710442955;946.9289803264749;946.9384490008161;756.9394448444111;774.7365895595497;776.3711393771007;778.941579381543;939.5959737312953;643.7489379142138;660.2407231683554;662.19543254945;663.9170103737033;665.2615596687673;16150.030998140031;16184.433544825992;16206.918965405097;16207.270672819752;16218;15169.08985460876;15477.380904763908;15487.225638718019;15630.14034228117;15940.20298985046;13178.34108294591;13373.933130334286;13468;13486.797698034537;13493.730125397535;4688.413948256468;4739.73931433771;4769.809207631691;4927.334809800703;4951.62862785289;90702;91285;92736;94688.52655736677;95818;11842.822357664641;12446.875531244752;12511.562095326803;12570.497180112692;12774.744505109846;22774.316770496913;22844.4288892779;22943.655845162335;23056.4235894104;23116.768832311798;8370.874436883452;8515.914840851636;8717.564121793885;8944.195022448012;9081.182693557612;4889.926651100236;5009.924851127236;5089.898202035939;5099.260607211933;5151.922721159186;3717.219383929351;3839.212961342918;3854.4218367244575;3859.421086836941;3859.942100868433;741.8738814401564;743.4907088644296;753.1075675324757;773.4353921637236;783.3772151139857;736.6095969136367;796.5618909599697;796.6654005317664;813.8616435206029;820.6266148902355;10206.336588121749;10289.845652315222;10596.682099537025;10655.680329590125;10711.303765255234;656.3846294946682;697.6328185558441;818.1368656067787;822.5106061893164;823.8480238044516;5069.1635880079375;5200.7919683213;5268.130758424817;5380.623356365017;5399.892002159935;81844;82075;82121.58939205266;115159;133971;69806;114222;115885.42057289659;116558;118870.4056479712;94671;94943;95475;95848;96046;9988;10092.236052655157;10225.693229203136;10373.896261037293;10403.271770975958;58536.4146358531;58803.70598146982;59033.70483147557;59403.702981484814;59594.40405596062;83279;84228.15771842204;84622.30755384981;84805;86672;12674.493020279086;13217.206967581977;13319.467221311426;13579.864201358256;13590.864091359355;13016.15394999322;13137.802932956205;13223.801642975171;13260.138091024053;13540;14375.568732938029;14999.7000059996;15021.77467337969;15247.695046098794;15327.46353877609;13233.3383330835;13475.865241347461;13985.300734963415;14416.342120656258;14773.778393323893;12374.938125309676;13112.606621801362;13453.865461345653;13812.240326782123;14008.719825603635;10195.235357348376;10495.580176793148;10720.785584288427;10813.080888124283;10839.241253112521;10545.156387489136;10583.341586610068;10697.197710171613;10764.784704306026;10881.238313317992 12:43:36 INFO - PROCESS | 7986 | __end_tp_report 12:43:36 INFO - PROCESS | 7986 | __start_cc_report 12:43:36 INFO - PROCESS | 7986 | _x_x_mozilla_cycle_collect,916 12:43:36 INFO - PROCESS | 7986 | __end_cc_report 12:43:36 INFO - PROCESS | 7986 | __startTimestamp1475005416135__endTimestamp 12:43:36 INFO - PROCESS | 7986 | 12:43:36 INFO - PROCESS | 7986 | ------- Summary: start ------- 12:43:36 INFO - PROCESS | 7986 | Number of tests: 6 12:43:36 INFO - PROCESS | 7986 | 12:43:36 INFO - PROCESS | 7986 | [#0] dojo.html Cycles:165 Average:5685.12 Median:5899.35 stddev:673.67 (11.4%) stddev-sans-first:645.69 12:43:36 INFO - PROCESS | 7986 | Values: 3148.9 3169.1 3187.4 3207.7 3227.5 5655.3 5689.9 5699.0 5746.3 5759.9 5693.6 5772.9 5774.8 5780.5 5781.0 5200.6 5206.3 5217.1 5243.8 5278.9 4993.5 5289.2 5291.3 5304.0 5328.2 4946.0 5147.7 5186.1 5225.9 5239.9 5184.8 5207.9 5209.1 5244.8 5249.8 5128.9 5167.7 5235.1 5245.7 5273.8 5533.9 5548.3 5601.2 5615.2 5674.4 6021.9 6051.7 6056.0 6145.4 6162.6 6188.2 6189.9 6203.5 6203.8 6215.0 5487.5 5530.1 5658.1 5717.0 5779.2 6256.6 6296.8 6298.1 6302.5 6302.9 6064.1 6067.3 6076.0 6078.4 6078.9 5758.7 5791.3 6065.2 6127.1 6164.4 6161.3 6164.0 6172.6 6178.3 6180.1 6136.9 6157.2 6173.6 6192.8 6203.3 4533.6 4597.5 4646.3 4725.0 4764.9 4142.2 4161.8 4164.6 4176.8 4199.6 5951.5 5964.5 5966.7 5967.8 6005.1 6023.5 6065.8 6245.8 6248.7 6262.1 5786.7 5806.4 5820.4 5822.8 5862.1 5157.9 5161.3 5191.5 5201.9 5207.6 6205.9 6369.4 6392.8 6424.9 6442.3 6082.3 6097.1 6133.2 6137.7 6214.8 6424.3 6434.9 6436.3 6441.1 6446.4 6067.4 6089.4 6097.7 6098.1 6107.7 5924.6 6026.2 6088.7 6103.2 6132.8 6071.8 6077.1 6077.7 6087.9 6112.2 6038.0 6063.5 6076.6 6088.2 6090.8 5780.9 5805.5 5806.2 5810.3 5814.8 5899.4 5929.7 5943.6 5946.1 5946.6 5638.8 5737.4 5790.4 5791.1 5797.8 12:43:36 INFO - PROCESS | 7986 | 12:43:36 INFO - PROCESS | 7986 | [#1] ext.html Cycles:180 Average:65249.96 Median:236629.79 stddev:128317.45 (54.2%) stddev-sans-first:128585.58 12:43:36 INFO - PROCESS | 7986 | Values: 591.7 619.2 653.7 654.6 672.4 34018.7 44915.1 46804.5 46873.3 46882.8 48901.3 49139.0 49497.8 49502.0 49597.0 8592.8 9355.8 9503.2 9509.8 9511.7 8571.0 11094.8 11330.8 11343.2 11825.6 11532.7 11557.7 11587.8 11601.6 11612.3 11335.8 11372.9 11379.2 11396.1 11417.4 11155.9 11183.3 11225.2 11251.0 11260.3 45786.0 46096.1 46100.1 46175.8 46194.3 3746.3 3987.0 4047.2 4172.5 4583.3 34686.5 35296.5 35354.5 35434.5 37335.3 4787.4 4867.7 4870.6 4892.0 4933.7 365394.0 366288.0 366696.0 367077.0 367389.0 64592.0 64760.4 64850.0 65030.0 65042.0 40197.6 41882.0 42122.6 44293.3 44374.8 19658.5 19679.3 19699.5 19832.9 19840.4 13237.1 13686.0 14656.9 15038.5 15125.0 20457.3 21209.9 21226.6 21237.3 21276.9 7594.7 7660.3 7711.1 7732.8 7809.0 988.9 1075.4 1078.0 1116.7 1157.7 34201.8 34657.7 34979.5 34985.0 35055.3 1126.9 1169.1 1171.0 1232.8 1267.7 18112.5 18166.3 18167.9 18224.0 18225.0 602757.0 603735.0 603813.0 605159.0 606404.0 63011.4 63704.4 63787.4 63978.4 64003.7 1297.2 1331.7 1370.6 1400.6 1424.8 33609.3 35748.0 35874.0 36060.0 36103.5 54734.0 55301.2 55436.7 55491.0 55568.7 431137.0 433461.0 434416.0 434491.0 517484.0 44710.3 47889.5 48075.0 48515.5 48965.3 52807.6 52890.0 53008.7 53317.2 53414.5 43153.0 43457.6 44273.3 47995.3 48265.0 44433.3 45210.5 45587.3 45808.8 46613.5 44045.8 44279.6 45046.8 45495.5 45631.0 38731.0 40645.6 40753.2 40798.8 41678.6 30383.2 30531.0 30561.4 30573.7 30656.8 12:43:36 INFO - PROCESS | 7986 | 12:43:36 INFO - PROCESS | 7986 | [#2] jquery.html Cycles:180 Average:30018.66 Median:3297.38 stddev:77437.98 (2348.5%) stddev-sans-first:77623.29 12:43:36 INFO - PROCESS | 7986 | Values: 400.7 413.8 426.8 431.4 447.5 15389.9 19486.1 21488.8 21515.9 21911.9 18571.0 18689.9 18777.9 19277.6 20511.6 5791.2 5990.4 5995.9 5997.9 6000.2 5662.4 5927.6 5963.9 6061.7 6062.6 5920.7 6044.3 6050.8 6063.5 6065.2 6110.2 6289.3 6300.4 6305.8 6311.6 5942.4 6093.9 6111.7 6161.6 6162.7 15262.2 15292.2 15417.0 15447.8 15632.8 2293.8 2452.5 2549.8 2552.9 2736.3 15949.8 16451.9 16754.2 16861.7 17434.6 1988.9 1991.7 2123.2 2246.1 2307.2 96263.5 96597.0 97180.5 98651.0 99758.0 14684.2 18950.3 19208.4 19300.4 19539.7 30705.5 34323.1 34448.5 34465.0 34476.7 10865.6 11002.3 11078.4 11176.9 11232.0 9424.0 9441.2 9484.1 9497.7 9720.1 9170.7 9281.1 9459.2 9592.6 9656.8 3275.0 3319.8 3406.8 3617.3 3638.6 957.3 968.7 969.1 1000.1 1006.3 19555.9 20167.9 20479.5 20543.0 20687.2 1021.4 1021.6 1039.1 1052.7 1066.6 10439.3 11345.0 11431.9 11506.8 11542.6 444401.0 446935.0 449721.0 482354.0 509001.0 94280.5 94653.0 96057.0 97631.5 98129.5 1013.3 1039.2 1057.8 1064.5 1080.1 17451.9 17811.3 17846.6 18104.5 18278.2 33397.5 34915.8 39903.8 40184.8 43407.8 57970.0 59002.4 59025.7 60317.0 62575.7 8671.6 9204.4 9345.4 9586.0 9633.4 7566.3 11127.3 12195.9 13372.7 13890.3 12071.8 12368.2 12428.2 12536.3 12568.0 11444.5 11848.8 12278.1 12484.1 12549.2 6304.0 9676.9 11183.4 12296.6 12680.7 9259.3 9294.6 9322.3 9503.7 9582.9 11668.8 12325.4 12526.2 12625.0 12757.9 12:43:36 INFO - PROCESS | 7986 | 12:43:36 INFO - PROCESS | 7986 | [#3] mootools.html Cycles:180 Average:6382.29 Median:4481.92 stddev:3707.00 (82.7%) stddev-sans-first:3699.60 12:43:36 INFO - PROCESS | 7986 | Values: 1548.3 1549.6 1692.8 1788.7 1819.6 9361.4 10064.2 10067.1 10068.7 10073.1 8215.3 8449.5 9327.5 9581.1 9823.7 2593.8 2611.0 2626.6 2627.2 2629.4 2550.0 2644.2 2644.9 2647.2 2648.2 2602.3 2617.5 2640.2 2646.1 2647.3 2569.0 2574.7 2621.7 2621.9 2627.9 2492.8 2530.6 2543.9 2545.4 2565.4 9848.0 9912.0 9922.2 9939.0 9943.8 5827.5 5996.1 6004.0 6006.0 6017.2 3616.2 3634.1 3660.8 3665.7 3669.5 1186.2 1246.7 1251.1 1270.9 1283.9 13867.9 13917.2 13918.2 13928.4 13956.9 5014.1 5128.9 5206.8 5273.9 5294.7 11470.0 11511.1 11526.7 11623.4 11624.7 5768.4 5773.5 5775.1 5776.7 5779.8 4526.8 4615.2 5294.3 5373.4 5416.5 4389.7 4398.8 4449.0 4467.3 4502.1 1368.6 1415.2 1421.9 1428.8 1429.6 1016.5 1026.4 1032.7 1037.5 1042.8 6281.6 6525.1 6612.1 6630.9 6780.6 484.9 487.1 492.0 502.5 503.7 4410.4 4423.5 4455.0 4496.6 4617.8 11923.9 12229.9 12322.1 12326.9 12347.0 11973.7 12190.2 12198.1 12198.6 12390.1 9069.8 9120.5 9203.7 9215.6 9220.2 6373.9 6432.1 6466.8 6522.9 6542.8 10923.3 11253.3 11325.2 11328.9 11336.9 11260.8 11326.8 11422.3 11552.2 11579.6 8406.2 8501.1 8634.3 8705.3 8752.9 9351.8 9375.7 9421.9 9467.6 9467.9 8252.2 8273.0 8330.4 8353.0 8374.0 7837.1 7877.3 7881.2 8031.7 8103.8 7514.0 7532.4 7639.1 7758.2 7874.3 5203.7 5212.5 5214.1 5334.5 5558.2 5345.8 5368.3 5385.8 5441.1 5559.8 12:43:36 INFO - PROCESS | 7986 | 12:43:36 INFO - PROCESS | 7986 | [#4] prototype.html Cycles:180 Average:4779.34 Median:5311.20 stddev:1365.71 (25.7%) stddev-sans-first:1328.18 12:43:36 INFO - PROCESS | 7986 | Values: 335.1 350.5 356.4 368.0 371.9 5570.9 5578.5 5591.2 5591.9 5626.3 5526.4 5528.0 5549.0 5549.3 5554.2 3813.7 4139.9 4298.4 4355.0 4362.5 4364.2 4369.2 4370.5 4377.0 4380.3 4364.6 4364.8 4365.8 4366.8 4371.2 4105.6 4155.9 4299.0 4357.6 4380.4 3885.8 3892.6 3893.3 3894.7 3899.9 5349.4 5352.2 5355.4 5363.3 5364.0 4838.3 4980.5 5006.2 5008.4 5023.8 5771.7 5771.9 5772.1 5789.9 5793.7 4278.7 4290.8 4298.5 4310.0 4313.8 5652.7 5806.4 5853.8 5942.7 5996.9 4308.6 4405.9 4408.7 4415.0 4427.8 4460.8 4501.3 4501.8 4506.4 4508.2 4880.0 4987.9 5037.7 5051.3 5059.5 5852.1 5856.3 5859.4 5890.4 5899.7 1548.5 1563.8 1565.3 1566.5 1569.8 965.7 994.7 995.9 1017.8 1026.1 5088.9 5104.4 5105.7 5110.9 5119.6 5296.4 5320.9 5324.4 5343.5 5348.4 4857.3 4991.1 5064.5 5104.5 5106.3 2810.9 2832.6 2833.0 2839.9 2847.9 5405.4 5416.4 5417.9 5434.9 5436.8 4947.9 5342.4 5348.3 5413.2 5427.3 5475.7 5492.8 5494.0 5494.6 5520.9 4944.0 5308.9 5313.5 5314.5 5335.4 5152.9 5205.6 5217.4 5231.9 5233.1 5895.8 6064.3 6096.0 6213.2 6228.7 4459.7 4460.9 4463.8 4472.5 4473.8 5780.3 5947.1 6011.6 6026.6 6045.5 5909.3 5921.7 5925.7 5928.5 5932.4 5885.2 5917.4 5940.7 5942.3 5963.3 5720.7 5868.4 5927.6 5929.4 5934.8 5866.9 5916.9 5958.8 5962.3 5967.9 5631.8 5772.7 5772.9 5784.1 5789.6 12:43:36 INFO - PROCESS | 7986 | 12:43:36 INFO - PROCESS | 7986 | [#5] yui.html Cycles:180 Average:22188.74 Median:4714.08 stddev:31847.71 (675.6%) stddev-sans-first:31896.55 12:43:36 INFO - PROCESS | 7986 | Values: 797.5 860.6 884.5 900.2 913.4 16981.7 17755.8 18043.0 18115.0 18125.5 16210.3 16241.8 16370.3 16380.4 16382.9 718.4 740.3 839.5 866.5 889.5 876.8 883.9 883.9 884.2 885.1 945.2 945.8 946.3 946.9 946.9 756.9 774.7 776.4 778.9 939.6 643.7 660.2 662.2 663.9 665.3 16150.0 16184.4 16206.9 16207.3 16218.0 15169.1 15477.4 15487.2 15630.1 15940.2 13178.3 13373.9 13468.0 13486.8 13493.7 4688.4 4739.7 4769.8 4927.3 4951.6 90702.0 91285.0 92736.0 94688.5 95818.0 11842.8 12446.9 12511.6 12570.5 12774.7 22774.3 22844.4 22943.7 23056.4 23116.8 8370.9 8515.9 8717.6 8944.2 9081.2 4889.9 5009.9 5089.9 5099.3 5151.9 3717.2 3839.2 3854.4 3859.4 3859.9 741.9 743.5 753.1 773.4 783.4 736.6 796.6 796.7 813.9 820.6 10206.3 10289.8 10596.7 10655.7 10711.3 656.4 697.6 818.1 822.5 823.8 5069.2 5200.8 5268.1 5380.6 5399.9 81844.0 82075.0 82121.6 115159.0 133971.0 69806.0 114222.0 115885.4 116558.0 118870.4 94671.0 94943.0 95475.0 95848.0 96046.0 9988.0 10092.2 10225.7 10373.9 10403.3 58536.4 58803.7 59033.7 59403.7 59594.4 83279.0 84228.2 84622.3 84805.0 86672.0 12674.5 13217.2 13319.5 13579.9 13590.9 13016.2 13137.8 13223.8 13260.1 13540.0 14375.6 14999.7 15021.8 15247.7 15327.5 13233.3 13475.9 13985.3 14416.3 14773.8 12374.9 13112.6 13453.9 13812.2 14008.7 10195.2 10495.6 10720.8 10813.1 10839.2 10545.2 10583.3 10697.2 10764.8 10881.2 12:43:36 INFO - PROCESS | 7986 | -------- Summary: end -------- 12:43:36 INFO - PROCESS | 7986 | 12:43:36 INFO - TEST-INFO | 7986: exit 0 12:43:36 INFO - TEST-OK | dromaeo_css | took 1113381ms 12:43:36 INFO - TEST-START | kraken 12:43:36 INFO - operating with platform_type : linux_ 12:43:36 INFO - Initialising browser for kraken test... 12:43:36 INFO - TEST-INFO | started process 8304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnVzXd0/profile http://localhost:48231/getInfo.html) 12:43:40 INFO - PROCESS | 8304 | __metrics Screen width/height:1600/1200 12:43:40 INFO - PROCESS | 8304 | colorDepth:24 12:43:40 INFO - PROCESS | 8304 | Browser inner width/height: 1024/697 12:43:40 INFO - PROCESS | 8304 | __metrics 12:43:40 INFO - PROCESS | 8304 | 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" 12:43:40 INFO - PROCESS | 8304 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:43:41 INFO - PROCESS | 8304 | console.error: PushService: 12:43:41 INFO - PROCESS | 8304 | stateChangeProcessEnqueue: Error transitioning state 12:43:41 INFO - PROCESS | 8304 | UnknownError 12:43:41 INFO - TEST-INFO | 8304: exit 0 12:43:41 INFO - Browser initialized. 12:43:41 INFO - Running cycle 1/1 for kraken test... 12:43:41 INFO - TEST-INFO | started process 8395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnVzXd0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:43:53 INFO - PROCESS | 8395 | RSS: Main: 144007168 12:43:53 INFO - PROCESS | 8395 | 12:43:55 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48231/tests/kraken/driver.html?testName=audio-beat-detection) 12:43:56 INFO - PROCESS | 8395 | RSS: Main: 186859520 12:43:56 INFO - PROCESS | 8395 | 12:43:59 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48231/tests/kraken/driver.html?testName=audio-dft) 12:43:59 INFO - PROCESS | 8395 | RSS: Main: 175583232 12:43:59 INFO - PROCESS | 8395 | 12:44:02 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48231/tests/kraken/driver.html?testName=audio-fft) 12:44:03 INFO - PROCESS | 8395 | RSS: Main: 266424320 12:44:03 INFO - PROCESS | 8395 | 12:44:05 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48231/tests/kraken/driver.html?testName=audio-oscillator) 12:44:06 INFO - PROCESS | 8395 | RSS: Main: 172953600 12:44:06 INFO - PROCESS | 8395 | 12:44:08 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48231/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:44:08 INFO - PROCESS | 8395 | RSS: Main: 174628864 12:44:08 INFO - PROCESS | 8395 | 12:44:11 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48231/tests/kraken/driver.html?testName=imaging-darkroom) 12:44:12 INFO - PROCESS | 8395 | RSS: Main: 211120128 12:44:12 INFO - PROCESS | 8395 | 12:44:15 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48231/tests/kraken/driver.html?testName=imaging-desaturate) 12:44:16 INFO - PROCESS | 8395 | RSS: Main: 210079744 12:44:16 INFO - PROCESS | 8395 | 12:44:18 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48231/tests/kraken/driver.html?testName=json-parse-financial) 12:44:19 INFO - PROCESS | 8395 | RSS: Main: 208736256 12:44:19 INFO - PROCESS | 8395 | 12:44:21 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48231/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:44:21 INFO - PROCESS | 8395 | RSS: Main: 170790912 12:44:21 INFO - PROCESS | 8395 | 12:44:23 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48231/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:44:23 INFO - PROCESS | 8395 | RSS: Main: 178880512 12:44:23 INFO - PROCESS | 8395 | 12:44:25 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48231/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:44:26 INFO - PROCESS | 8395 | RSS: Main: 184279040 12:44:26 INFO - PROCESS | 8395 | 12:44:29 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:44:29 INFO - PROCESS | 8395 | RSS: Main: 184696832 12:44:29 INFO - PROCESS | 8395 | 12:44:32 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:44:32 INFO - PROCESS | 8395 | RSS: Main: 182374400 12:44:32 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | Cycle 1(1): loaded http://localhost:48231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48231/tests/kraken/driver.html?testName=ai-astar) 12:44:34 INFO - PROCESS | 8395 | RSS: Main: 233779200 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | __start_tp_report 12:44:34 INFO - PROCESS | 8395 | _x_x_mozilla_page_load 12:44:34 INFO - PROCESS | 8395 | _x_x_mozilla_page_load_details 12:44:34 INFO - PROCESS | 8395 | |i|pagename|runs| 12:44:34 INFO - PROCESS | 8395 | |0;ai-astar;107;110;110;111;111;109;109;110;110;110 12:44:34 INFO - PROCESS | 8395 | |1;audio-beat-detection;146;118;123;158;119;118;121;115;148;118 12:44:34 INFO - PROCESS | 8395 | |2;audio-dft;162;161;161;161;162;161;162;161;168;161 12:44:34 INFO - PROCESS | 8395 | |3;audio-fft;75;75;76;110;77;76;76;76;98;76 12:44:34 INFO - PROCESS | 8395 | |4;audio-oscillator;81;81;113;82;89;81;111;80;82;113 12:44:34 INFO - PROCESS | 8395 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;116;116;117 12:44:34 INFO - PROCESS | 8395 | |6;imaging-darkroom;146;146;146;146;146;146;145;147;146;145 12:44:34 INFO - PROCESS | 8395 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 12:44:34 INFO - PROCESS | 8395 | |8;json-parse-financial;50;52;49;50;50;51;51;50;51;50 12:44:34 INFO - PROCESS | 8395 | |9;json-stringify-tinderbox;59;59;58;59;59;59;58;59;59;59 12:44:34 INFO - PROCESS | 8395 | |10;stanford-crypto-aes;74;74;74;76;74;73;74;74;73;74 12:44:34 INFO - PROCESS | 8395 | |11;stanford-crypto-ccm;126;121;119;119;118;118;140;116;166;117 12:44:34 INFO - PROCESS | 8395 | |12;stanford-crypto-pbkdf2;155;154;152;152;152;151;150;153;152;150 12:44:34 INFO - PROCESS | 8395 | |13;stanford-crypto-sha256-iterative;66;63;65;63;63;62;62;62;63;60 12:44:34 INFO - PROCESS | 8395 | __end_tp_report 12:44:34 INFO - PROCESS | 8395 | __start_cc_report 12:44:34 INFO - PROCESS | 8395 | _x_x_mozilla_cycle_collect,1599 12:44:34 INFO - PROCESS | 8395 | __end_cc_report 12:44:34 INFO - PROCESS | 8395 | __startTimestamp1475005474856__endTimestamp 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | ------- Summary: start ------- 12:44:34 INFO - PROCESS | 8395 | Number of tests: 14 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.16 (1.1%) stddev-sans-first:0.71 12:44:34 INFO - PROCESS | 8395 | Values: 107.0 110.0 110.0 111.0 111.0 109.0 109.0 110.0 110.0 110.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:122.00 stddev:15.80 (12.9%) stddev-sans-first:15.42 12:44:34 INFO - PROCESS | 8395 | Values: 146.0 118.0 123.0 158.0 119.0 118.0 121.0 115.0 148.0 118.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#2] audio-dft Cycles:10 Average:162.00 Median:161.50 stddev:2.16 (1.3%) stddev-sans-first:2.29 12:44:34 INFO - PROCESS | 8395 | Values: 162.0 161.0 161.0 161.0 162.0 161.0 162.0 161.0 168.0 161.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:12.20 (16.1%) stddev-sans-first:12.72 12:44:34 INFO - PROCESS | 8395 | Values: 75.0 75.0 76.0 110.0 77.0 76.0 76.0 76.0 98.0 76.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:81.00 stddev:14.74 (18.2%) stddev-sans-first:15.15 12:44:34 INFO - PROCESS | 8395 | Values: 81.0 81.0 113.0 82.0 89.0 81.0 111.0 80.0 82.0 113.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:44:34 INFO - PROCESS | 8395 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 12:44:34 INFO - PROCESS | 8395 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 145.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 12:44:34 INFO - PROCESS | 8395 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:50.50 stddev:0.84 (1.7%) stddev-sans-first:0.88 12:44:34 INFO - PROCESS | 8395 | Values: 50.0 52.0 49.0 50.0 50.0 51.0 51.0 50.0 51.0 50.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 12:44:34 INFO - PROCESS | 8395 | Values: 59.0 59.0 58.0 59.0 59.0 59.0 58.0 59.0 59.0 59.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 12:44:34 INFO - PROCESS | 8395 | Values: 74.0 74.0 74.0 76.0 74.0 73.0 74.0 74.0 73.0 74.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:120.00 stddev:15.73 (13.1%) stddev-sans-first:16.69 12:44:34 INFO - PROCESS | 8395 | Values: 126.0 121.0 119.0 119.0 118.0 118.0 140.0 116.0 166.0 117.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:152.00 stddev:1.60 (1.0%) stddev-sans-first:1.30 12:44:34 INFO - PROCESS | 8395 | Values: 155.0 154.0 152.0 152.0 152.0 151.0 150.0 153.0 152.0 150.0 12:44:34 INFO - PROCESS | 8395 | 12:44:34 INFO - PROCESS | 8395 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.66 (2.6%) stddev-sans-first:1.33 12:44:34 INFO - PROCESS | 8395 | Values: 66.0 63.0 65.0 63.0 63.0 62.0 62.0 62.0 63.0 60.0 12:44:34 INFO - PROCESS | 8395 | -------- Summary: end -------- 12:44:34 INFO - PROCESS | 8395 | 12:44:35 INFO - TEST-INFO | 8395: exit 0 12:44:35 INFO - TEST-OK | kraken | took 58990ms 12:44:35 INFO - SUITE-END | took 1172s 12:44:36 INFO - Completed test suite (00:19:32) 12:44:36 INFO - javascript benchmark 12:44:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3148.8897888573897, 3169.0809665197085, 3187.394395064936, 3207.7433805295577, 3227.4997375406806, 5655.349634792, 5689.8577535561635, 5698.971505142474, 5746.281714785652, 5759.856003599912, 5693.572982026344, 5772.855678608037, 5774.797882074128, 5780.450857168562, 5781.0, 5200.635955483108, 5206.3231779868565, 5217.139172036628, 5243.764030618631, 5278.894422111555, 4993.475685053071, 5289.20661900716, 5291.3385826771655, 5304.045271851065, 5328.17413300939, 4945.950540494603, 5147.7426128693605, 5186.118359878829, 5225.895482090375, 5239.947600523984, 5184.792608295664, 5207.869803254911, 5209.088409528336, 5244.763985620656, 5249.790008399659, 5128.871778205537, 5167.741612919376, 5235.136202526579, 5245.737713114329, 5273.762680679379, 5533.861653458655, 5548.306461692288, 5601.215829783833, 5615.241942337814, 5674.375818659944, 6021.909671354933, 6051.697415129226, 6056.031035034417, 6145.446909778097, 6162.630242185483, 6188.164597779287, 6189.87620247597, 6203.472704820096, 6203.751849925998, 6215.0, 5487.478689524489, 5530.087535556629, 5658.066419040894, 5716.971415142898, 5779.190913272145, 6256.562040657111, 6296.8425789354715, 6298.0552917062805, 6302.527310451735, 6302.936970630235, 6064.06007068905, 6067.332593414721, 6075.969620151871, 6078.422549857756, 6078.939210607926, 5758.654480731169, 5791.333996590446, 6065.2418447694035, 6127.142200091991, 6164.352742962014, 6161.291451483047, 6164.044573091178, 6172.629642221481, 6178.320384757673, 6180.103884936659, 6136.938630613726, 6157.199564056644, 6173.629582225081, 6192.845178870564, 6203.2556093269095, 4533.569310915458, 4597.4712908015335, 4646.3495110684535, 4724.95275047252, 4764.857054288377, 4142.212979533879, 4161.750294982311, 4164.583541645872, 4176.812043458051, 4199.601037901394, 5951.464368206882, 5964.493018093423, 5966.701664916737, 5967.761289548456, 6005.099235114768, 6023.548233882477, 6065.848353791191, 6245.843853903598, 6248.656323902229, 6262.091996660459, 5786.652800831964, 5806.44838740319, 5820.3888591698105, 5822.796202132905, 5862.14998825168, 5157.896842063138, 5161.2516185152945, 5191.532762051434, 5201.947980520222, 5207.635465517377, 6205.875882482234, 6369.363063693686, 6392.776252831129, 6424.903626445701, 6442.2591401989375, 6082.2701275847185, 6097.054956481752, 6133.1510485532735, 6137.744733333838, 6214.782482613267, 6424.2933277338525, 6434.871302573829, 6436.324185960407, 6441.066045423481, 6446.355364463516, 6067.423594758491, 6089.360617135314, 6097.725602347817, 6098.0852872069545, 6107.664078475549, 5924.644521328734, 6026.186464827192, 6088.665123418255, 6103.206583144163, 6132.846678832886, 6071.848203794941, 6077.149199112217, 6077.726502307319, 6087.878242435215, 6112.205413296243, 6038.003729384603, 6063.484603808725, 6076.635401875901, 6088.208532890696, 6090.786822461193, 5780.884382312246, 5805.535557155333, 5806.2451881255165, 5810.331811841692, 5814.767409303749, 5899.351071382231, 5929.673867937305, 5943.58394912352, 5946.137810017437, 5946.613470124601, 5638.802641907513, 5737.397573254748, 5790.449907258803, 5791.131330300489, 5797.768089276382], "value": 5637.2071098962, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.7218907113655, 619.1610367951425, 653.6927644007318, 654.6268626882679, 672.4351544702455, 34018.65981340186, 44915.10169796606, 46804.531954680446, 46873.29690054652, 46882.76558617202, 48901.266481002815, 49139.0, 49497.75251123739, 49502.00995980078, 49597.0, 8592.828143437127, 9355.76610584734, 9503.239740820718, 9509.762255943588, 9511.667091651794, 8570.957145214265, 11094.778104437906, 11330.773384532304, 11343.205975581712, 11825.586104486345, 11532.71168220797, 11557.65327040186, 11587.826182607268, 11601.593944211954, 11612.303261804276, 11335.773284534303, 11372.943135284353, 11379.203455758101, 11396.088312934946, 11417.42912854354, 11155.944220278929, 11183.273087249303, 11225.158113141466, 11251.0, 11260.324380537195, 45786.0, 46096.07807843858, 46100.07799843985, 46175.76912115418, 46194.307085393746, 3746.269477451871, 3987.023179321056, 4047.1703300823556, 4172.499300083979, 4583.335416364642, 34686.47970280448, 35296.470552941726, 35354.469682954776, 35434.46848297278, 37335.25329493395, 4787.377640906695, 4867.683600565952, 4870.634702397334, 4892.0, 4933.70397776131, 365394.0, 366287.9999999973, 366696.0, 367077.0, 367389.0, 64592.0, 64760.35239647637, 64850.0, 65030.0, 65042.0, 40197.59802401997, 41882.0, 42122.57877421186, 44293.33559996603, 44374.778126109806, 19658.508537286398, 19679.31122410709, 19699.507512312306, 19832.90083549573, 19840.404787856387, 13237.139585926883, 13686.0, 14656.926715366355, 15038.473653422077, 15125.0, 20457.2839950601, 21209.89395053046, 21226.575468490544, 21237.256696015564, 21276.893615531822, 7594.7469417125485, 7660.310572048543, 7711.113221979432, 7732.806679833049, 7808.960955195188, 988.9406635601887, 1075.3924032921532, 1078.013617539942, 1116.6538373104202, 1157.7163594919298, 34201.82899085488, 34657.72428316213, 34979.4753078704, 34985.0, 35055.29889402198, 1126.9436528173721, 1169.1465230381698, 1171.0, 1232.8226543650792, 1267.6513958661258, 18112.45662630123, 18166.27334906589, 18167.909160454114, 18224.0, 18225.0, 602757.0, 603735.0, 603813.0, 605159.0, 606404.0, 63011.369886301465, 63704.36295636984, 63787.36212637907, 63978.36021639817, 64003.679981600726, 1297.1568480487758, 1331.6803967048033, 1370.616227456314, 1400.5588239704462, 1424.8432672406234, 33609.327813444084, 35748.0, 35874.0, 36060.0, 36103.45844812277, 54734.0, 55301.170482441994, 55436.72281638566, 55491.0, 55568.72215639058, 431137.0, 433461.0, 434416.0, 434491.0, 517484.0, 44710.3293450592, 47889.5211047899, 48075.0, 48515.5148448511, 48965.26552101793, 52807.623656936295, 52890.0, 53008.73495632497, 53317.200241995626, 53414.465855340946, 43153.0, 43457.60983145957, 44273.33589996217, 47995.28007079827, 48265.0, 44433.33349999688, 45210.547894520634, 45587.316190257836, 45808.77095614634, 46613.533864660916, 44045.77977110222, 44279.55720442755, 45046.77476612596, 45495.545044550454, 45631.0, 38731.0, 40645.593544064184, 40753.1849363017, 40798.79600601978, 41678.58321416747, 30383.240418989702, 30531.0, 30561.388772224876, 30573.694263057085, 30656.846715766278], "value": 22303.75474271189, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.7235007844589, 413.80551140963735, 426.7823410060869, 431.37019950871723, 447.4742177940919, 15389.923050384747, 19486.1231244594, 21488.785112148893, 21515.892420537915, 21911.890440547813, 18571.0, 18689.90655046726, 18777.906110469463, 19277.614447711036, 20511.589768204627, 5791.189233507302, 5990.430909063653, 5995.910061349084, 5997.85005374867, 6000.18997435345, 5662.433756624346, 5927.644341339512, 5963.910541341883, 6061.66660833654, 6062.605930614496, 5920.674362910038, 6044.304904935944, 6050.757969681207, 6063.454289113979, 6065.150878876961, 6110.20567326247, 6289.276733175698, 6300.401461861139, 6305.842353941142, 6311.558190926637, 5942.405759424067, 6093.939060609426, 6111.724972376253, 6161.630302181883, 6162.67502486963, 15262.23688815566, 15292.158931258777, 15417.0, 15447.768283475756, 15632.765508517381, 2293.7820907013806, 2452.509498100369, 2549.8342607730438, 2552.8851201695784, 2736.261209473451, 15949.760753588705, 16451.91774041122, 16754.246058927376, 16861.747073793904, 17434.564135896577, 1988.9005549722601, 1991.6713742232514, 2123.1507397041305, 2246.0903334149693, 2307.180950762489, 96263.51868240684, 96597.0, 97180.51409742906, 98651.0, 99758.0, 14684.237891453095, 18950.336738214373, 19208.423747287605, 19300.420987370402, 19539.706904396444, 30705.539416908763, 34323.141921451665, 34448.48327275093, 34465.0, 34476.655233447345, 10865.619703310345, 11002.284851484788, 11078.390688512049, 11176.888231117584, 11232.0, 9424.0, 9441.15029647335, 9484.0515948406, 9497.667581634609, 9720.125188733047, 9170.67902623405, 9281.076460914925, 9459.19596834263, 9592.616295348247, 9656.806863862825, 3274.9672503274664, 3319.8008119512906, 3406.8316465686653, 3617.3127105849803, 3638.636136386393, 957.3250858144991, 968.7239136845965, 969.1132613658565, 1000.1099021870541, 1006.285537268533, 19555.924424156525, 20167.899160504396, 20479.488012799502, 20543.0, 20687.241584465188, 1021.3514418344405, 1021.5556233038652, 1039.0752230514847, 1052.6947185316174, 1066.5520481397832, 10439.269251152498, 11345.0, 11431.885681143249, 11506.827397589042, 11542.59600913964, 444401.0, 446935.0, 449721.0, 482354.0, 509001.0, 94280.52859735658, 94653.0, 96057.0, 97631.51184244176, 98129.50935245278, 1013.2603199664286, 1039.184240371305, 1057.8254587992894, 1064.4784055812752, 1080.0873262093519, 17451.912740436725, 17811.287548497916, 17846.553836153682, 18104.547386315448, 18278.177482013074, 33397.49903751397, 34915.82542087375, 39903.80048099741, 40184.799076004434, 43407.782961084995, 57970.0, 59002.40997589969, 59025.70487147537, 60317.0, 62575.6871215641, 8671.566421679017, 9204.401713888576, 9345.392549484262, 9586.0, 9633.421994680342, 7566.281203285679, 11127.332360058423, 12195.878041219474, 13372.665683357995, 13890.30548472552, 12071.818922716342, 12368.1960672556, 12428.192167509083, 12536.310502922426, 12568.0, 11444.484998175269, 11848.822267666164, 12278.140530162802, 12484.12611117213, 12549.184303020274, 6303.968480157753, 9676.9032309676, 11183.378410130648, 12296.569620063256, 12680.6829829255, 9259.259259259108, 9294.581743821409, 9322.300827437834, 9503.66737164196, 9582.856257156009, 11668.766624667629, 12325.445354958869, 12526.218184883566, 12625.0, 12757.93621031926], "value": 10342.102353565042, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1548.2723120133533, 1549.6435819761455, 1692.7884014498188, 1788.669096217199, 1819.590592116774, 9361.391509551875, 10064.24518161138, 10067.144292735107, 10068.69793906183, 10073.143782778472, 8215.301699355561, 8449.493030418163, 9327.533623318841, 9581.137697607213, 9823.65617203398, 2593.7924966002674, 2611.0469678567374, 2626.579747240442, 2627.238100950722, 2629.447815958651, 2549.961750573743, 2644.2067379786085, 2644.920652380422, 2647.2058382485275, 2648.1525911708263, 2602.3233959170657, 2617.5419301622237, 2640.221134765239, 2646.140004498536, 2647.3116989582654, 2569.0494517028724, 2574.652421923035, 2621.7247189045065, 2621.89512419503, 2627.8948842046293, 2492.7756501914732, 2530.6204069389737, 2543.9364015899564, 2545.389106614418, 2565.3714839864165, 9848.0, 9912.0, 9922.156616687591, 9938.9503052485, 9943.801123977551, 5827.475527202572, 5996.100584912255, 6004.0, 6006.039033754622, 6017.187679663233, 3616.150204701893, 3634.0914771307175, 3660.816959152058, 3665.6700896919137, 3669.541307336583, 1186.1993154620682, 1246.7070238493948, 1251.1179618369029, 1270.8538518070447, 1283.8844503994685, 13867.930660346734, 13917.164970101827, 13918.164910105426, 13928.37322320498, 13956.93021534896, 5014.122528557488, 5128.948710512847, 5206.843794686166, 5273.866118784403, 5294.729264976378, 11470.025047870857, 11511.136664750009, 11526.711832204262, 11623.360715160747, 11624.709382265512, 5768.3654797972185, 5773.509251713652, 5775.104858746901, 5776.729119593682, 5779.768809247583, 4526.841560545365, 4615.16926953145, 5294.285271488377, 5373.35519737634, 5416.458354164631, 4389.6927215095275, 4398.846040388571, 4448.977755111204, 4467.285234362486, 4502.077074199781, 1368.6304697731557, 1415.1509094543192, 1421.9360128794228, 1428.7713965765427, 1429.5854202281223, 1016.4917541229386, 1026.4457193115634, 1032.7108409645311, 1037.5071840875523, 1042.8435734639866, 6281.560290779602, 6525.086487891699, 6612.07430959666, 6630.867382652416, 6780.627065511346, 484.91513985053183, 487.11831584831566, 492.0454318621862, 502.5175831202014, 503.6826799116606, 4410.42664453619, 4423.51341352451, 4455.0, 4496.5503449655425, 4617.8383756568355, 11923.880761192451, 12229.938850305869, 12322.075844311534, 12326.938365308117, 12347.0, 11973.700657483458, 12190.2076365036, 12198.085143614264, 12198.634040978784, 12390.070744694183, 9069.818603627758, 9120.543972801333, 9203.723888283363, 9215.585298661576, 9220.170184683411, 6373.8725225496155, 6432.067350234283, 6466.838329041811, 6522.934770652422, 6542.771003014872, 10923.344599324066, 11253.268537545033, 11325.15061370417, 11328.886711132784, 11336.94331528337, 11260.83108753353, 11326.773464530828, 11422.31466112036, 11552.191346605658, 11579.594714184963, 8406.243438090602, 8501.064882862756, 8634.309255259439, 8705.303575714055, 8752.91247087521, 9351.766205844908, 9375.671851485165, 9421.905780942378, 9467.621295148392, 9467.905320946702, 8252.21603947624, 8272.958635206785, 8330.416870818985, 8353.0, 8373.958130209554, 7837.13791482925, 7877.251661092187, 7881.172476890073, 8031.678732850621, 8103.83792324162, 7514.023176986957, 7532.39740820744, 7639.121501027453, 7758.224177582197, 7874.3306818918745, 5203.687778733288, 5212.530872221519, 5214.113600687968, 5334.51989320963, 5558.194061860927, 5345.812896548602, 5368.32895888014, 5385.838424847261, 5441.129419293053, 5559.805406810742], "value": 5003.618475777956, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.05013287330416, 350.51803769816513, 356.43149177062594, 367.979761113139, 371.94048952167657, 5570.86072848179, 5578.470045345691, 5591.245181900442, 5591.944080559193, 5626.324841019084, 5526.447355264471, 5528.032594296003, 5548.9722551387285, 5549.278593782813, 5554.222408862763, 3813.656770890619, 4139.917201655965, 4298.355246713002, 4354.976580503595, 4362.541933097027, 4364.236258654739, 4369.213541562517, 4370.453693288339, 4377.0, 4380.299152135643, 4364.629006534448, 4364.759938203398, 4365.759883206439, 4366.8253269869165, 4371.235033869076, 4105.5894410559, 4155.854545090938, 4299.0, 4357.607815296638, 4380.364847097169, 3885.7862817545024, 3892.610738926113, 3893.299206142893, 3894.6884249259992, 3899.908025752794, 5349.411564727877, 5352.223927530486, 5355.357357117132, 5363.302770639831, 5363.980843639735, 4838.250071238928, 4980.452150263468, 5006.249062640633, 5008.373953255843, 5023.79904803811, 5771.653700777967, 5771.884562308773, 5772.134179873053, 5789.855253618651, 5793.73928173229, 4278.679099067551, 4290.785460726951, 4298.548652391516, 4310.0, 4313.784310784479, 5652.660840349551, 5806.361300256968, 5853.824385268449, 5942.712055858482, 5996.880062398727, 4308.590683885026, 4405.867823965286, 4408.669349798778, 4414.977925110354, 4427.826625944127, 4460.754658493814, 4501.344206917935, 4501.774911254424, 4506.3916371290115, 4508.233600287959, 4880.0, 4987.900241995212, 5037.69773813565, 5051.292819005343, 5059.544640982329, 5852.098068127875, 5856.326522449887, 5859.44335288147, 5890.440408161217, 5899.734511946973, 1548.4889986304493, 1563.8045244344457, 1565.3425561264296, 1566.4517418903292, 1569.7566877134063, 965.7054598347431, 994.7416518104603, 995.8705368302075, 1017.7760892603616, 1026.1226651213105, 5088.872778180501, 5104.41299250591, 5105.668131571436, 5110.897782044338, 5119.59043276537, 5296.364436267672, 5320.940459235955, 5324.361076670824, 5343.519083282523, 5348.438413966477, 4857.271409288635, 4991.126552853236, 5064.518870707277, 5104.489551044866, 5106.259592359087, 2810.943781124366, 2832.5751137329567, 2833.0, 2839.872205750746, 2847.9145625631263, 5405.432424596823, 5416.3750874737425, 5417.916416716594, 5434.945650543523, 5436.836894893159, 4947.911459478909, 5342.385625653022, 5348.331458567679, 5413.242146099549, 5427.294451721251, 5475.7262136893, 5492.752826122834, 5494.0, 5494.560435165177, 5520.91718624221, 4944.0, 5308.859089909876, 5313.548348390275, 5314.468553144655, 5335.439778823167, 5152.948470515397, 5205.609579281493, 5217.399999000164, 5231.869203269949, 5233.136532472252, 5895.764169433174, 6064.302605200459, 6095.969520152371, 6213.1922850029205, 6228.657423841551, 4459.665525085697, 4460.910781784281, 4463.776811159494, 4472.485664148665, 4473.821047158077, 5780.306363236438, 5947.137665038632, 6011.633485248275, 6026.578139530191, 6045.455908968214, 5909.261342332208, 5921.733521991435, 5925.703714814156, 5928.525717942468, 5932.406759324033, 5885.175595565388, 5917.437843404869, 5940.702964851654, 5942.257217847769, 5963.2844058713235, 5720.685362305113, 5868.354481007001, 5927.614705044159, 5929.377415371497, 5934.7922822701, 5866.919867069651, 5916.940830591639, 5958.76164953397, 5962.314333851663, 5967.880642387215, 5631.774729010794, 5772.729999400125, 5772.913406298993, 5784.132380143013, 5789.623674461147], "value": 4352.188021299157, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.5374282915909, 860.5697151424284, 884.5311984648137, 900.1988230474878, 913.3971578758013, 16981.660366792672, 17755.822441775577, 18043.0, 18115.0, 18125.456236312915, 16210.270537825796, 16241.83758162421, 16370.345186192568, 16380.426685066024, 16382.918085409556, 718.3821913154683, 740.3484933258725, 839.5214727605268, 866.536403024382, 889.4929889962724, 876.7983363826323, 883.8718385834051, 883.9381243312938, 884.1732979664034, 885.0706757904208, 945.2154711589365, 945.8202941441104, 946.2713710442955, 946.9289803264749, 946.9384490008161, 756.9394448444111, 774.7365895595497, 776.3711393771007, 778.941579381543, 939.5959737312953, 643.7489379142138, 660.2407231683554, 662.19543254945, 663.9170103737033, 665.2615596687673, 16150.030998140031, 16184.433544825992, 16206.918965405097, 16207.270672819752, 16218.0, 15169.08985460876, 15477.380904763908, 15487.225638718019, 15630.14034228117, 15940.20298985046, 13178.34108294591, 13373.933130334286, 13468.0, 13486.797698034537, 13493.730125397535, 4688.413948256468, 4739.73931433771, 4769.809207631691, 4927.334809800703, 4951.62862785289, 90702.0, 91285.0, 92736.0, 94688.52655736677, 95818.0, 11842.822357664641, 12446.875531244752, 12511.562095326803, 12570.497180112692, 12774.744505109846, 22774.316770496913, 22844.4288892779, 22943.655845162335, 23056.4235894104, 23116.768832311798, 8370.874436883452, 8515.914840851636, 8717.564121793885, 8944.195022448012, 9081.182693557612, 4889.926651100236, 5009.924851127236, 5089.898202035939, 5099.260607211933, 5151.922721159186, 3717.219383929351, 3839.212961342918, 3854.4218367244575, 3859.421086836941, 3859.942100868433, 741.8738814401564, 743.4907088644296, 753.1075675324757, 773.4353921637236, 783.3772151139857, 736.6095969136367, 796.5618909599697, 796.6654005317664, 813.8616435206029, 820.6266148902355, 10206.336588121749, 10289.845652315222, 10596.682099537025, 10655.680329590125, 10711.303765255234, 656.3846294946682, 697.6328185558441, 818.1368656067787, 822.5106061893164, 823.8480238044516, 5069.1635880079375, 5200.7919683213, 5268.130758424817, 5380.623356365017, 5399.892002159935, 81844.0, 82075.0, 82121.58939205266, 115159.0, 133971.0, 69806.0, 114222.0, 115885.42057289659, 116558.0, 118870.4056479712, 94671.0, 94943.0, 95475.0, 95848.0, 96046.0, 9988.0, 10092.236052655157, 10225.693229203136, 10373.896261037293, 10403.271770975958, 58536.4146358531, 58803.70598146982, 59033.70483147557, 59403.702981484814, 59594.40405596062, 83279.0, 84228.15771842204, 84622.30755384981, 84805.0, 86672.0, 12674.493020279086, 13217.206967581977, 13319.467221311426, 13579.864201358256, 13590.864091359355, 13016.15394999322, 13137.802932956205, 13223.801642975171, 13260.138091024053, 13540.0, 14375.568732938029, 14999.7000059996, 15021.77467337969, 15247.695046098794, 15327.46353877609, 13233.3383330835, 13475.865241347461, 13985.300734963415, 14416.342120656258, 14773.778393323893, 12374.938125309676, 13112.606621801362, 13453.865461345653, 13812.240326782123, 14008.719825603635, 10195.235357348376, 10495.580176793148, 10720.785584288427, 10813.080888124283, 10839.241253112521, 10545.156387489136, 10583.341586610068, 10697.197710171613, 10764.784704306026, 10881.238313317992], "value": 8091.45540313303, "unit": "score"}], "name": "dromaeo_css", "value": 7822.624579232341, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 110.0, 111.0, 111.0, 109.0, 109.0, 110.0, 110.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 123.0, 158.0, 119.0, 118.0, 121.0, 115.0, 148.0, 118.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 168.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 110.0, 77.0, 76.0, 76.0, 76.0, 98.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 113.0, 82.0, 89.0, 81.0, 111.0, 80.0, 82.0, 113.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 49.0, 50.0, 50.0, 51.0, 51.0, 50.0, 51.0, 50.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 76.0, 74.0, 73.0, 74.0, 74.0, 73.0, 74.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 121.0, 119.0, 119.0, 118.0, 118.0, 140.0, 116.0, 166.0, 117.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 152.0, 152.0, 152.0, 151.0, 150.0, 153.0, 152.0, 150.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 65.0, 63.0, 63.0, 62.0, 62.0, 62.0, 63.0, 60.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1454.6, "alertThreshold": 2.0}]} 12:44:36 INFO - Return code: 0 12:44:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:44:36 INFO - # TBPL SUCCESS # 12:44:36 INFO - Running post-action listener: _resource_record_post_action 12:44:36 INFO - [mozharness: 2016-09-27 19:44:36.150797Z] Finished run-tests step (success) 12:44:36 INFO - Running post-run listener: _resource_record_post_run 12:44:36 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 358199296; Read time: 8; Write time: 214512 12:44:36 INFO - TinderboxPrint: CPU usage
13.0% 12:44:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:44:36 INFO - TinderboxPrint: I/O write bytes / time
358,199,296 / 214,512 12:44:36 INFO - TinderboxPrint: CPU idle
8,256.5 (87.0%) 12:44:36 INFO - TinderboxPrint: CPU user
1,189.9 (12.5%) 12:44:36 INFO - TinderboxPrint: Swap in / out
0 / 0 12:44:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118693888; Read time: 0; Write time: 70060 12:44:36 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 238952448; Read time: 0; Write time: 144444 12:44:36 INFO - Running post-run listener: _upload_blobber_files 12:44:36 INFO - Blob upload gear active. 12:44:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:44:36 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 12:44:36 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:44:36 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:44:37 INFO - (blobuploader) - INFO - Open directory for files ... 12:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:44:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:44:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:44:38 INFO - (blobuploader) - INFO - Done attempting. 12:44:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:44:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:44:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:44:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:44:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:44:42 INFO - (blobuploader) - INFO - Done attempting. 12:44:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:44:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:44:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:44:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:44:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:44:43 INFO - (blobuploader) - INFO - Done attempting. 12:44:43 INFO - (blobuploader) - INFO - Iteration through files over. 12:44:43 INFO - Return code: 0 12:44:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:44:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:44:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54a6fe9da3b7018481cad5dea50a4df500f894ed626c5f64c086da8fa8dc1552dffdb919fd656a1f07561b139de116cfa3f06848df456e82f780f7079496ca1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76248715de493db89b260c047bb0c2ee3d09cf7b533fa23e931cecf986a0050a70aa332306a810817e2187ecf687d0a2d77a734eaeb6d6e1eda93aea4e4baaa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59a251dd455fbbbac65a64539f936aa4958e846a92a1c99177936a0b2ee7c28dcea9d932cce4f8bd4251306f9854643dabfa884927a48bc7c6246ffa5db2c83f"} 12:44:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:44:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:44:43 INFO - Contents: 12:44:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54a6fe9da3b7018481cad5dea50a4df500f894ed626c5f64c086da8fa8dc1552dffdb919fd656a1f07561b139de116cfa3f06848df456e82f780f7079496ca1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76248715de493db89b260c047bb0c2ee3d09cf7b533fa23e931cecf986a0050a70aa332306a810817e2187ecf687d0a2d77a734eaeb6d6e1eda93aea4e4baaa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59a251dd455fbbbac65a64539f936aa4958e846a92a1c99177936a0b2ee7c28dcea9d932cce4f8bd4251306f9854643dabfa884927a48bc7c6246ffa5db2c83f"} 12:44:43 INFO - Running post-run listener: copy_logs_to_upload_dir 12:44:43 INFO - Copying logs to upload dir... 12:44:43 INFO - mkdir: /builds/slave/test/build/upload/logs 12:44:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.466641 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-09-27 12:44:42.733208) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 12:44:42.737071) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740 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-Aurora/sha512/54a6fe9da3b7018481cad5dea50a4df500f894ed626c5f64c086da8fa8dc1552dffdb919fd656a1f07561b139de116cfa3f06848df456e82f780f7079496ca1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76248715de493db89b260c047bb0c2ee3d09cf7b533fa23e931cecf986a0050a70aa332306a810817e2187ecf687d0a2d77a734eaeb6d6e1eda93aea4e4baaa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59a251dd455fbbbac65a64539f936aa4958e846a92a1c99177936a0b2ee7c28dcea9d932cce4f8bd4251306f9854643dabfa884927a48bc7c6246ffa5db2c83f"} build_url:https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/aYWkMtGXRrS5HU_t5g_L_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54a6fe9da3b7018481cad5dea50a4df500f894ed626c5f64c086da8fa8dc1552dffdb919fd656a1f07561b139de116cfa3f06848df456e82f780f7079496ca1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76248715de493db89b260c047bb0c2ee3d09cf7b533fa23e931cecf986a0050a70aa332306a810817e2187ecf687d0a2d77a734eaeb6d6e1eda93aea4e4baaa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59a251dd455fbbbac65a64539f936aa4958e846a92a1c99177936a0b2ee7c28dcea9d932cce4f8bd4251306f9854643dabfa884927a48bc7c6246ffa5db2c83f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 12:44:42.763105) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:44:42.763446) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1474995570.985227-742166740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:44:42.851779) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 12:44:42.852654) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 12:44:42.853392) ========= ========= Total master_lag: 0.18 =========