builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1479999932.9 results: success (0) buildid: 20161124041737 builduid: 5e883a82886d4865bdc657b9b9bfa8de revision: 482eefb7b7a75d450af08c4537ff17515fd8871c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 07:05:32.903903) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 07:05:32.904366) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 07:05:32.904651) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 07:05:32.919223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:05:32.919564) ========= 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=745a4373a2a16df560f216e000000264-1479999932.723567-984304933 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-24 07:05:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.3K=0.2s 2016-11-24 07:05:33 (58.3 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.327034 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:05:33.260356) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:05:33.260733) ========= 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=745a4373a2a16df560f216e000000264-1479999932.723567-984304933 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018993 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:05:33.312790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 07:05:33.313250) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 482eefb7b7a75d450af08c4537ff17515fd8871c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 482eefb7b7a75d450af08c4537ff17515fd8871c --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=745a4373a2a16df560f216e000000264-1479999932.723567-984304933 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-24 07:05:33,837 truncating revision to first 12 chars 2016-11-24 07:05:33,837 Setting DEBUG logging. 2016-11-24 07:05:33,837 attempt 1/10 2016-11-24 07:05:33,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/482eefb7b7a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 07:05:35,099 unpacking tar archive at: mozilla-beta-482eefb7b7a7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.619537 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 07:05:34.946686) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 07:05:34.947020) ========= script_repo_revision: 482eefb7b7a75d450af08c4537ff17515fd8871c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 07:05:34.947499) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 07:05:34.947894) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 07:05:34.958768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-11-24 07:05:34.959188) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1479999932.723567-984304933 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:05:35 INFO - MultiFileLogger online at 20161124 07:05:35 in /builds/slave/test 07:05:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:05:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:05:35 INFO - {'append_to_log': False, 07:05:35 INFO - 'base_work_dir': '/builds/slave/test', 07:05:35 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:05:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:05:35 INFO - 'branch': 'Mozilla-Beta', 07:05:35 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:35 INFO - 'config_files': ('talos/linux_config.py',), 07:05:35 INFO - 'default_actions': ('clobber', 07:05:35 INFO - 'read-buildbot-config', 07:05:35 INFO - 'download-and-extract', 07:05:35 INFO - 'populate-webroot', 07:05:35 INFO - 'create-virtualenv', 07:05:35 INFO - 'install', 07:05:35 INFO - 'run-tests'), 07:05:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:35 INFO - 'download_minidump_stackwalk': True, 07:05:35 INFO - 'download_symbols': 'ondemand', 07:05:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:35 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:35 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:35 INFO - 'installer_path': 'installer.exe', 07:05:35 INFO - 'log_level': 'info', 07:05:35 INFO - 'log_name': 'talos', 07:05:35 INFO - 'log_to_console': True, 07:05:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:05:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:05:35 INFO - 'opt_config_files': (), 07:05:35 INFO - 'pip_index': False, 07:05:35 INFO - 'sps_profile': False, 07:05:35 INFO - 'sps_profile_interval': 0, 07:05:35 INFO - 'suite': 'dromaeojs', 07:05:35 INFO - 'system_bits': '32', 07:05:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:35 INFO - 'title': 'talos-linux64-ix-032', 07:05:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:35 INFO - 'use_talos_json': True, 07:05:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:05:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:35 INFO - 'work_dir': 'build'} 07:05:35 INFO - [mozharness: 2016-11-24 15:05:35.572279Z] Running clobber step. 07:05:35 INFO - Running pre-action listener: _resource_record_pre_action 07:05:35 INFO - Running main action method: clobber 07:05:35 INFO - rmtree: /builds/slave/test/build 07:05:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:05:36 INFO - Running post-action listener: _resource_record_post_action 07:05:36 INFO - [mozharness: 2016-11-24 15:05:36.046996Z] Finished clobber step (success) 07:05:36 INFO - [mozharness: 2016-11-24 15:05:36.047097Z] Running read-buildbot-config step. 07:05:36 INFO - Running pre-action listener: _resource_record_pre_action 07:05:36 INFO - Running main action method: read_buildbot_config 07:05:36 INFO - Using buildbot properties: 07:05:36 INFO - { 07:05:36 INFO - "project": "", 07:05:36 INFO - "product": "firefox", 07:05:36 INFO - "script_repo_revision": "production", 07:05:36 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 07:05:36 INFO - "repository": "", 07:05:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 07:05:36 INFO - "buildid": "20161124041737", 07:05:36 INFO - "pgo_build": "True", 07:05:36 INFO - "basedir": "/builds/slave/test", 07:05:36 INFO - "buildnumber": 30, 07:05:36 INFO - "slavename": "talos-linux64-ix-032", 07:05:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:05:36 INFO - "platform": "ubuntu64_hw", 07:05:36 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 07:05:36 INFO - "branch": "mozilla-beta", 07:05:36 INFO - "repo_path": "releases/mozilla-beta", 07:05:36 INFO - "revision": "482eefb7b7a75d450af08c4537ff17515fd8871c", 07:05:36 INFO - "stage_platform": "linux64-pgo", 07:05:36 INFO - "builduid": "5e883a82886d4865bdc657b9b9bfa8de", 07:05:36 INFO - "slavebuilddir": "test" 07:05:36 INFO - } 07:05:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 07:05:36 INFO - Running post-action listener: _resource_record_post_action 07:05:36 INFO - [mozharness: 2016-11-24 15:05:36.049594Z] Finished read-buildbot-config step (success) 07:05:36 INFO - [mozharness: 2016-11-24 15:05:36.049685Z] Running download-and-extract step. 07:05:36 INFO - Running pre-action listener: _resource_record_pre_action 07:05:36 INFO - Running main action method: download_and_extract 07:05:36 INFO - mkdir: /builds/slave/test/build/tests 07:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:36 INFO - trying https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 07:05:36 INFO - Downloading https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 07:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:05:36 INFO - Downloaded 1327 bytes. 07:05:36 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 07:05:36 INFO - Using the following test package requirements: 07:05:36 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 07:05:36 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 07:05:36 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 07:05:36 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 07:05:36 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 07:05:36 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 07:05:36 INFO - u'jsshell-linux-x86_64.zip'], 07:05:36 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 07:05:36 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 07:05:36 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 07:05:36 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 07:05:36 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 07:05:36 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 07:05:36 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 07:05:36 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 07:05:36 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 07:05:36 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 07:05:36 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 07:05:36 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:05:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 07:05:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:05:36 INFO - Fetch https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 07:05:37 INFO - Expected file size: 21963370 07:05:41 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:05:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 07:05:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:05:41 INFO - Fetch https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 07:05:41 INFO - Expected file size: 21963370 07:05:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 07:05:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:05:46 INFO - Fetch https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 07:05:47 INFO - Expected file size: 14414089 07:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:47 INFO - trying https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 07:05:47 INFO - Downloading https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 07:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:05:48 INFO - Downloaded 56961121 bytes. 07:05:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 07:05:48 INFO - mkdir: /builds/slave/test/properties 07:05:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:05:48 INFO - Writing to file /builds/slave/test/properties/build_url 07:05:48 INFO - Contents: 07:05:48 INFO - build_url:https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 07:05:49 INFO - Running post-action listener: _resource_record_post_action 07:05:49 INFO - Running post-action listener: set_extra_try_arguments 07:05:49 INFO - [mozharness: 2016-11-24 15:05:49.312288Z] Finished download-and-extract step (success) 07:05:49 INFO - [mozharness: 2016-11-24 15:05:49.312517Z] Running populate-webroot step. 07:05:49 INFO - Running pre-action listener: _resource_record_pre_action 07:05:49 INFO - Running main action method: populate_webroot 07:05:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:05:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:05:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:05:49 INFO - '--tppagecycles', 07:05:49 INFO - '7'], 07:05:49 INFO - 'tests': ['tsvgm']}}, 07:05:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:05:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:05:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:05:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:05:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:05:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:05:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:49 INFO - 'talos_options': ['--disable-e10s'], 07:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:49 INFO - 'talos_options': ['--disable-e10s'], 07:05:49 INFO - 'tests': ['damp', 'tps']}, 07:05:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:49 INFO - 'tests': ['damp', 'tps']}, 07:05:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:05:49 INFO - 'tests': ['dromaeo_dom']}, 07:05:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:05:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:05:49 INFO - 'tests': ['basic_compositor_video']}, 07:05:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:05:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:05:49 INFO - 'tests': ['a11yr', 07:05:49 INFO - 'ts_paint', 07:05:49 INFO - 'tpaint', 07:05:49 INFO - 'sessionrestore', 07:05:49 INFO - 'sessionrestore_no_auto_restore', 07:05:49 INFO - 'tabpaint']}, 07:05:49 INFO - 'other-e10s': {'tests': ['a11yr', 07:05:49 INFO - 'ts_paint', 07:05:49 INFO - 'tpaint', 07:05:49 INFO - 'sessionrestore', 07:05:49 INFO - 'sessionrestore_no_auto_restore', 07:05:49 INFO - 'tabpaint']}, 07:05:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:05:49 INFO - 'ts_paint', 07:05:49 INFO - 'tpaint', 07:05:49 INFO - 'sessionrestore', 07:05:49 INFO - 'sessionrestore_no_auto_restore', 07:05:49 INFO - 'tabpaint']}, 07:05:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:05:49 INFO - 'ts_paint', 07:05:49 INFO - 'tpaint', 07:05:49 INFO - 'sessionrestore', 07:05:49 INFO - 'sessionrestore_no_auto_restore', 07:05:49 INFO - 'tabpaint']}, 07:05:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:05:49 INFO - 'tests': ['a11yr', 07:05:49 INFO - 'ts_paint', 07:05:49 INFO - 'tpaint', 07:05:49 INFO - 'sessionrestore', 07:05:49 INFO - 'sessionrestore_no_auto_restore', 07:05:49 INFO - 'tabpaint']}, 07:05:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:05:49 INFO - 'tests': ['a11yr', 07:05:49 INFO - 'ts_paint', 07:05:49 INFO - 'tpaint', 07:05:49 INFO - 'sessionrestore', 07:05:49 INFO - 'sessionrestore_no_auto_restore', 07:05:49 INFO - 'tabpaint']}, 07:05:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:05:49 INFO - 'tests': ['tsvgx', 07:05:49 INFO - 'tsvgr_opacity', 07:05:49 INFO - 'tart', 07:05:49 INFO - 'tscrollx', 07:05:49 INFO - 'cart']}, 07:05:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:05:49 INFO - 'tsvgr_opacity', 07:05:49 INFO - 'tart', 07:05:49 INFO - 'tscrollx', 07:05:49 INFO - 'cart']}, 07:05:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:49 INFO - 'talos_options': ['--disable-e10s'], 07:05:49 INFO - 'tests': ['tp5o']}, 07:05:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:49 INFO - 'tests': ['tp5o']}, 07:05:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:49 INFO - 'talos_options': ['--disable-e10s', 07:05:49 INFO - '--xperf_path', 07:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:49 INFO - 'tests': ['tp5n']}, 07:05:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:49 INFO - 'talos_options': ['--xperf_path', 07:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:49 INFO - 'tests': ['tp5n']}}, 07:05:49 INFO - 'talos.zip': {'path': '', 07:05:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:05:49 INFO - Running post-action listener: _resource_record_post_action 07:05:49 INFO - [mozharness: 2016-11-24 15:05:49.331594Z] Finished populate-webroot step (success) 07:05:49 INFO - [mozharness: 2016-11-24 15:05:49.331688Z] Running create-virtualenv step. 07:05:49 INFO - Running pre-action listener: _resource_record_pre_action 07:05:49 INFO - Running main action method: create_virtualenv 07:05:49 INFO - Creating virtualenv /builds/slave/test/build/venv 07:05:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:05:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:05:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:05:49 INFO - Using real prefix '/usr' 07:05:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:05:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:05:51 INFO - Installing pip.................done. 07:05:51 INFO - Return code: 0 07:05:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:51 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 0x7ff1bdd41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbff60>, '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 0x1bc0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc11d0>, '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': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:05:51 INFO - Using env: {'DISPLAY': ':0', 07:05:51 INFO - 'HOME': '/home/cltbld', 07:05:51 INFO - 'LANG': 'en_US.UTF-8', 07:05:51 INFO - 'LANGUAGE': 'en_US:en', 07:05:51 INFO - 'LOGNAME': 'cltbld', 07:05:51 INFO - 'MAIL': '/var/mail/cltbld', 07:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:51 INFO - 'MOZ_NO_REMOTE': '1', 07:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:51 INFO - 'NO_EM_RESTART': '1', 07:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:51 INFO - 'PWD': '/builds/slave/test', 07:05:51 INFO - 'SHELL': '/bin/bash', 07:05:51 INFO - 'SHLVL': '1', 07:05:51 INFO - 'TERM': 'linux', 07:05:51 INFO - 'TMOUT': '86400', 07:05:51 INFO - 'USER': 'cltbld', 07:05:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 07:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:51 INFO - '_': '/tools/buildbot/bin/python'} 07:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:05:52 INFO - Cleaning up... 07:05:52 INFO - Return code: 0 07:05:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff1bdd41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbff60>, '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 0x1bc0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc11d0>, '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': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:05:52 INFO - Using env: {'DISPLAY': ':0', 07:05:52 INFO - 'HOME': '/home/cltbld', 07:05:52 INFO - 'LANG': 'en_US.UTF-8', 07:05:52 INFO - 'LANGUAGE': 'en_US:en', 07:05:52 INFO - 'LOGNAME': 'cltbld', 07:05:52 INFO - 'MAIL': '/var/mail/cltbld', 07:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:52 INFO - 'MOZ_NO_REMOTE': '1', 07:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:52 INFO - 'NO_EM_RESTART': '1', 07:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:52 INFO - 'PWD': '/builds/slave/test', 07:05:52 INFO - 'SHELL': '/bin/bash', 07:05:52 INFO - 'SHLVL': '1', 07:05:52 INFO - 'TERM': 'linux', 07:05:52 INFO - 'TMOUT': '86400', 07:05:52 INFO - 'USER': 'cltbld', 07:05:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 07:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:52 INFO - '_': '/tools/buildbot/bin/python'} 07:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:52 INFO - Downloading/unpacking psutil>=3.1.1 07:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:05:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:54 INFO - Installing collected packages: psutil 07:05:54 INFO - Running setup.py install for psutil 07:05:54 INFO - building 'psutil._psutil_linux' extension 07:05:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:05:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:05:54 INFO - building 'psutil._psutil_posix' extension 07:05:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:05:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:05:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:54 INFO - Successfully installed psutil 07:05:54 INFO - Cleaning up... 07:05:54 INFO - Return code: 0 07:05:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:54 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 0x7ff1bdd41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbff60>, '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 0x1bc0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc11d0>, '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': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:05:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:05:54 INFO - Using env: {'DISPLAY': ':0', 07:05:54 INFO - 'HOME': '/home/cltbld', 07:05:54 INFO - 'LANG': 'en_US.UTF-8', 07:05:54 INFO - 'LANGUAGE': 'en_US:en', 07:05:54 INFO - 'LOGNAME': 'cltbld', 07:05:54 INFO - 'MAIL': '/var/mail/cltbld', 07:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:54 INFO - 'MOZ_NO_REMOTE': '1', 07:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:54 INFO - 'NO_EM_RESTART': '1', 07:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:54 INFO - 'PWD': '/builds/slave/test', 07:05:54 INFO - 'SHELL': '/bin/bash', 07:05:54 INFO - 'SHLVL': '1', 07:05:54 INFO - 'TERM': 'linux', 07:05:54 INFO - 'TMOUT': '86400', 07:05:54 INFO - 'USER': 'cltbld', 07:05:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 07:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:54 INFO - '_': '/tools/buildbot/bin/python'} 07:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:05:57 INFO - Installing collected packages: mozsystemmonitor 07:05:57 INFO - Running setup.py install for mozsystemmonitor 07:05:57 INFO - Successfully installed mozsystemmonitor 07:05:57 INFO - Cleaning up... 07:05:57 INFO - Return code: 0 07:05:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff1bdd41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbff60>, '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 0x1bc0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc11d0>, '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': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:05:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:05:57 INFO - Using env: {'DISPLAY': ':0', 07:05:57 INFO - 'HOME': '/home/cltbld', 07:05:57 INFO - 'LANG': 'en_US.UTF-8', 07:05:57 INFO - 'LANGUAGE': 'en_US:en', 07:05:57 INFO - 'LOGNAME': 'cltbld', 07:05:57 INFO - 'MAIL': '/var/mail/cltbld', 07:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:57 INFO - 'MOZ_NO_REMOTE': '1', 07:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:57 INFO - 'NO_EM_RESTART': '1', 07:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:57 INFO - 'PWD': '/builds/slave/test', 07:05:57 INFO - 'SHELL': '/bin/bash', 07:05:57 INFO - 'SHLVL': '1', 07:05:57 INFO - 'TERM': 'linux', 07:05:57 INFO - 'TMOUT': '86400', 07:05:57 INFO - 'USER': 'cltbld', 07:05:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 07:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:57 INFO - '_': '/tools/buildbot/bin/python'} 07:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:57 INFO - Downloading/unpacking jsonschema==2.5.1 07:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:05:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:59 INFO - Downloading functools32-3.2.3-2.tar.gz 07:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:05:59 INFO - warning: no files found matching '*.txt' 07:05:59 INFO - no previously-included directories found matching 'build' 07:05:59 INFO - no previously-included directories found matching 'dist' 07:05:59 INFO - no previously-included directories found matching '.git*' 07:05:59 INFO - Installing collected packages: jsonschema, functools32 07:05:59 INFO - Running setup.py install for functools32 07:05:59 INFO - warning: no files found matching '*.txt' 07:05:59 INFO - no previously-included directories found matching 'build' 07:05:59 INFO - no previously-included directories found matching 'dist' 07:05:59 INFO - no previously-included directories found matching '.git*' 07:05:59 INFO - Successfully installed jsonschema functools32 07:05:59 INFO - Cleaning up... 07:05:59 INFO - Return code: 0 07:05:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:59 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 0x7ff1bdd41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbff60>, '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 0x1bc0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc11d0>, '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': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:05:59 INFO - Using env: {'DISPLAY': ':0', 07:05:59 INFO - 'HOME': '/home/cltbld', 07:05:59 INFO - 'LANG': 'en_US.UTF-8', 07:05:59 INFO - 'LANGUAGE': 'en_US:en', 07:05:59 INFO - 'LOGNAME': 'cltbld', 07:05:59 INFO - 'MAIL': '/var/mail/cltbld', 07:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:59 INFO - 'MOZ_NO_REMOTE': '1', 07:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:59 INFO - 'NO_EM_RESTART': '1', 07:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:59 INFO - 'PWD': '/builds/slave/test', 07:05:59 INFO - 'SHELL': '/bin/bash', 07:05:59 INFO - 'SHLVL': '1', 07:05:59 INFO - 'TERM': 'linux', 07:05:59 INFO - 'TMOUT': '86400', 07:05:59 INFO - 'USER': 'cltbld', 07:05:59 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 07:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:59 INFO - '_': '/tools/buildbot/bin/python'} 07:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:06:00 INFO - Cleaning up... 07:06:00 INFO - Return code: 0 07:06:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:00 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 0x7ff1bdd41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbff60>, '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 0x1bc0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc11d0>, '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': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:06:00 INFO - Using env: {'DISPLAY': ':0', 07:06:00 INFO - 'HOME': '/home/cltbld', 07:06:00 INFO - 'LANG': 'en_US.UTF-8', 07:06:00 INFO - 'LANGUAGE': 'en_US:en', 07:06:00 INFO - 'LOGNAME': 'cltbld', 07:06:00 INFO - 'MAIL': '/var/mail/cltbld', 07:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:00 INFO - 'MOZ_NO_REMOTE': '1', 07:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:00 INFO - 'NO_EM_RESTART': '1', 07:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:00 INFO - 'PWD': '/builds/slave/test', 07:06:00 INFO - 'SHELL': '/bin/bash', 07:06:00 INFO - 'SHLVL': '1', 07:06:00 INFO - 'TERM': 'linux', 07:06:00 INFO - 'TMOUT': '86400', 07:06:00 INFO - 'USER': 'cltbld', 07:06:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 07:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:00 INFO - '_': '/tools/buildbot/bin/python'} 07:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:02 INFO - Downloading docopt-0.6.1.tar.gz 07:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:03 INFO - Running setup.py install for blobuploader 07:06:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:03 INFO - Running setup.py install for requests 07:06:03 INFO - Running setup.py install for docopt 07:06:03 INFO - Successfully installed blobuploader requests docopt 07:06:03 INFO - Cleaning up... 07:06:03 INFO - Return code: 0 07:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:03 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 0x7ff1bdd41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbff60>, '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 0x1bc0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc11d0>, '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': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:03 INFO - Using env: {'DISPLAY': ':0', 07:06:03 INFO - 'HOME': '/home/cltbld', 07:06:03 INFO - 'LANG': 'en_US.UTF-8', 07:06:03 INFO - 'LANGUAGE': 'en_US:en', 07:06:03 INFO - 'LOGNAME': 'cltbld', 07:06:03 INFO - 'MAIL': '/var/mail/cltbld', 07:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:03 INFO - 'MOZ_NO_REMOTE': '1', 07:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:03 INFO - 'NO_EM_RESTART': '1', 07:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:03 INFO - 'PWD': '/builds/slave/test', 07:06:03 INFO - 'SHELL': '/bin/bash', 07:06:03 INFO - 'SHLVL': '1', 07:06:03 INFO - 'TERM': 'linux', 07:06:03 INFO - 'TMOUT': '86400', 07:06:03 INFO - 'USER': 'cltbld', 07:06:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 07:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:03 INFO - '_': '/tools/buildbot/bin/python'} 07:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:03 INFO - Running setup.py (path:/tmp/pip-nFCLtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:03 INFO - Running setup.py (path:/tmp/pip-GHN6Vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:03 INFO - Running setup.py (path:/tmp/pip-mP0wlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:04 INFO - Running setup.py (path:/tmp/pip-YaGuUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:04 INFO - Running setup.py (path:/tmp/pip-veb0Hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:04 INFO - Running setup.py (path:/tmp/pip-r2QpsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:04 INFO - Running setup.py (path:/tmp/pip-fVOkHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:04 INFO - Running setup.py (path:/tmp/pip-CFzhnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:04 INFO - Running setup.py (path:/tmp/pip-2W3qIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:04 INFO - Running setup.py (path:/tmp/pip-qSbX4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:04 INFO - Running setup.py (path:/tmp/pip-eaLzHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:04 INFO - Running setup.py (path:/tmp/pip-fEbw1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:04 INFO - Running setup.py (path:/tmp/pip-P3QoAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:04 INFO - Running setup.py (path:/tmp/pip-R9AqQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:04 INFO - Running setup.py (path:/tmp/pip-Eh5w7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:04 INFO - Running setup.py (path:/tmp/pip-bZperl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:05 INFO - Running setup.py (path:/tmp/pip-HCIFcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:05 INFO - Running setup.py install for manifestparser 07:06:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:05 INFO - Running setup.py install for mozcrash 07:06:05 INFO - Running setup.py install for mozdebug 07:06:05 INFO - Running setup.py install for mozdevice 07:06:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:06:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:05 INFO - Running setup.py install for mozfile 07:06:05 INFO - Running setup.py install for mozhttpd 07:06:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:05 INFO - Running setup.py install for mozinfo 07:06:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:05 INFO - Running setup.py install for mozInstall 07:06:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:05 INFO - Running setup.py install for mozleak 07:06:05 INFO - Running setup.py install for mozlog 07:06:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:06 INFO - Running setup.py install for moznetwork 07:06:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:06 INFO - Running setup.py install for mozprocess 07:06:06 INFO - Running setup.py install for mozprofile 07:06:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:06 INFO - Running setup.py install for mozrunner 07:06:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:06 INFO - Running setup.py install for mozscreenshot 07:06:06 INFO - Running setup.py install for moztest 07:06:06 INFO - Running setup.py install for mozversion 07:06:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:07 INFO - Cleaning up... 07:06:07 INFO - Return code: 0 07:06:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:07 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 0x7ff1bdd41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbff60>, '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 0x1bc0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc11d0>, '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': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:07 INFO - Using env: {'DISPLAY': ':0', 07:06:07 INFO - 'HOME': '/home/cltbld', 07:06:07 INFO - 'LANG': 'en_US.UTF-8', 07:06:07 INFO - 'LANGUAGE': 'en_US:en', 07:06:07 INFO - 'LOGNAME': 'cltbld', 07:06:07 INFO - 'MAIL': '/var/mail/cltbld', 07:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:07 INFO - 'MOZ_NO_REMOTE': '1', 07:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:07 INFO - 'NO_EM_RESTART': '1', 07:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:07 INFO - 'PWD': '/builds/slave/test', 07:06:07 INFO - 'SHELL': '/bin/bash', 07:06:07 INFO - 'SHLVL': '1', 07:06:07 INFO - 'TERM': 'linux', 07:06:07 INFO - 'TMOUT': '86400', 07:06:07 INFO - 'USER': 'cltbld', 07:06:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 07:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:07 INFO - '_': '/tools/buildbot/bin/python'} 07:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:07 INFO - Running setup.py (path:/tmp/pip-rophoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:07 INFO - Running setup.py (path:/tmp/pip-iwplhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:07 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)) 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:07 INFO - Running setup.py (path:/tmp/pip-lS1DL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:07 INFO - Running setup.py (path:/tmp/pip-wOZFso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:07 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)) 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:07 INFO - Running setup.py (path:/tmp/pip-wqWqhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:07 INFO - Running setup.py (path:/tmp/pip-IdAuSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:07 INFO - Running setup.py (path:/tmp/pip-n7dDwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:07 INFO - Running setup.py (path:/tmp/pip-DoatmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:07 INFO - Running setup.py (path:/tmp/pip-GOqFw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:07 INFO - Running setup.py (path:/tmp/pip-D2_iYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:07 INFO - Running setup.py (path:/tmp/pip-xgaZNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:08 INFO - Running setup.py (path:/tmp/pip-fNnatv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:08 INFO - Running setup.py (path:/tmp/pip-AO8Uje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:08 INFO - Running setup.py (path:/tmp/pip-GjVDGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:08 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)) 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:08 INFO - Running setup.py (path:/tmp/pip-CLt9KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:08 INFO - Running setup.py (path:/tmp/pip-ZkiV0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:08 INFO - Running setup.py (path:/tmp/pip-eGe_Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:06:08 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)) 07:06:08 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)) 07:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:08 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)) 07:06:08 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)) 07:06:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:10 INFO - Downloading blessings-1.6.tar.gz 07:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:10 INFO - Installing collected packages: blessings 07:06:10 INFO - Running setup.py install for blessings 07:06:10 INFO - Successfully installed blessings 07:06:10 INFO - Cleaning up... 07:06:10 INFO - Return code: 0 07:06:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:10 INFO - Reading from file tmpfile_stdout 07:06:10 INFO - Current package versions: 07:06:10 INFO - argparse == 1.2.1 07:06:10 INFO - blessings == 1.6 07:06:10 INFO - blobuploader == 1.2.4 07:06:10 INFO - docopt == 0.6.1 07:06:10 INFO - functools32 == 3.2.3-2 07:06:10 INFO - jsonschema == 2.5.1 07:06:10 INFO - manifestparser == 1.1 07:06:10 INFO - mozInstall == 1.12 07:06:10 INFO - mozcrash == 0.17 07:06:10 INFO - mozdebug == 0.1 07:06:10 INFO - mozdevice == 0.48 07:06:10 INFO - mozfile == 1.2 07:06:10 INFO - mozhttpd == 0.7 07:06:10 INFO - mozinfo == 0.9 07:06:10 INFO - mozleak == 0.1 07:06:10 INFO - mozlog == 3.4 07:06:10 INFO - moznetwork == 0.27 07:06:10 INFO - mozprocess == 0.23 07:06:10 INFO - mozprofile == 0.28 07:06:10 INFO - mozrunner == 6.12 07:06:10 INFO - mozscreenshot == 0.1 07:06:10 INFO - mozsystemmonitor == 0.3 07:06:10 INFO - moztest == 0.7 07:06:10 INFO - mozversion == 1.4 07:06:10 INFO - psutil == 3.1.1 07:06:10 INFO - requests == 1.2.3 07:06:10 INFO - wsgiref == 0.1.2 07:06:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:10 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 0x7ff1bdd41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbff60>, '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 0x1bc0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc11d0>, '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': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:10 INFO - Using env: {'DISPLAY': ':0', 07:06:10 INFO - 'HOME': '/home/cltbld', 07:06:10 INFO - 'LANG': 'en_US.UTF-8', 07:06:10 INFO - 'LANGUAGE': 'en_US:en', 07:06:10 INFO - 'LOGNAME': 'cltbld', 07:06:10 INFO - 'MAIL': '/var/mail/cltbld', 07:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:10 INFO - 'MOZ_NO_REMOTE': '1', 07:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:10 INFO - 'NO_EM_RESTART': '1', 07:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:10 INFO - 'PWD': '/builds/slave/test', 07:06:10 INFO - 'SHELL': '/bin/bash', 07:06:10 INFO - 'SHLVL': '1', 07:06:10 INFO - 'TERM': 'linux', 07:06:10 INFO - 'TMOUT': '86400', 07:06:10 INFO - 'USER': 'cltbld', 07:06:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 07:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:10 INFO - '_': '/tools/buildbot/bin/python'} 07:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:06:11 INFO - Cleaning up... 07:06:11 INFO - Return code: 0 07:06:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:11 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 0x7ff1bdd41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbff60>, '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 0x1bc0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc11d0>, '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': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:06:11 INFO - Using env: {'DISPLAY': ':0', 07:06:11 INFO - 'HOME': '/home/cltbld', 07:06:11 INFO - 'LANG': 'en_US.UTF-8', 07:06:11 INFO - 'LANGUAGE': 'en_US:en', 07:06:11 INFO - 'LOGNAME': 'cltbld', 07:06:11 INFO - 'MAIL': '/var/mail/cltbld', 07:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:11 INFO - 'MOZ_NO_REMOTE': '1', 07:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:11 INFO - 'NO_EM_RESTART': '1', 07:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:11 INFO - 'PWD': '/builds/slave/test', 07:06:11 INFO - 'SHELL': '/bin/bash', 07:06:11 INFO - 'SHLVL': '1', 07:06:11 INFO - 'TERM': 'linux', 07:06:11 INFO - 'TMOUT': '86400', 07:06:11 INFO - 'USER': 'cltbld', 07:06:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 07:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:11 INFO - '_': '/tools/buildbot/bin/python'} 07:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:11 INFO - Cleaning up... 07:06:11 INFO - Return code: 0 07:06:11 INFO - Running post-action listener: _resource_record_post_action 07:06:11 INFO - Running post-action listener: _start_resource_monitoring 07:06:11 INFO - Starting resource monitoring. 07:06:11 INFO - [mozharness: 2016-11-24 15:06:11.333434Z] Finished create-virtualenv step (success) 07:06:11 INFO - [mozharness: 2016-11-24 15:06:11.333937Z] Running install step. 07:06:11 INFO - Running pre-action listener: _resource_record_pre_action 07:06:11 INFO - Running main action method: install 07:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:11 INFO - Reading from file tmpfile_stdout 07:06:11 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:11 INFO - Reading from file tmpfile_stdout 07:06:11 INFO - Output received: 07:06:11 INFO - Usage: mozinstall [options] installer 07:06:11 INFO - Options: 07:06:11 INFO - -h, --help show this help message and exit 07:06:11 INFO - -d DEST, --destination=DEST 07:06:11 INFO - Directory to install application into. [default: 07:06:11 INFO - "/builds/slave/test"] 07:06:11 INFO - --app=APP Application being installed. [default: firefox] 07:06:11 INFO - mkdir: /builds/slave/test/build/application 07:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:06:25 INFO - Reading from file tmpfile_stdout 07:06:25 INFO - Output received: 07:06:25 INFO - /builds/slave/test/build/application/firefox/firefox 07:06:25 INFO - Running post-action listener: _resource_record_post_action 07:06:25 INFO - [mozharness: 2016-11-24 15:06:25.121587Z] Finished install step (success) 07:06:25 INFO - [mozharness: 2016-11-24 15:06:25.121835Z] Running run-tests step. 07:06:25 INFO - Running pre-action listener: _resource_record_pre_action 07:06:25 INFO - Running main action method: run_tests 07:06:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:06:25 INFO - Python 2.7.3 07:06:25 INFO - Return code: 0 07:06:25 INFO - grabbing minidump binary from tooltool 07:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:25 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 0x1bbff60>, '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 0x1bc0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc11d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:06:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:06:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:06:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:06:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:06:25 INFO - Return code: 0 07:06:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:06:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:06:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:06:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:06:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:06:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:06:25 INFO - Using env: {'DISPLAY': ':0', 07:06:25 INFO - 'HOME': '/home/cltbld', 07:06:25 INFO - 'LANG': 'en_US.UTF-8', 07:06:25 INFO - 'LANGUAGE': 'en_US:en', 07:06:25 INFO - 'LOGNAME': 'cltbld', 07:06:25 INFO - 'MAIL': '/var/mail/cltbld', 07:06:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:06:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:25 INFO - 'MOZ_NO_REMOTE': '1', 07:06:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:25 INFO - 'NO_EM_RESTART': '1', 07:06:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:25 INFO - 'PWD': '/builds/slave/test', 07:06:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:06:25 INFO - 'SHELL': '/bin/bash', 07:06:25 INFO - 'SHLVL': '1', 07:06:25 INFO - 'TERM': 'linux', 07:06:25 INFO - 'TMOUT': '86400', 07:06:25 INFO - 'USER': 'cltbld', 07:06:25 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479999932.723567-984304933', 07:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:25 INFO - '_': '/tools/buildbot/bin/python'} 07:06:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:06:25 INFO - mozversion application_buildid: 20161124041737 07:06:25 INFO - mozversion application_changeset: 482eefb7b7a75d450af08c4537ff17515fd8871c 07:06:25 INFO - mozversion application_display_name: Firefox 07:06:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:06:25 INFO - mozversion application_name: Firefox 07:06:25 INFO - mozversion application_remotingname: firefox 07:06:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:06:25 INFO - mozversion application_vendor: Mozilla 07:06:25 INFO - mozversion application_version: 51.0 07:06:25 INFO - mozversion platform_buildid: 20161124041737 07:06:25 INFO - mozversion platform_changeset: 482eefb7b7a75d450af08c4537ff17515fd8871c 07:06:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:06:25 INFO - mozversion platform_version: 51.0 07:06:25 INFO - using testdate: 1479999985 07:06:25 INFO - actual date: 1479999985 07:06:25 INFO - starting webserver on 'localhost:42132' 07:06:25 INFO - SUITE-START | Running 2 tests 07:06:25 INFO - TEST-START | dromaeo_css 07:06:25 INFO - operating with platform_type : linux_ 07:06:25 INFO - Initialising browser for dromaeo_css test... 07:06:25 INFO - TEST-INFO | started process 28870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2UanJI/profile http://localhost:42132/getInfo.html) 07:06:29 INFO - PROCESS | 28870 | __metrics Screen width/height:1600/1200 07:06:29 INFO - PROCESS | 28870 | colorDepth:24 07:06:29 INFO - PROCESS | 28870 | Browser inner width/height: 1024/697 07:06:29 INFO - PROCESS | 28870 | __metrics 07:06:30 INFO - PROCESS | 28870 | 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" 07:06:30 INFO - PROCESS | 28870 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:06:30 INFO - PROCESS | 28870 | console.error: PushService: 07:06:30 INFO - PROCESS | 28870 | stateChangeProcessEnqueue: Error transitioning state 07:06:30 INFO - PROCESS | 28870 | UnknownError 07:06:31 INFO - TEST-INFO | 28870: exit 0 07:06:31 INFO - Browser initialized. 07:06:31 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:31 INFO - TEST-INFO | started process 28958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2UanJI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:42 INFO - PROCESS | 28958 | RSS: Main: 142893056 07:06:42 INFO - PROCESS | 28958 | 07:07:34 INFO - PROCESS | 28958 | 1480000053999 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:09:43 INFO - PROCESS | 28958 | Cycle 1(1): loaded http://localhost:42132/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42132/tests/dromaeo/cssquery-ext.html) 07:09:44 INFO - PROCESS | 28958 | RSS: Main: 236158976 07:09:44 INFO - PROCESS | 28958 | 07:12:46 INFO - PROCESS | 28958 | Cycle 1(1): loaded http://localhost:42132/tests/dromaeo/cssquery-ext.html (next: http://localhost:42132/tests/dromaeo/cssquery-jquery.html) 07:12:47 INFO - PROCESS | 28958 | RSS: Main: 236417024 07:12:47 INFO - PROCESS | 28958 | 07:15:48 INFO - PROCESS | 28958 | Cycle 1(1): loaded http://localhost:42132/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42132/tests/dromaeo/cssquery-mootools.html) 07:15:49 INFO - PROCESS | 28958 | RSS: Main: 200798208 07:15:49 INFO - PROCESS | 28958 | 07:18:51 INFO - PROCESS | 28958 | Cycle 1(1): loaded http://localhost:42132/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42132/tests/dromaeo/cssquery-prototype.html) 07:18:51 INFO - PROCESS | 28958 | RSS: Main: 216281088 07:18:51 INFO - PROCESS | 28958 | 07:21:54 INFO - PROCESS | 28958 | Cycle 1(1): loaded http://localhost:42132/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42132/tests/dromaeo/cssquery-yui.html) 07:21:55 INFO - PROCESS | 28958 | RSS: Main: 174284800 07:21:55 INFO - PROCESS | 28958 | 07:24:57 INFO - PROCESS | 28958 | Cycle 1(1): loaded http://localhost:42132/tests/dromaeo/cssquery-yui.html (next: http://localhost:42132/tests/dromaeo/cssquery-dojo.html) 07:24:57 INFO - PROCESS | 28958 | RSS: Main: 259006464 07:24:57 INFO - PROCESS | 28958 | 07:24:57 INFO - PROCESS | 28958 | __start_tp_report 07:24:57 INFO - PROCESS | 28958 | _x_x_mozilla_page_load 07:24:57 INFO - PROCESS | 28958 | _x_x_mozilla_page_load_details 07:24:57 INFO - PROCESS | 28958 | |i|pagename|runs| 07:24:57 INFO - PROCESS | 28958 | |0;dojo.html;3121.9843900780497;3167.952480712788;3182.061291918885;3196.0411876437065;3211.50221715634;5488.368837583679;5546.861328466785;5583;5594.888102237953;5612.270404847369;5648.887022259552;5717;5728.484436400723;5729.427057294279;5733.770649174028;5164.2253661950635;5168.638195326319;5190.039842629126;5204.739763011853;5239.083160446926;5073.670211436263;5225.346831646044;5259.079661059319;5259.421463638997;5288.048151332759;5039.21892106724;5051.621128415365;5070.2394640803805;5093.083245015896;5126.2054381570915;5074.137396642561;5106;5106.953074619712;5143.202803565453;5175.327207463043;4999.775010124553;5062.215356619693;5121.6670916390685;5133.358330208724;5140.177571588528;5398.595105367113;5440.972795136038;5524.447555244444;5559.416261292547;5575.163725441175;6092.116643086728;6105.45050945417;6107.786227482017;6116.296625888035;6116.663583502906;6109.114178444101;6147.047207682816;6156.230471191101;6161.199044124235;6162.907556386658;5486.31421072366;5547.389787123413;5585.273914391103;5611.158326251095;5644.040513112781;6195.19462469885;6195.721192546346;6202.038684003986;6202.596831205957;6204.286507051656;5948.67282299469;5954.46409823118;5969.552283578749;5986.398630882018;6000.429959153874;5777.3933736957015;5810.331811841608;5906.527477801766;5923.763049477972;6030.095485677183;6022.126791615191;6023.728932198062;6029.336772954972;6031.09533569968;6050.21347224858;6023.69881505923;6024.939750602525;6025;6031.366706495843;6056.818295451144;4542.931856022163;4546.408966834357;4589.495155532889;4620.53794620542;4628.421447319085;4114.958850411457;4129.359949207877;4136.710430269913;4159.043420013414;4168.228877657643;5791.218185544982;5792.797252096157;5794.304683438015;5802.274715660543;5823.5341172706085;5938.970305148447;6004.579679422486;6064.06007068905;6114.755409783559;6117.265928088658;5623.718814059281;5625.09998400254;5657.971710141505;5713.800016999468;5744.655320680772;5196.92204616931;5197.792088316501;5199.298094757235;5199.66202196856;5205.947940520622;6114.449699527064;6148.661823599656;6197.318294987548;6205.472534834499;6206.286277078104;5998.490128338965;6001.609895356788;6050.062240352752;6051.304100028553;6140.754369825157;6265;6276.435120839146;6312.242530896322;6312.368763123651;6322.114903913548;5985.221921150222;5987.550933679904;6000.8499787503915;6001.849953751192;6014.0377539593455;5874.853128671817;5891.05743081105;5892.175095486549;5905.084711869667;5909;5841.036229022334;5842.503387212135;5844.444777746107;5849.181114643869;5882.5293976480925;5838.678872661874;5840.532757379315;5840.912386314294;5841.737121829613;5842.036064049385;5600.383957764561;5711.5716321276905;5803.071508558611;5812.331581868139;5840.795572155124;5973.611715238496;5973.611715238496;5982.49148822355;5984.58107932458;5990.550708696778;5829.504492118217;5829.562782791223;5834.124881267844;5836.299644042572;5843.824685259449 07:24:57 INFO - PROCESS | 28958 | |1;ext.html;590.3211306996953;634.5780056262586;648.2739331948219;651.2217899609968;656.0716586030766;35097.12257193572;38177.42733858994;46279.76860115703;47087.29369059458;47266.291005634856;48132;48379.27431088537;48515;48541;48647.27029094558;9277.396969197014;9444.527773611326;9462.858057129148;9466.19537339327;9468.857967130498;8543.102974187714;8730.51982140982;10995;11253.887461125407;11259.774804503904;11497.655070347902;11599.884001159964;11607.767844643102;11609.419529023557;11614.070874330033;11265.831012534818;11335;11349.432528373549;11353.659390218307;11362.48868800906;11142.331460112338;11172.329660220414;11194.216404851582;11207.551697932073;11209.215354925158;44689.329660055126;45074.09851802946;45080.3237951431;45093.09813803706;45099.32351014738;3667.688246499051;3767.523943606133;3791.469194312798;3798.4302354646748;3990.4213888985932;34276;34620.65379346199;34963.30073398543;35836.462453062966;36388;4493.326001099828;4500.257457519506;4506.752128632924;4547.067851090552;4627.930581041287;258079;259422;259740;261000;262039;39299.214015719524;63930.36069639337;64097.35902641007;64123.358766412675;64378;40200.195996079914;42493.787531062764;42592.57407425948;42613;42628.3605745914;16958;16991.660166796595;17102.743458848126;17111.91444042797;17130.48608541746;10890.61882834097;11278.830817537744;14135.43458261658;14205.218712970885;14259.358328875225;9384.108509691569;9694.22446204302;9700.466474343979;9771.267154963263;9853.950730246303;3642.0488385944223;3653.762505437191;3669.1744357519347;3692.4276737105793;3766.3032339016822;1040.6461802986869;1068.8557044799009;1084.295208114716;1119.753654196092;1155.5493357590547;32824.83587582094;32899.67100328966;32906.17734556607;32918.835405822814;33578.83210583931;1151.3609946479617;1191.9642410727517;1198.688341031338;1246.644706258712;1283.5892514395491;17619.735703964452;17816.198271077832;17845.107744612716;17847.058059163806;17902.194401251974;605617;614171;614445;614655;615200;62980.68509657423;63507;63571.36428635655;63589.682051590375;63607.36392636014;1231.8398608180878;1337.4249072898747;1432.0667099415705;1457.5190187238186;1478.9038712483868;34757;35883.64116358803;36016;37774.43338349872;38277.61722382852;57261;58020;63198.36801631925;63288.68355658192;63309.68345158429;511938;520108;520125;520526;521255;39589.17460079397;47090.76454617705;48034.27948580844;48886.5111348882;49847.50152498574;51652.74173629108;52067;52798.47201527935;52988;53136.468635313155;40392.79803600963;40547;40863.7956810214;41954.79022604867;45996;41551.79224103981;44928.32607510825;45169.77415112904;46253.537464624926;46951;44548.331775024046;45137;45468.772656136505;45960.770196148806;45974.54025459703;39278.2144357117;41046.79476602598;41292.1741565173;41321.79339103285;42004.3699344504;29919.55120673148;30291.848540757153;30629.693703062683;30729;31083.378332432774 07:24:57 INFO - PROCESS | 28958 | |2;jquery.html;430.52857121452;431.1370268052649;432.51774271687066;432.62793997162436;446.9664775141865;18585.442436726902;20124.295649652264;20321.1871525139;20602.072906719197;20831.27090551831;19683.803161968375;20063;20235.291764788235;20352.796472035276;20383.49041273965;5816.854578635547;6090.147379366892;6096.4513193812545;6096.634201947875;6101.450869421751;5805.303363596353;5970;5980.132880732292;5985.670788106652;5993.28080630325;5918.733656985446;5949.464548190662;5952.255968003999;5953.3748956359605;5954.970225148868;5708;5873.295204575457;5899.852503687399;5900.3509613942215;5905.763769449217;5165.586753059746;5326.307580014573;5326.866828329284;5328.333958255218;5331.173668081415;23567.88216058926;23776.762232377627;23818.64272035921;23992.28023159308;24028.15901443441;2678.8794504247358;2689.247010836969;2805.733455321741;2929.355541780826;2932.4868148074215;14192.92903535486;14982.62543436412;15354.692906141927;15421.15183664898;15645.608859778482;1916.9808301916942;2013.7885522020124;2026.8986550672407;2033.6237796007786;2078.8025137612053;84366.15633843644;84652.15347846504;84707;85989.57005214997;86765.56617216874;9795.559199836025;10259.384436933808;10426.68719938403;10782.245242832927;11129.777404451866;14287.285635718172;14336.713265734626;14384.568462946128;14486.203258820655;14684.486042988658;8069.354451643854;8070.717524886601;8157.347412207009;8216.34269258458;8288.751337459886;7997.840043199103;8039;8052.516848989079;8213.219744124299;8234.958825205955;4429.092036132585;4454.153710794939;4484.910301793946;4529.728216307032;4611.492735799059;2024.382563318202;2062.5668609592153;2081.3651836189806;2092.8953552322323;2111.144986280559;981.5533932060895;1025.1183981775666;1057.7672911959357;1062.721504159676;1093.0818112785298;18862.905685471484;19615;19717.704234436496;20164.727623172956;20215.39353819388;1016.5425558498557;1017.7760892603616;1048.7220886465093;1068.647346375694;1070.4540684251087;10755.83866242007;11357.318560886208;11416.828747568794;11512.654620361403;11564.42177891102;396674;541906;558151;558731;559884;61707;69226.65386673034;98536.50731746295;105113.47443262735;106523;1055.2876808154465;1056.3292309383596;1074.3446497636435;1082.2748758331936;1093.5297821936804;18349;18663.533411664816;18892.905535472233;18939.242430302635;19277.518062048;43799.34300985424;44291.33562996493;44539.554604453544;45077.32384014177;46116.30825537687;63104;63699;63710;63923.68038159779;64765.67617161884;9218.539073046186;9327.720168394959;9411.764705882408;9459.432434053979;9552.570134343832;10386.948065259625;12474.939630131541;13289.269090200132;13772.03595748288;14431.42274309016;12002.279863208236;12398.752024959631;12424.316662583644;12556.937215313865;12611.30637814929;12057.81913271284;12196.573119941115;12212.69468263265;12310;12339.876601233873;12081.275123492618;12194.87805121973;12330.260184388966;12458.127931044739;12895.16181448203;9024.593893274687;9058.275337973078;9223.953880230556;9231.538423078684;9236.26109911219;11939.164258501822;12039.217450865666;12128.151029428209;12200.81698774537;12292.754144917231 07:24:57 INFO - PROCESS | 28958 | |3;mootools.html;1184.23025033728;1520.0575643101279;1523.1470376589111;1689.7972243330803;1844.8155184481554;7465.962670186648;8479.32165426766;8795.78010549735;8812.471251724894;9018.594163262653;8790.6923257686;8858.291336693064;8861.291096712264;8867.423617464876;8904.154105359996;2526.5452218600644;2554.4380236347974;2555.884985175662;2557.296743395572;2557.718650948394;2436.1473484280536;2474.183519438581;2488.7635674610883;2500.7999360051244;2501.862397568133;2410.385351735305;2419.346776370379;2469.937926691522;2469.938251543717;2470.110760126353;2407.9518409631796;2424.46661734419;2432.768886955745;2446.7308596054418;2478.776910078084;2390.2829151254555;2411.8191135664897;2420.5884999550117;2424.1030818597055;2424.515096980611;8735;8878.511681857495;9021.819563608757;9085.863712044325;9106.86339704905;5508.256385387961;5657.434256574351;5661;5663.093904975184;5664.405237450091;3536.5932917714536;3559.697425718817;3595.280943811222;3604.891853244407;3613.7470377073614;1145.9885401146048;1155.5435602936793;1161.3380373187288;1162.2503485251966;1174.74155685749;12707;12736.108472406935;12748.745025099446;12785.55250566235;12817.615471535775;4786.760661966888;4829.323894654681;4858.416989961227;4896.853094407174;5016.241067412909;10073.69778906634;10114.089731924016;10191.694249172537;10194.133498652549;10200.693979180489;5544.085225937756;5545.528630066409;5547.306586676666;5549.972250138723;5550.139728342114;4492.146492166478;4625.722456652612;5126.66676666023;5202.817901373433;5244.082285600005;3974.0859602291634;4059.3707975263883;4084.4281800547947;4123.690723195772;4179.080602267496;1322.4776213395846;1346.104840281202;1347.7035052288481;1358.2529608715167;1367.2548461088732;876.2464280718577;1002.3634991780126;1003.7942221844504;1009.5204777730519;1010.6765834932897;6140.539459540552;6163.209626079929;6253.843653908689;6375.936240637627;6696.1629796275465;481.24684868181185;485.6867320578278;1026.6047571684956;1084.6745976207105;1116.5875167912598;4240.6676328020085;4322.459692538433;4343.153085148366;4406.9559304407185;4429.49060857999;10970.616028439126;11597.942010290064;11720.70698232551;11742.823857641972;11743.295402275891;11463.656090317303;11523.942380288045;11614.477348519336;11617.88382116185;11633.53465861373;8365.1216622255;8517.23344898962;8545.188207120189;8564.871526927102;8566.357523185787;6087.939120608914;6159.72281247336;6162.168107305636;6240.625562466266;6260.217472815898;9670;9984.301098923006;10040.64857729976;10167.084962353423;10384.896151038392;10244.743881402726;10264.230182736474;10318.690439286833;10337.534810933375;10372.58509659605;7614.733484328243;7690.423218258765;7771.106322772727;7900.2889739923685;7950.920490795018;9008.369414140947;9080.409773364974;9085.22775564058;9098.909010909807;9099.863502047343;7226.277372262942;7401.777946661608;7662.8084297893;7773.261540153676;7934.722284720007;7411.592362419903;7433.776986690408;7470.2903224193615;7564.735234266775;7794.922050779646;7127.82180445493;7319.048523691886;7319.597422141834;7319.8536029280185;7325.4505912057875;5142.6914385137015;5349.117395629678;5390.164524498709;5398.163284690879;5557.777688892561;5073.239014147907;5118.41138269089;5126.948730512647;5183.144781111075;5355.571554275571 07:24:57 INFO - PROCESS | 28958 | |4;prototype.html;339.52805600215703;339.8699324745222;351.79244245894927;355.78475022611303;358.2476798722683;5530.557555395569;5530.917036244459;5558.444155584444;5563.972180139103;5565.833025009256;5212.556932660719;5272.947270527294;5302.575793936486;5381.757820898059;5512.91730624041;4241;4260.467441569804;4262.552431994643;4265.530791612936;4268.701190916637;4276.465441819772;4285.250081235787;4291.8497852575165;4301.311790113583;4307.461567304087;4112.958870411302;4216.936745948813;4260.659147268211;4268.97865510672;4279.764612946286;4234;4241.406203131564;4261.041265715205;4263.488381394237;4266.488021437416;3766.4915236443003;3782.3569993101237;3786.9431958520645;3793.9810300948593;3801.3084177541004;5076.720780357079;5347.866303342447;5348.015728282416;5352.2506849041165;5369.40936496985;4858.514148585148;4862.419713593061;4862.902741945141;4870.391201099863;4883.389576302962;5695.345035320908;5704.828855134353;5721.542276617861;5735.397783232742;5747.683877386742;4002.479677641917;4100.200460910124;4122.969257685579;4127.607877251687;4127.876163715094;5849.707514624251;5882.23530940975;5898.64608123514;5907.6160049597065;5914.4381283777975;4198.265303571863;4209.442506272638;4215.852445164404;4219.067747915231;4221.556736542619;4165.66674666026;4225.218334608107;4275.657947364203;4278.272693642026;4289.699721019499;4847.95152048482;4849.326982191138;4861;4864.562189402971;4877.341558889575;5733.283339582552;5740.1102829061565;5747.683877386784;5770.307563092372;5770.826875193751;1413.3639862061907;1456.565283196051;1462.2980969134876;1467.2663668165917;1479.7188534178472;921.9627918591584;926.2312280807049;934.7569631895756;938.2025278513346;940.6143481172824;4880.243562247857;4918.37693561124;4921.557059864629;4930.8767280818265;4943.849425499919;5142.357205349332;5178.663386879841;5179.4779549906425;5200.97399513;5206.921896171561;4909.926351104737;4914.385701787277;4941.357623508921;4960.379952505937;5225.608079394061;3102.534619807002;3137.7449020392028;3138.2311333723383;3145.6225252969334;3145.6382516010494;6058.575899687068;6059.879042335236;6064.575479716465;6098.75604975796;6099.786507472217;5769.307683077974;6007.849803754853;6012.819615411545;6027;6027.7287522061615;6028.758849645965;6060.363661815534;6077.270727512727;6082.361352058058;6153.107799369066;5718.571107167062;5964.493018093511;5999.70001499932;6001.969990150022;6029.4874935629205;5879.323877754113;5890.204822349099;5901.29184497863;5910.408959104056;5914.645121292736;6132.601380910227;6142.249458904191;6142.754289828536;6162.845928851814;6170.259568851767;3988.700847436512;4150.232207041707;4181.226473102486;4183.853565125206;4187.225363307798;5650.57620678459;5821.27234095738;5855.189509035602;5869.559783016376;5908.172855800105;5723.254407405781;5760.457318749023;5770.6249093808765;5777.786664800439;5793.15999180125;5599.27481372273;5756.30924289088;5786.884262314814;5788.971055144697;5806.303243610793;5751.568632352507;5756.1941328214925;5769.480746732815;5775.33583637887;5793.217915581343;5809.157672137601;5817.342057513588;5820.1560773688425;5824.912626310694;5837.445442682938;5375.838724838261;5608.38307786135;5682.783714351323;5697.344805347272;5698.743556540048 07:24:57 INFO - PROCESS | 28958 | |5;yui.html;741.6847839668142;750.1373420566348;751.9624018799059;753.0774800868933;841.490898006706;13766.862331376684;14431.206283654396;14434.350454229558;14544.636384090403;14575.489857854976;13644.454221831114;13758.174509529435;13966.930165349184;14168.929155354208;14171.574852754435;523.7145755563208;554.9694766787825;841.5960339037266;850.098895171119;864.6109250837117;855.2730179347567;858.9527575983318;866.5580553917516;867.2498288980019;867.6832955971088;902.9683961061364;904.4708845325492;905.3436258712446;905.5608030105394;905.6105874473974;903.029243563169;903.8327909336793;903.9502827344494;904.1455824246058;904.2946501728662;671.9832004199885;674.0731494195481;674.3223060823841;674.6390680985699;674.7908148473989;13673.794893076612;13806.516771912935;13814.516491922734;13816.654583635389;13824.447022119102;14777.187254700988;15105.39578416862;15135.621609459742;15299.15854627995;15417;12197.939010304981;12297.508099676003;12342.938285308606;12380.690482737913;12417;3915.2968458720547;3944.6055394460614;3962.9009274768073;4029.959700402988;4034.5965403459713;84228.57885710594;88789.55605221997;88899;89215;89368.5531572338;11310.4910279036;11454.656360309204;11538.653840384803;11620.941895290469;11778.941105294418;22825.543489130123;23052.193173239193;23108.422289442562;23138.421539461648;23188.18841340545;7987.32107770846;8691.304695624334;8778.648854045767;8835.558222089;8858.15847494487;4887.877803054952;4920.114379411741;4923.606111511071;4941.901161976741;5048.368953880765;3437.071990562534;3579.6599323064265;3588.2644057968055;3591.586967498719;3591.9281614367565;604.0998911621652;613.0681364326289;636.4431122767578;643.350216281559;644.9742010319628;571.8884817460638;597.1878245585999;641.5605310362416;650.3366566102549;739.8421470398808;9966.402015878926;9990.600375984879;9996.700098997042;10021.248406369552;10333.586656533806;658.986820263592;694.9305069493112;711.661960568736;713.6075158662715;739.9408047356198;4639.953600463952;4820.156472617278;4853.102176097434;4862.975685121552;4896.216605343128;71348;74108.62945685237;74185.6290718543;74470;114963;91008;91937.08062919418;110167;110974.89025109807;112494.43752781184;54613.18080228879;84514;87786.12213877907;89375;93241.53379233196;9801.11789938909;9932.503374831374;10114.645987390406;10141.645042423479;10254.641087562199;52117.47882521126;52867.47132528779;53673.463265366845;54638.45361546334;54995.72502137464;45840.31239531343;47070.76464617655;52049.739751301;86199;86940.5652971731;12852.935735321264;13022.934885325512;13511.527096551574;13712.314384280946;13976.09155404936;13303.06878518533;14094.154350738989;14314.642133946734;14321;15313.46402875894;14607.19660418687;14725.190114543802;14812.333444994785;14872.62818429548;15293.464728734441;14258.71482570322;14301.427942882585;14689.41242350294;14691.045082069631;15541.84458155404;11841.407929603312;13640.113392629448;13743.793843092162;14341.426342946166;14882.032667876554;10418.68743937683;10439.791204176026;10589.629362972259;10640.84038739404;11064.28082174656;12120.575779847662;12374.319412432402;12401.193922395016;12509.937450312691;12568.811467827807 07:24:57 INFO - PROCESS | 28958 | __end_tp_report 07:24:57 INFO - PROCESS | 28958 | __start_cc_report 07:24:57 INFO - PROCESS | 28958 | _x_x_mozilla_cycle_collect,862 07:24:57 INFO - PROCESS | 28958 | __end_cc_report 07:24:57 INFO - PROCESS | 28958 | __startTimestamp1480001097664__endTimestamp 07:24:57 INFO - PROCESS | 28958 | 07:24:57 INFO - PROCESS | 28958 | ------- Summary: start ------- 07:24:57 INFO - PROCESS | 28958 | Number of tests: 6 07:24:57 INFO - PROCESS | 28958 | 07:24:57 INFO - PROCESS | 28958 | [#0] dojo.html Cycles:165 Average:5598.00 Median:5829.56 stddev:646.48 (11.1%) stddev-sans-first:618.60 07:24:57 INFO - PROCESS | 28958 | Values: 3122.0 3168.0 3182.1 3196.0 3211.5 5488.4 5546.9 5583.0 5594.9 5612.3 5648.9 5717.0 5728.5 5729.4 5733.8 5164.2 5168.6 5190.0 5204.7 5239.1 5073.7 5225.3 5259.1 5259.4 5288.0 5039.2 5051.6 5070.2 5093.1 5126.2 5074.1 5106.0 5107.0 5143.2 5175.3 4999.8 5062.2 5121.7 5133.4 5140.2 5398.6 5441.0 5524.4 5559.4 5575.2 6092.1 6105.5 6107.8 6116.3 6116.7 6109.1 6147.0 6156.2 6161.2 6162.9 5486.3 5547.4 5585.3 5611.2 5644.0 6195.2 6195.7 6202.0 6202.6 6204.3 5948.7 5954.5 5969.6 5986.4 6000.4 5777.4 5810.3 5906.5 5923.8 6030.1 6022.1 6023.7 6029.3 6031.1 6050.2 6023.7 6024.9 6025.0 6031.4 6056.8 4542.9 4546.4 4589.5 4620.5 4628.4 4115.0 4129.4 4136.7 4159.0 4168.2 5791.2 5792.8 5794.3 5802.3 5823.5 5939.0 6004.6 6064.1 6114.8 6117.3 5623.7 5625.1 5658.0 5713.8 5744.7 5196.9 5197.8 5199.3 5199.7 5205.9 6114.4 6148.7 6197.3 6205.5 6206.3 5998.5 6001.6 6050.1 6051.3 6140.8 6265.0 6276.4 6312.2 6312.4 6322.1 5985.2 5987.6 6000.8 6001.8 6014.0 5874.9 5891.1 5892.2 5905.1 5909.0 5841.0 5842.5 5844.4 5849.2 5882.5 5838.7 5840.5 5840.9 5841.7 5842.0 5600.4 5711.6 5803.1 5812.3 5840.8 5973.6 5973.6 5982.5 5984.6 5990.6 5829.5 5829.6 5834.1 5836.3 5843.8 07:24:57 INFO - PROCESS | 28958 | 07:24:57 INFO - PROCESS | 28958 | [#1] ext.html Cycles:180 Average:63584.29 Median:40705.40 stddev:129971.17 (319.3%) stddev-sans-first:130249.72 07:24:57 INFO - PROCESS | 28958 | Values: 590.3 634.6 648.3 651.2 656.1 35097.1 38177.4 46279.8 47087.3 47266.3 48132.0 48379.3 48515.0 48541.0 48647.3 9277.4 9444.5 9462.9 9466.2 9468.9 8543.1 8730.5 10995.0 11253.9 11259.8 11497.7 11599.9 11607.8 11609.4 11614.1 11265.8 11335.0 11349.4 11353.7 11362.5 11142.3 11172.3 11194.2 11207.6 11209.2 44689.3 45074.1 45080.3 45093.1 45099.3 3667.7 3767.5 3791.5 3798.4 3990.4 34276.0 34620.7 34963.3 35836.5 36388.0 4493.3 4500.3 4506.8 4547.1 4627.9 258079.0 259422.0 259740.0 261000.0 262039.0 39299.2 63930.4 64097.4 64123.4 64378.0 40200.2 42493.8 42592.6 42613.0 42628.4 16958.0 16991.7 17102.7 17111.9 17130.5 10890.6 11278.8 14135.4 14205.2 14259.4 9384.1 9694.2 9700.5 9771.3 9854.0 3642.0 3653.8 3669.2 3692.4 3766.3 1040.6 1068.9 1084.3 1119.8 1155.5 32824.8 32899.7 32906.2 32918.8 33578.8 1151.4 1192.0 1198.7 1246.6 1283.6 17619.7 17816.2 17845.1 17847.1 17902.2 605617.0 614171.0 614445.0 614655.0 615200.0 62980.7 63507.0 63571.4 63589.7 63607.4 1231.8 1337.4 1432.1 1457.5 1478.9 34757.0 35883.6 36016.0 37774.4 38277.6 57261.0 58020.0 63198.4 63288.7 63309.7 511938.0 520108.0 520125.0 520526.0 521255.0 39589.2 47090.8 48034.3 48886.5 49847.5 51652.7 52067.0 52798.5 52988.0 53136.5 40392.8 40547.0 40863.8 41954.8 45996.0 41551.8 44928.3 45169.8 46253.5 46951.0 44548.3 45137.0 45468.8 45960.8 45974.5 39278.2 41046.8 41292.2 41321.8 42004.4 29919.6 30291.8 30629.7 30729.0 31083.4 07:24:57 INFO - PROCESS | 28958 | 07:24:57 INFO - PROCESS | 28958 | [#2] jquery.html Cycles:180 Average:30557.26 Median:23672.32 stddev:86780.52 (366.6%) stddev-sans-first:86994.48 07:24:57 INFO - PROCESS | 28958 | Values: 430.5 431.1 432.5 432.6 447.0 18585.4 20124.3 20321.2 20602.1 20831.3 19683.8 20063.0 20235.3 20352.8 20383.5 5816.9 6090.1 6096.5 6096.6 6101.5 5805.3 5970.0 5980.1 5985.7 5993.3 5918.7 5949.5 5952.3 5953.4 5955.0 5708.0 5873.3 5899.9 5900.4 5905.8 5165.6 5326.3 5326.9 5328.3 5331.2 23567.9 23776.8 23818.6 23992.3 24028.2 2678.9 2689.2 2805.7 2929.4 2932.5 14192.9 14982.6 15354.7 15421.2 15645.6 1917.0 2013.8 2026.9 2033.6 2078.8 84366.2 84652.2 84707.0 85989.6 86765.6 9795.6 10259.4 10426.7 10782.2 11129.8 14287.3 14336.7 14384.6 14486.2 14684.5 8069.4 8070.7 8157.3 8216.3 8288.8 7997.8 8039.0 8052.5 8213.2 8235.0 4429.1 4454.2 4484.9 4529.7 4611.5 2024.4 2062.6 2081.4 2092.9 2111.1 981.6 1025.1 1057.8 1062.7 1093.1 18862.9 19615.0 19717.7 20164.7 20215.4 1016.5 1017.8 1048.7 1068.6 1070.5 10755.8 11357.3 11416.8 11512.7 11564.4 396674.0 541906.0 558151.0 558731.0 559884.0 61707.0 69226.7 98536.5 105113.5 106523.0 1055.3 1056.3 1074.3 1082.3 1093.5 18349.0 18663.5 18892.9 18939.2 19277.5 43799.3 44291.3 44539.6 45077.3 46116.3 63104.0 63699.0 63710.0 63923.7 64765.7 9218.5 9327.7 9411.8 9459.4 9552.6 10386.9 12474.9 13289.3 13772.0 14431.4 12002.3 12398.8 12424.3 12556.9 12611.3 12057.8 12196.6 12212.7 12310.0 12339.9 12081.3 12194.9 12330.3 12458.1 12895.2 9024.6 9058.3 9224.0 9231.5 9236.3 11939.2 12039.2 12128.2 12200.8 12292.8 07:24:57 INFO - PROCESS | 28958 | 07:24:57 INFO - PROCESS | 28958 | [#3] mootools.html Cycles:180 Average:5966.37 Median:4558.93 stddev:3362.56 (73.8%) stddev-sans-first:3352.78 07:24:57 INFO - PROCESS | 28958 | Values: 1184.2 1520.1 1523.1 1689.8 1844.8 7466.0 8479.3 8795.8 8812.5 9018.6 8790.7 8858.3 8861.3 8867.4 8904.2 2526.5 2554.4 2555.9 2557.3 2557.7 2436.1 2474.2 2488.8 2500.8 2501.9 2410.4 2419.3 2469.9 2469.9 2470.1 2408.0 2424.5 2432.8 2446.7 2478.8 2390.3 2411.8 2420.6 2424.1 2424.5 8735.0 8878.5 9021.8 9085.9 9106.9 5508.3 5657.4 5661.0 5663.1 5664.4 3536.6 3559.7 3595.3 3604.9 3613.7 1146.0 1155.5 1161.3 1162.3 1174.7 12707.0 12736.1 12748.7 12785.6 12817.6 4786.8 4829.3 4858.4 4896.9 5016.2 10073.7 10114.1 10191.7 10194.1 10200.7 5544.1 5545.5 5547.3 5550.0 5550.1 4492.1 4625.7 5126.7 5202.8 5244.1 3974.1 4059.4 4084.4 4123.7 4179.1 1322.5 1346.1 1347.7 1358.3 1367.3 876.2 1002.4 1003.8 1009.5 1010.7 6140.5 6163.2 6253.8 6375.9 6696.2 481.2 485.7 1026.6 1084.7 1116.6 4240.7 4322.5 4343.2 4407.0 4429.5 10970.6 11597.9 11720.7 11742.8 11743.3 11463.7 11523.9 11614.5 11617.9 11633.5 8365.1 8517.2 8545.2 8564.9 8566.4 6087.9 6159.7 6162.2 6240.6 6260.2 9670.0 9984.3 10040.6 10167.1 10384.9 10244.7 10264.2 10318.7 10337.5 10372.6 7614.7 7690.4 7771.1 7900.3 7950.9 9008.4 9080.4 9085.2 9098.9 9099.9 7226.3 7401.8 7662.8 7773.3 7934.7 7411.6 7433.8 7470.3 7564.7 7794.9 7127.8 7319.0 7319.6 7319.9 7325.5 5142.7 5349.1 5390.2 5398.2 5557.8 5073.2 5118.4 5126.9 5183.1 5355.6 07:24:57 INFO - PROCESS | 28958 | 07:24:57 INFO - PROCESS | 28958 | [#4] prototype.html Cycles:180 Average:4789.10 Median:5350.13 stddev:1411.82 (26.4%) stddev-sans-first:1375.71 07:24:57 INFO - PROCESS | 28958 | Values: 339.5 339.9 351.8 355.8 358.2 5530.6 5530.9 5558.4 5564.0 5565.8 5212.6 5272.9 5302.6 5381.8 5512.9 4241.0 4260.5 4262.6 4265.5 4268.7 4276.5 4285.3 4291.8 4301.3 4307.5 4113.0 4216.9 4260.7 4269.0 4279.8 4234.0 4241.4 4261.0 4263.5 4266.5 3766.5 3782.4 3786.9 3794.0 3801.3 5076.7 5347.9 5348.0 5352.3 5369.4 4858.5 4862.4 4862.9 4870.4 4883.4 5695.3 5704.8 5721.5 5735.4 5747.7 4002.5 4100.2 4123.0 4127.6 4127.9 5849.7 5882.2 5898.6 5907.6 5914.4 4198.3 4209.4 4215.9 4219.1 4221.6 4165.7 4225.2 4275.7 4278.3 4289.7 4848.0 4849.3 4861.0 4864.6 4877.3 5733.3 5740.1 5747.7 5770.3 5770.8 1413.4 1456.6 1462.3 1467.3 1479.7 922.0 926.2 934.8 938.2 940.6 4880.2 4918.4 4921.6 4930.9 4943.8 5142.4 5178.7 5179.5 5201.0 5206.9 4909.9 4914.4 4941.4 4960.4 5225.6 3102.5 3137.7 3138.2 3145.6 3145.6 6058.6 6059.9 6064.6 6098.8 6099.8 5769.3 6007.8 6012.8 6027.0 6027.7 6028.8 6060.4 6077.3 6082.4 6153.1 5718.6 5964.5 5999.7 6002.0 6029.5 5879.3 5890.2 5901.3 5910.4 5914.6 6132.6 6142.2 6142.8 6162.8 6170.3 3988.7 4150.2 4181.2 4183.9 4187.2 5650.6 5821.3 5855.2 5869.6 5908.2 5723.3 5760.5 5770.6 5777.8 5793.2 5599.3 5756.3 5786.9 5789.0 5806.3 5751.6 5756.2 5769.5 5775.3 5793.2 5809.2 5817.3 5820.2 5824.9 5837.4 5375.8 5608.4 5682.8 5697.3 5698.7 07:24:57 INFO - PROCESS | 28958 | 07:24:57 INFO - PROCESS | 28958 | [#5] yui.html Cycles:180 Average:20093.87 Median:25855.36 stddev:28178.39 (109.0%) stddev-sans-first:28219.97 07:24:57 INFO - PROCESS | 28958 | Values: 741.7 750.1 752.0 753.1 841.5 13766.9 14431.2 14434.4 14544.6 14575.5 13644.5 13758.2 13966.9 14168.9 14171.6 523.7 555.0 841.6 850.1 864.6 855.3 859.0 866.6 867.2 867.7 903.0 904.5 905.3 905.6 905.6 903.0 903.8 904.0 904.1 904.3 672.0 674.1 674.3 674.6 674.8 13673.8 13806.5 13814.5 13816.7 13824.4 14777.2 15105.4 15135.6 15299.2 15417.0 12197.9 12297.5 12342.9 12380.7 12417.0 3915.3 3944.6 3962.9 4030.0 4034.6 84228.6 88789.6 88899.0 89215.0 89368.6 11310.5 11454.7 11538.7 11620.9 11778.9 22825.5 23052.2 23108.4 23138.4 23188.2 7987.3 8691.3 8778.6 8835.6 8858.2 4887.9 4920.1 4923.6 4941.9 5048.4 3437.1 3579.7 3588.3 3591.6 3591.9 604.1 613.1 636.4 643.4 645.0 571.9 597.2 641.6 650.3 739.8 9966.4 9990.6 9996.7 10021.2 10333.6 659.0 694.9 711.7 713.6 739.9 4640.0 4820.2 4853.1 4863.0 4896.2 71348.0 74108.6 74185.6 74470.0 114963.0 91008.0 91937.1 110167.0 110974.9 112494.4 54613.2 84514.0 87786.1 89375.0 93241.5 9801.1 9932.5 10114.6 10141.6 10254.6 52117.5 52867.5 53673.5 54638.5 54995.7 45840.3 47070.8 52049.7 86199.0 86940.6 12852.9 13022.9 13511.5 13712.3 13976.1 13303.1 14094.2 14314.6 14321.0 15313.5 14607.2 14725.2 14812.3 14872.6 15293.5 14258.7 14301.4 14689.4 14691.0 15541.8 11841.4 13640.1 13743.8 14341.4 14882.0 10418.7 10439.8 10589.6 10640.8 11064.3 12120.6 12374.3 12401.2 12509.9 12568.8 07:24:57 INFO - PROCESS | 28958 | -------- Summary: end -------- 07:24:57 INFO - PROCESS | 28958 | 07:24:58 INFO - TEST-INFO | 28958: exit 0 07:24:58 INFO - TEST-OK | dromaeo_css | took 1112981ms 07:24:58 INFO - TEST-START | kraken 07:24:58 INFO - operating with platform_type : linux_ 07:24:58 INFO - Initialising browser for kraken test... 07:24:58 INFO - TEST-INFO | started process 29274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptL80J1/profile http://localhost:42132/getInfo.html) 07:25:02 INFO - PROCESS | 29274 | __metrics Screen width/height:1600/1200 07:25:02 INFO - PROCESS | 29274 | colorDepth:24 07:25:02 INFO - PROCESS | 29274 | Browser inner width/height: 1024/697 07:25:02 INFO - PROCESS | 29274 | __metrics 07:25:03 INFO - PROCESS | 29274 | 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" 07:25:03 INFO - PROCESS | 29274 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:25:03 INFO - PROCESS | 29274 | console.error: PushService: 07:25:03 INFO - PROCESS | 29274 | stateChangeProcessEnqueue: Error transitioning state 07:25:03 INFO - PROCESS | 29274 | UnknownError 07:25:04 INFO - TEST-INFO | 29274: exit 0 07:25:04 INFO - Browser initialized. 07:25:04 INFO - Running cycle 1/1 for kraken test... 07:25:04 INFO - TEST-INFO | started process 29367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptL80J1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:15 INFO - PROCESS | 29367 | RSS: Main: 142835712 07:25:15 INFO - PROCESS | 29367 | 07:25:18 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42132/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:19 INFO - PROCESS | 29367 | RSS: Main: 186667008 07:25:19 INFO - PROCESS | 29367 | 07:25:21 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42132/tests/kraken/driver.html?testName=audio-dft) 07:25:22 INFO - PROCESS | 29367 | RSS: Main: 174034944 07:25:22 INFO - PROCESS | 29367 | 07:25:25 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42132/tests/kraken/driver.html?testName=audio-fft) 07:25:25 INFO - PROCESS | 29367 | RSS: Main: 265261056 07:25:25 INFO - PROCESS | 29367 | 07:25:27 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42132/tests/kraken/driver.html?testName=audio-oscillator) 07:25:28 INFO - PROCESS | 29367 | RSS: Main: 171958272 07:25:28 INFO - PROCESS | 29367 | 07:25:30 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42132/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:25:31 INFO - PROCESS | 29367 | RSS: Main: 173355008 07:25:31 INFO - PROCESS | 29367 | 07:25:34 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42132/tests/kraken/driver.html?testName=imaging-darkroom) 07:25:34 INFO - PROCESS | 29367 | RSS: Main: 209747968 07:25:34 INFO - PROCESS | 29367 | 07:25:38 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42132/tests/kraken/driver.html?testName=imaging-desaturate) 07:25:38 INFO - PROCESS | 29367 | RSS: Main: 208384000 07:25:38 INFO - PROCESS | 29367 | 07:25:41 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42132/tests/kraken/driver.html?testName=json-parse-financial) 07:25:41 INFO - PROCESS | 29367 | RSS: Main: 208302080 07:25:41 INFO - PROCESS | 29367 | 07:25:43 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42132/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:25:44 INFO - PROCESS | 29367 | RSS: Main: 169824256 07:25:44 INFO - PROCESS | 29367 | 07:25:45 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42132/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:25:46 INFO - PROCESS | 29367 | RSS: Main: 178221056 07:25:46 INFO - PROCESS | 29367 | 07:25:48 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42132/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:25:48 INFO - PROCESS | 29367 | RSS: Main: 186417152 07:25:48 INFO - PROCESS | 29367 | 07:25:51 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42132/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:25:52 INFO - PROCESS | 29367 | RSS: Main: 195289088 07:25:52 INFO - PROCESS | 29367 | 07:25:54 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42132/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:25:55 INFO - PROCESS | 29367 | RSS: Main: 191868928 07:25:55 INFO - PROCESS | 29367 | 07:25:56 INFO - PROCESS | 29367 | Cycle 1(1): loaded http://localhost:42132/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42132/tests/kraken/driver.html?testName=ai-astar) 07:25:57 INFO - PROCESS | 29367 | RSS: Main: 243216384 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | __start_tp_report 07:25:57 INFO - PROCESS | 29367 | _x_x_mozilla_page_load 07:25:57 INFO - PROCESS | 29367 | _x_x_mozilla_page_load_details 07:25:57 INFO - PROCESS | 29367 | |i|pagename|runs| 07:25:57 INFO - PROCESS | 29367 | |0;ai-astar;111;112;110;111;111;111;111;111;111;111 07:25:57 INFO - PROCESS | 29367 | |1;audio-beat-detection;143;120;123;161;124;121;127;125;159;118 07:25:57 INFO - PROCESS | 29367 | |2;audio-dft;161;161;160;160;160;161;163;164;161;161 07:25:57 INFO - PROCESS | 29367 | |3;audio-fft;75;76;75;107;74;75;76;75;109;75 07:25:57 INFO - PROCESS | 29367 | |4;audio-oscillator;81;82;112;81;81;81;100;81;81;108 07:25:57 INFO - PROCESS | 29367 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;116;117 07:25:57 INFO - PROCESS | 29367 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;145;145 07:25:57 INFO - PROCESS | 29367 | |7;imaging-desaturate;95;94;95;95;95;96;95;95;98;95 07:25:57 INFO - PROCESS | 29367 | |8;json-parse-financial;50;49;47;49;50;50;49;50;60;52 07:25:57 INFO - PROCESS | 29367 | |9;json-stringify-tinderbox;58;59;59;59;58;59;58;58;59;61 07:25:57 INFO - PROCESS | 29367 | |10;stanford-crypto-aes;77;78;73;74;73;82;73;76;73;78 07:25:57 INFO - PROCESS | 29367 | |11;stanford-crypto-ccm;122;120;121;125;126;121;119;120;165;140 07:25:57 INFO - PROCESS | 29367 | |12;stanford-crypto-pbkdf2;158;157;156;155;159;153;159;158;157;156 07:25:57 INFO - PROCESS | 29367 | |13;stanford-crypto-sha256-iterative;64;67;64;63;65;63;63;63;62;60 07:25:57 INFO - PROCESS | 29367 | __end_tp_report 07:25:57 INFO - PROCESS | 29367 | __start_cc_report 07:25:57 INFO - PROCESS | 29367 | _x_x_mozilla_cycle_collect,1574 07:25:57 INFO - PROCESS | 29367 | __end_cc_report 07:25:57 INFO - PROCESS | 29367 | __startTimestamp1480001157211__endTimestamp 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | ------- Summary: start ------- 07:25:57 INFO - PROCESS | 29367 | Number of tests: 14 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:25:57 INFO - PROCESS | 29367 | Values: 111.0 112.0 110.0 111.0 111.0 111.0 111.0 111.0 111.0 111.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:126.00 stddev:16.23 (12.9%) stddev-sans-first:16.73 07:25:57 INFO - PROCESS | 29367 | Values: 143.0 120.0 123.0 161.0 124.0 121.0 127.0 125.0 159.0 118.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 07:25:57 INFO - PROCESS | 29367 | Values: 161.0 161.0 160.0 160.0 160.0 161.0 163.0 164.0 161.0 161.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:13.88 (18.5%) stddev-sans-first:14.51 07:25:57 INFO - PROCESS | 29367 | Values: 75.0 76.0 75.0 107.0 74.0 75.0 76.0 75.0 109.0 75.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:81.00 stddev:12.66 (15.6%) stddev-sans-first:13.11 07:25:57 INFO - PROCESS | 29367 | Values: 81.0 82.0 112.0 81.0 81.0 81.0 100.0 81.0 81.0 108.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:25:57 INFO - PROCESS | 29367 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:25:57 INFO - PROCESS | 29367 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.06 (1.1%) stddev-sans-first:1.12 07:25:57 INFO - PROCESS | 29367 | Values: 95.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 98.0 95.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.00 stddev:3.53 (7.1%) stddev-sans-first:3.74 07:25:57 INFO - PROCESS | 29367 | Values: 50.0 49.0 47.0 49.0 50.0 50.0 49.0 50.0 60.0 52.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 07:25:57 INFO - PROCESS | 29367 | Values: 58.0 59.0 59.0 59.0 58.0 59.0 58.0 58.0 59.0 61.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.50 stddev:3.06 (4.0%) stddev-sans-first:3.21 07:25:57 INFO - PROCESS | 29367 | Values: 77.0 78.0 73.0 74.0 73.0 82.0 73.0 76.0 73.0 78.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:123.50 stddev:14.41 (11.7%) stddev-sans-first:15.13 07:25:57 INFO - PROCESS | 29367 | Values: 122.0 120.0 121.0 125.0 126.0 121.0 119.0 120.0 165.0 140.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:157.50 stddev:1.87 (1.2%) stddev-sans-first:1.94 07:25:57 INFO - PROCESS | 29367 | Values: 158.0 157.0 156.0 155.0 159.0 153.0 159.0 158.0 157.0 156.0 07:25:57 INFO - PROCESS | 29367 | 07:25:57 INFO - PROCESS | 29367 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.84 (2.9%) stddev-sans-first:1.94 07:25:57 INFO - PROCESS | 29367 | Values: 64.0 67.0 64.0 63.0 65.0 63.0 63.0 63.0 62.0 60.0 07:25:57 INFO - PROCESS | 29367 | -------- Summary: end -------- 07:25:57 INFO - PROCESS | 29367 | 07:25:58 INFO - TEST-INFO | 29367: exit 0 07:25:58 INFO - TEST-OK | kraken | took 60024ms 07:25:58 INFO - SUITE-END | took 1173s 07:25:58 INFO - Completed test suite (00:19:33) 07:25:58 INFO - javascript benchmark 07:25:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.9843900780497, 3167.952480712788, 3182.061291918885, 3196.0411876437065, 3211.50221715634, 5488.368837583679, 5546.861328466785, 5583.0, 5594.888102237953, 5612.270404847369, 5648.887022259552, 5717.0, 5728.484436400723, 5729.427057294279, 5733.770649174028, 5164.2253661950635, 5168.638195326319, 5190.039842629126, 5204.739763011853, 5239.083160446926, 5073.670211436263, 5225.346831646044, 5259.079661059319, 5259.421463638997, 5288.048151332759, 5039.21892106724, 5051.621128415365, 5070.2394640803805, 5093.083245015896, 5126.2054381570915, 5074.137396642561, 5106.0, 5106.953074619712, 5143.202803565453, 5175.327207463043, 4999.775010124553, 5062.215356619693, 5121.6670916390685, 5133.358330208724, 5140.177571588528, 5398.595105367113, 5440.972795136038, 5524.447555244444, 5559.416261292547, 5575.163725441175, 6092.116643086728, 6105.45050945417, 6107.786227482017, 6116.296625888035, 6116.663583502906, 6109.114178444101, 6147.047207682816, 6156.230471191101, 6161.199044124235, 6162.907556386658, 5486.31421072366, 5547.389787123413, 5585.273914391103, 5611.158326251095, 5644.040513112781, 6195.19462469885, 6195.721192546346, 6202.038684003986, 6202.596831205957, 6204.286507051656, 5948.67282299469, 5954.46409823118, 5969.552283578749, 5986.398630882018, 6000.429959153874, 5777.3933736957015, 5810.331811841608, 5906.527477801766, 5923.763049477972, 6030.095485677183, 6022.126791615191, 6023.728932198062, 6029.336772954972, 6031.09533569968, 6050.21347224858, 6023.69881505923, 6024.939750602525, 6025.0, 6031.366706495843, 6056.818295451144, 4542.931856022163, 4546.408966834357, 4589.495155532889, 4620.53794620542, 4628.421447319085, 4114.958850411457, 4129.359949207877, 4136.710430269913, 4159.043420013414, 4168.228877657643, 5791.218185544982, 5792.797252096157, 5794.304683438015, 5802.274715660543, 5823.5341172706085, 5938.970305148447, 6004.579679422486, 6064.06007068905, 6114.755409783559, 6117.265928088658, 5623.718814059281, 5625.09998400254, 5657.971710141505, 5713.800016999468, 5744.655320680772, 5196.92204616931, 5197.792088316501, 5199.298094757235, 5199.66202196856, 5205.947940520622, 6114.449699527064, 6148.661823599656, 6197.318294987548, 6205.472534834499, 6206.286277078104, 5998.490128338965, 6001.609895356788, 6050.062240352752, 6051.304100028553, 6140.754369825157, 6265.0, 6276.435120839146, 6312.242530896322, 6312.368763123651, 6322.114903913548, 5985.221921150222, 5987.550933679904, 6000.8499787503915, 6001.849953751192, 6014.0377539593455, 5874.853128671817, 5891.05743081105, 5892.175095486549, 5905.084711869667, 5909.0, 5841.036229022334, 5842.503387212135, 5844.444777746107, 5849.181114643869, 5882.5293976480925, 5838.678872661874, 5840.532757379315, 5840.912386314294, 5841.737121829613, 5842.036064049385, 5600.383957764561, 5711.5716321276905, 5803.071508558611, 5812.331581868139, 5840.795572155124, 5973.611715238496, 5973.611715238496, 5982.49148822355, 5984.58107932458, 5990.550708696778, 5829.504492118217, 5829.562782791223, 5834.124881267844, 5836.299644042572, 5843.824685259449], "value": 5553.040316477109, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.3211306996953, 634.5780056262586, 648.2739331948219, 651.2217899609968, 656.0716586030766, 35097.12257193572, 38177.42733858994, 46279.76860115703, 47087.29369059458, 47266.291005634856, 48132.0, 48379.27431088537, 48515.0, 48541.0, 48647.27029094558, 9277.396969197014, 9444.527773611326, 9462.858057129148, 9466.19537339327, 9468.857967130498, 8543.102974187714, 8730.51982140982, 10995.0, 11253.887461125407, 11259.774804503904, 11497.655070347902, 11599.884001159964, 11607.767844643102, 11609.419529023557, 11614.070874330033, 11265.831012534818, 11335.0, 11349.432528373549, 11353.659390218307, 11362.48868800906, 11142.331460112338, 11172.329660220414, 11194.216404851582, 11207.551697932073, 11209.215354925158, 44689.329660055126, 45074.09851802946, 45080.3237951431, 45093.09813803706, 45099.32351014738, 3667.688246499051, 3767.523943606133, 3791.469194312798, 3798.4302354646748, 3990.4213888985932, 34276.0, 34620.65379346199, 34963.30073398543, 35836.462453062966, 36388.0, 4493.326001099828, 4500.257457519506, 4506.752128632924, 4547.067851090552, 4627.930581041287, 258079.0, 259422.0, 259740.0, 261000.0, 262039.0, 39299.214015719524, 63930.36069639337, 64097.35902641007, 64123.358766412675, 64378.0, 40200.195996079914, 42493.787531062764, 42592.57407425948, 42613.0, 42628.3605745914, 16958.0, 16991.660166796595, 17102.743458848126, 17111.91444042797, 17130.48608541746, 10890.61882834097, 11278.830817537744, 14135.43458261658, 14205.218712970885, 14259.358328875225, 9384.108509691569, 9694.22446204302, 9700.466474343979, 9771.267154963263, 9853.950730246303, 3642.0488385944223, 3653.762505437191, 3669.1744357519347, 3692.4276737105793, 3766.3032339016822, 1040.6461802986869, 1068.8557044799009, 1084.295208114716, 1119.753654196092, 1155.5493357590547, 32824.83587582094, 32899.67100328966, 32906.17734556607, 32918.835405822814, 33578.83210583931, 1151.3609946479617, 1191.9642410727517, 1198.688341031338, 1246.644706258712, 1283.5892514395491, 17619.735703964452, 17816.198271077832, 17845.107744612716, 17847.058059163806, 17902.194401251974, 605617.0, 614171.0, 614445.0, 614655.0, 615200.0, 62980.68509657423, 63507.0, 63571.36428635655, 63589.682051590375, 63607.36392636014, 1231.8398608180878, 1337.4249072898747, 1432.0667099415705, 1457.5190187238186, 1478.9038712483868, 34757.0, 35883.64116358803, 36016.0, 37774.43338349872, 38277.61722382852, 57261.0, 58020.0, 63198.36801631925, 63288.68355658192, 63309.68345158429, 511938.0, 520108.0, 520125.0, 520526.0, 521255.0, 39589.17460079397, 47090.76454617705, 48034.27948580844, 48886.5111348882, 49847.50152498574, 51652.74173629108, 52067.0, 52798.47201527935, 52988.0, 53136.468635313155, 40392.79803600963, 40547.0, 40863.7956810214, 41954.79022604867, 45996.0, 41551.79224103981, 44928.32607510825, 45169.77415112904, 46253.537464624926, 46951.0, 44548.331775024046, 45137.0, 45468.772656136505, 45960.770196148806, 45974.54025459703, 39278.2144357117, 41046.79476602598, 41292.1741565173, 41321.79339103285, 42004.3699344504, 29919.55120673148, 30291.848540757153, 30629.693703062683, 30729.0, 31083.378332432774], "value": 20896.361498337857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.52857121452, 431.1370268052649, 432.51774271687066, 432.62793997162436, 446.9664775141865, 18585.442436726902, 20124.295649652264, 20321.1871525139, 20602.072906719197, 20831.27090551831, 19683.803161968375, 20063.0, 20235.291764788235, 20352.796472035276, 20383.49041273965, 5816.854578635547, 6090.147379366892, 6096.4513193812545, 6096.634201947875, 6101.450869421751, 5805.303363596353, 5970.0, 5980.132880732292, 5985.670788106652, 5993.28080630325, 5918.733656985446, 5949.464548190662, 5952.255968003999, 5953.3748956359605, 5954.970225148868, 5708.0, 5873.295204575457, 5899.852503687399, 5900.3509613942215, 5905.763769449217, 5165.586753059746, 5326.307580014573, 5326.866828329284, 5328.333958255218, 5331.173668081415, 23567.88216058926, 23776.762232377627, 23818.64272035921, 23992.28023159308, 24028.15901443441, 2678.8794504247358, 2689.247010836969, 2805.733455321741, 2929.355541780826, 2932.4868148074215, 14192.92903535486, 14982.62543436412, 15354.692906141927, 15421.15183664898, 15645.608859778482, 1916.9808301916942, 2013.7885522020124, 2026.8986550672407, 2033.6237796007786, 2078.8025137612053, 84366.15633843644, 84652.15347846504, 84707.0, 85989.57005214997, 86765.56617216874, 9795.559199836025, 10259.384436933808, 10426.68719938403, 10782.245242832927, 11129.777404451866, 14287.285635718172, 14336.713265734626, 14384.568462946128, 14486.203258820655, 14684.486042988658, 8069.354451643854, 8070.717524886601, 8157.347412207009, 8216.34269258458, 8288.751337459886, 7997.840043199103, 8039.0, 8052.516848989079, 8213.219744124299, 8234.958825205955, 4429.092036132585, 4454.153710794939, 4484.910301793946, 4529.728216307032, 4611.492735799059, 2024.382563318202, 2062.5668609592153, 2081.3651836189806, 2092.8953552322323, 2111.144986280559, 981.5533932060895, 1025.1183981775666, 1057.7672911959357, 1062.721504159676, 1093.0818112785298, 18862.905685471484, 19615.0, 19717.704234436496, 20164.727623172956, 20215.39353819388, 1016.5425558498557, 1017.7760892603616, 1048.7220886465093, 1068.647346375694, 1070.4540684251087, 10755.83866242007, 11357.318560886208, 11416.828747568794, 11512.654620361403, 11564.42177891102, 396674.0, 541906.0, 558151.0, 558731.0, 559884.0, 61707.0, 69226.65386673034, 98536.50731746295, 105113.47443262735, 106523.0, 1055.2876808154465, 1056.3292309383596, 1074.3446497636435, 1082.2748758331936, 1093.5297821936804, 18349.0, 18663.533411664816, 18892.905535472233, 18939.242430302635, 19277.518062048, 43799.34300985424, 44291.33562996493, 44539.554604453544, 45077.32384014177, 46116.30825537687, 63104.0, 63699.0, 63710.0, 63923.68038159779, 64765.67617161884, 9218.539073046186, 9327.720168394959, 9411.764705882408, 9459.432434053979, 9552.570134343832, 10386.948065259625, 12474.939630131541, 13289.269090200132, 13772.03595748288, 14431.42274309016, 12002.279863208236, 12398.752024959631, 12424.316662583644, 12556.937215313865, 12611.30637814929, 12057.81913271284, 12196.573119941115, 12212.69468263265, 12310.0, 12339.876601233873, 12081.275123492618, 12194.87805121973, 12330.260184388966, 12458.127931044739, 12895.16181448203, 9024.593893274687, 9058.275337973078, 9223.953880230556, 9231.538423078684, 9236.26109911219, 11939.164258501822, 12039.217450865666, 12128.151029428209, 12200.81698774537, 12292.754144917231], "value": 9680.594245481916, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1184.23025033728, 1520.0575643101279, 1523.1470376589111, 1689.7972243330803, 1844.8155184481554, 7465.962670186648, 8479.32165426766, 8795.78010549735, 8812.471251724894, 9018.594163262653, 8790.6923257686, 8858.291336693064, 8861.291096712264, 8867.423617464876, 8904.154105359996, 2526.5452218600644, 2554.4380236347974, 2555.884985175662, 2557.296743395572, 2557.718650948394, 2436.1473484280536, 2474.183519438581, 2488.7635674610883, 2500.7999360051244, 2501.862397568133, 2410.385351735305, 2419.346776370379, 2469.937926691522, 2469.938251543717, 2470.110760126353, 2407.9518409631796, 2424.46661734419, 2432.768886955745, 2446.7308596054418, 2478.776910078084, 2390.2829151254555, 2411.8191135664897, 2420.5884999550117, 2424.1030818597055, 2424.515096980611, 8735.0, 8878.511681857495, 9021.819563608757, 9085.863712044325, 9106.86339704905, 5508.256385387961, 5657.434256574351, 5661.0, 5663.093904975184, 5664.405237450091, 3536.5932917714536, 3559.697425718817, 3595.280943811222, 3604.891853244407, 3613.7470377073614, 1145.9885401146048, 1155.5435602936793, 1161.3380373187288, 1162.2503485251966, 1174.74155685749, 12707.0, 12736.108472406935, 12748.745025099446, 12785.55250566235, 12817.615471535775, 4786.760661966888, 4829.323894654681, 4858.416989961227, 4896.853094407174, 5016.241067412909, 10073.69778906634, 10114.089731924016, 10191.694249172537, 10194.133498652549, 10200.693979180489, 5544.085225937756, 5545.528630066409, 5547.306586676666, 5549.972250138723, 5550.139728342114, 4492.146492166478, 4625.722456652612, 5126.66676666023, 5202.817901373433, 5244.082285600005, 3974.0859602291634, 4059.3707975263883, 4084.4281800547947, 4123.690723195772, 4179.080602267496, 1322.4776213395846, 1346.104840281202, 1347.7035052288481, 1358.2529608715167, 1367.2548461088732, 876.2464280718577, 1002.3634991780126, 1003.7942221844504, 1009.5204777730519, 1010.6765834932897, 6140.539459540552, 6163.209626079929, 6253.843653908689, 6375.936240637627, 6696.1629796275465, 481.24684868181185, 485.6867320578278, 1026.6047571684956, 1084.6745976207105, 1116.5875167912598, 4240.6676328020085, 4322.459692538433, 4343.153085148366, 4406.9559304407185, 4429.49060857999, 10970.616028439126, 11597.942010290064, 11720.70698232551, 11742.823857641972, 11743.295402275891, 11463.656090317303, 11523.942380288045, 11614.477348519336, 11617.88382116185, 11633.53465861373, 8365.1216622255, 8517.23344898962, 8545.188207120189, 8564.871526927102, 8566.357523185787, 6087.939120608914, 6159.72281247336, 6162.168107305636, 6240.625562466266, 6260.217472815898, 9670.0, 9984.301098923006, 10040.64857729976, 10167.084962353423, 10384.896151038392, 10244.743881402726, 10264.230182736474, 10318.690439286833, 10337.534810933375, 10372.58509659605, 7614.733484328243, 7690.423218258765, 7771.106322772727, 7900.2889739923685, 7950.920490795018, 9008.369414140947, 9080.409773364974, 9085.22775564058, 9098.909010909807, 9099.863502047343, 7226.277372262942, 7401.777946661608, 7662.8084297893, 7773.261540153676, 7934.722284720007, 7411.592362419903, 7433.776986690408, 7470.2903224193615, 7564.735234266775, 7794.922050779646, 7127.82180445493, 7319.048523691886, 7319.597422141834, 7319.8536029280185, 7325.4505912057875, 5142.6914385137015, 5349.117395629678, 5390.164524498709, 5398.163284690879, 5557.777688892561, 5073.239014147907, 5118.41138269089, 5126.948730512647, 5183.144781111075, 5355.571554275571], "value": 4780.277343733301, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.52805600215703, 339.8699324745222, 351.79244245894927, 355.78475022611303, 358.2476798722683, 5530.557555395569, 5530.917036244459, 5558.444155584444, 5563.972180139103, 5565.833025009256, 5212.556932660719, 5272.947270527294, 5302.575793936486, 5381.757820898059, 5512.91730624041, 4241.0, 4260.467441569804, 4262.552431994643, 4265.530791612936, 4268.701190916637, 4276.465441819772, 4285.250081235787, 4291.8497852575165, 4301.311790113583, 4307.461567304087, 4112.958870411302, 4216.936745948813, 4260.659147268211, 4268.97865510672, 4279.764612946286, 4234.0, 4241.406203131564, 4261.041265715205, 4263.488381394237, 4266.488021437416, 3766.4915236443003, 3782.3569993101237, 3786.9431958520645, 3793.9810300948593, 3801.3084177541004, 5076.720780357079, 5347.866303342447, 5348.015728282416, 5352.2506849041165, 5369.40936496985, 4858.514148585148, 4862.419713593061, 4862.902741945141, 4870.391201099863, 4883.389576302962, 5695.345035320908, 5704.828855134353, 5721.542276617861, 5735.397783232742, 5747.683877386742, 4002.479677641917, 4100.200460910124, 4122.969257685579, 4127.607877251687, 4127.876163715094, 5849.707514624251, 5882.23530940975, 5898.64608123514, 5907.6160049597065, 5914.4381283777975, 4198.265303571863, 4209.442506272638, 4215.852445164404, 4219.067747915231, 4221.556736542619, 4165.66674666026, 4225.218334608107, 4275.657947364203, 4278.272693642026, 4289.699721019499, 4847.95152048482, 4849.326982191138, 4861.0, 4864.562189402971, 4877.341558889575, 5733.283339582552, 5740.1102829061565, 5747.683877386784, 5770.307563092372, 5770.826875193751, 1413.3639862061907, 1456.565283196051, 1462.2980969134876, 1467.2663668165917, 1479.7188534178472, 921.9627918591584, 926.2312280807049, 934.7569631895756, 938.2025278513346, 940.6143481172824, 4880.243562247857, 4918.37693561124, 4921.557059864629, 4930.8767280818265, 4943.849425499919, 5142.357205349332, 5178.663386879841, 5179.4779549906425, 5200.97399513, 5206.921896171561, 4909.926351104737, 4914.385701787277, 4941.357623508921, 4960.379952505937, 5225.608079394061, 3102.534619807002, 3137.7449020392028, 3138.2311333723383, 3145.6225252969334, 3145.6382516010494, 6058.575899687068, 6059.879042335236, 6064.575479716465, 6098.75604975796, 6099.786507472217, 5769.307683077974, 6007.849803754853, 6012.819615411545, 6027.0, 6027.7287522061615, 6028.758849645965, 6060.363661815534, 6077.270727512727, 6082.361352058058, 6153.107799369066, 5718.571107167062, 5964.493018093511, 5999.70001499932, 6001.969990150022, 6029.4874935629205, 5879.323877754113, 5890.204822349099, 5901.29184497863, 5910.408959104056, 5914.645121292736, 6132.601380910227, 6142.249458904191, 6142.754289828536, 6162.845928851814, 6170.259568851767, 3988.700847436512, 4150.232207041707, 4181.226473102486, 4183.853565125206, 4187.225363307798, 5650.57620678459, 5821.27234095738, 5855.189509035602, 5869.559783016376, 5908.172855800105, 5723.254407405781, 5760.457318749023, 5770.6249093808765, 5777.786664800439, 5793.15999180125, 5599.27481372273, 5756.30924289088, 5786.884262314814, 5788.971055144697, 5806.303243610793, 5751.568632352507, 5756.1941328214925, 5769.480746732815, 5775.33583637887, 5793.217915581343, 5809.157672137601, 5817.342057513588, 5820.1560773688425, 5824.912626310694, 5837.445442682938, 5375.838724838261, 5608.38307786135, 5682.783714351323, 5697.344805347272, 5698.743556540048], "value": 4339.909078203383, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.6847839668142, 750.1373420566348, 751.9624018799059, 753.0774800868933, 841.490898006706, 13766.862331376684, 14431.206283654396, 14434.350454229558, 14544.636384090403, 14575.489857854976, 13644.454221831114, 13758.174509529435, 13966.930165349184, 14168.929155354208, 14171.574852754435, 523.7145755563208, 554.9694766787825, 841.5960339037266, 850.098895171119, 864.6109250837117, 855.2730179347567, 858.9527575983318, 866.5580553917516, 867.2498288980019, 867.6832955971088, 902.9683961061364, 904.4708845325492, 905.3436258712446, 905.5608030105394, 905.6105874473974, 903.029243563169, 903.8327909336793, 903.9502827344494, 904.1455824246058, 904.2946501728662, 671.9832004199885, 674.0731494195481, 674.3223060823841, 674.6390680985699, 674.7908148473989, 13673.794893076612, 13806.516771912935, 13814.516491922734, 13816.654583635389, 13824.447022119102, 14777.187254700988, 15105.39578416862, 15135.621609459742, 15299.15854627995, 15417.0, 12197.939010304981, 12297.508099676003, 12342.938285308606, 12380.690482737913, 12417.0, 3915.2968458720547, 3944.6055394460614, 3962.9009274768073, 4029.959700402988, 4034.5965403459713, 84228.57885710594, 88789.55605221997, 88899.0, 89215.0, 89368.5531572338, 11310.4910279036, 11454.656360309204, 11538.653840384803, 11620.941895290469, 11778.941105294418, 22825.543489130123, 23052.193173239193, 23108.422289442562, 23138.421539461648, 23188.18841340545, 7987.32107770846, 8691.304695624334, 8778.648854045767, 8835.558222089, 8858.15847494487, 4887.877803054952, 4920.114379411741, 4923.606111511071, 4941.901161976741, 5048.368953880765, 3437.071990562534, 3579.6599323064265, 3588.2644057968055, 3591.586967498719, 3591.9281614367565, 604.0998911621652, 613.0681364326289, 636.4431122767578, 643.350216281559, 644.9742010319628, 571.8884817460638, 597.1878245585999, 641.5605310362416, 650.3366566102549, 739.8421470398808, 9966.402015878926, 9990.600375984879, 9996.700098997042, 10021.248406369552, 10333.586656533806, 658.986820263592, 694.9305069493112, 711.661960568736, 713.6075158662715, 739.9408047356198, 4639.953600463952, 4820.156472617278, 4853.102176097434, 4862.975685121552, 4896.216605343128, 71348.0, 74108.62945685237, 74185.6290718543, 74470.0, 114963.0, 91008.0, 91937.08062919418, 110167.0, 110974.89025109807, 112494.43752781184, 54613.18080228879, 84514.0, 87786.12213877907, 89375.0, 93241.53379233196, 9801.11789938909, 9932.503374831374, 10114.645987390406, 10141.645042423479, 10254.641087562199, 52117.47882521126, 52867.47132528779, 53673.463265366845, 54638.45361546334, 54995.72502137464, 45840.31239531343, 47070.76464617655, 52049.739751301, 86199.0, 86940.5652971731, 12852.935735321264, 13022.934885325512, 13511.527096551574, 13712.314384280946, 13976.09155404936, 13303.06878518533, 14094.154350738989, 14314.642133946734, 14321.0, 15313.46402875894, 14607.19660418687, 14725.190114543802, 14812.333444994785, 14872.62818429548, 15293.464728734441, 14258.71482570322, 14301.427942882585, 14689.41242350294, 14691.045082069631, 15541.84458155404, 11841.407929603312, 13640.113392629448, 13743.793843092162, 14341.426342946166, 14882.032667876554, 10418.68743937683, 10439.791204176026, 10589.629362972259, 10640.84038739404, 11064.28082174656, 12120.575779847662, 12374.319412432402, 12401.193922395016, 12509.937450312691, 12568.811467827807], "value": 7586.521792598877, "unit": "score"}], "name": "dromaeo_css", "value": 7491.820402755621, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 110.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 120.0, 123.0, 161.0, 124.0, 121.0, 127.0, 125.0, 159.0, 118.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 163.0, 164.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 107.0, 74.0, 75.0, 76.0, 75.0, 109.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 112.0, 81.0, 81.0, 81.0, 100.0, 81.0, 81.0, 108.0], "value": 88.8, "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, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 98.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 47.0, 49.0, 50.0, 50.0, 49.0, 50.0, 60.0, 52.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 58.0, 59.0, 58.0, 58.0, 59.0, 61.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 73.0, 74.0, 73.0, 82.0, 73.0, 76.0, 73.0, 78.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 121.0, 125.0, 126.0, 121.0, 119.0, 120.0, 165.0, 140.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 156.0, 155.0, 159.0, 153.0, 159.0, 158.0, 157.0, 156.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 64.0, 63.0, 65.0, 63.0, 63.0, 63.0, 62.0, 60.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1465.8000000000002, "alertThreshold": 2.0}]} 07:25:58 INFO - Return code: 0 07:25:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:25:59 INFO - # TBPL SUCCESS # 07:25:59 INFO - Running post-action listener: _resource_record_post_action 07:25:59 INFO - [mozharness: 2016-11-24 15:25:59.027184Z] Finished run-tests step (success) 07:25:59 INFO - Running post-run listener: _resource_record_post_run 07:25:59 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318828544; Read time: 4; Write time: 278744 07:25:59 INFO - TinderboxPrint: CPU usage
12.9% 07:25:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 07:25:59 INFO - TinderboxPrint: I/O write bytes / time
318,828,544 / 278,744 07:25:59 INFO - TinderboxPrint: CPU idle
8,250.4 (87.1%) 07:25:59 INFO - TinderboxPrint: CPU user
1,181.8 (12.5%) 07:25:59 INFO - TinderboxPrint: Swap in / out
0 / 0 07:25:59 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 100536320; Read time: 0; Write time: 153324 07:25:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 218292224; Read time: 4; Write time: 125420 07:25:59 INFO - Running post-run listener: _upload_blobber_files 07:25:59 INFO - Blob upload gear active. 07:25:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:25:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:25:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:26:00 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:03 INFO - (blobuploader) - INFO - Done attempting. 07:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:26:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:04 INFO - (blobuploader) - INFO - Done attempting. 07:26:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:26:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:26:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:05 INFO - (blobuploader) - INFO - Done attempting. 07:26:05 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:05 INFO - Return code: 0 07:26:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79ac7608dc0fd1c573eb705629ce5a25824f66b97774589da3b4c0fe395772f0b7f7b5b198d6c7ef866bfe53f25ee883c07674311a9fdf0f5d1a24958216ba27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bf589369fedb2810078c3968ae04f08c48ee60b88e6f5169797925ffd18d82af8adee709d3dcc519c252bc611324ea999ceb09459de81a00a8d10218c81021f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f07de01b02f9be6dcfd4d16ee8e08309d24e185313de452db4bd88338c40541cebda856756d4d5e14ec0d928edf8e6193573ce9ccc003875f1aadc22b579df00"} 07:26:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:05 INFO - Contents: 07:26:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79ac7608dc0fd1c573eb705629ce5a25824f66b97774589da3b4c0fe395772f0b7f7b5b198d6c7ef866bfe53f25ee883c07674311a9fdf0f5d1a24958216ba27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bf589369fedb2810078c3968ae04f08c48ee60b88e6f5169797925ffd18d82af8adee709d3dcc519c252bc611324ea999ceb09459de81a00a8d10218c81021f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f07de01b02f9be6dcfd4d16ee8e08309d24e185313de452db4bd88338c40541cebda856756d4d5e14ec0d928edf8e6193573ce9ccc003875f1aadc22b579df00"} 07:26:05 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:05 INFO - Copying logs to upload dir... 07:26:05 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.350437 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-11-24 07:26:05.323248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 07:26:05.326409) ========= 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=745a4373a2a16df560f216e000000264-1479999932.723567-984304933 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79ac7608dc0fd1c573eb705629ce5a25824f66b97774589da3b4c0fe395772f0b7f7b5b198d6c7ef866bfe53f25ee883c07674311a9fdf0f5d1a24958216ba27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bf589369fedb2810078c3968ae04f08c48ee60b88e6f5169797925ffd18d82af8adee709d3dcc519c252bc611324ea999ceb09459de81a00a8d10218c81021f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f07de01b02f9be6dcfd4d16ee8e08309d24e185313de452db4bd88338c40541cebda856756d4d5e14ec0d928edf8e6193573ce9ccc003875f1aadc22b579df00"} build_url:https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011845 build_url: 'https://queue.taskcluster.net/v1/task/KU_ol6uESnaw6j8gXd0aPg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79ac7608dc0fd1c573eb705629ce5a25824f66b97774589da3b4c0fe395772f0b7f7b5b198d6c7ef866bfe53f25ee883c07674311a9fdf0f5d1a24958216ba27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bf589369fedb2810078c3968ae04f08c48ee60b88e6f5169797925ffd18d82af8adee709d3dcc519c252bc611324ea999ceb09459de81a00a8d10218c81021f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f07de01b02f9be6dcfd4d16ee8e08309d24e185313de452db4bd88338c40541cebda856756d4d5e14ec0d928edf8e6193573ce9ccc003875f1aadc22b579df00"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 07:26:05.351952) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:26:05.352298) ========= 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=745a4373a2a16df560f216e000000264-1479999932.723567-984304933 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:26:05.435754) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 07:26:05.436087) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 07:26:05.436381) ========= ========= Total master_lag: 0.17 =========