builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1474885180.74 results: success (0) buildid: 20160926003006 builduid: 5c3b420fe49641a1ac71e248365c368a revision: 74cc37d7da2c4f830787a2eb8af5a7543131237f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 03:19:40.735479) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 03:19:40.735885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 03:19:40.736169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 03:19:40.753215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 03:19:40.753523) ========= 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=32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 03:19:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-09-26 03:19:42 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.217231 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 03:19:41.116230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 03:19:41.116539) ========= 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=32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015916 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 03:19:41.150675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 03:19:41.151024) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 74cc37d7da2c4f830787a2eb8af5a7543131237f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 74cc37d7da2c4f830787a2eb8af5a7543131237f --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=32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 03:19:42,652 truncating revision to first 12 chars 2016-09-26 03:19:42,652 Setting DEBUG logging. 2016-09-26 03:19:42,652 attempt 1/10 2016-09-26 03:19:42,652 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/74cc37d7da2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 03:19:44,053 unpacking tar archive at: autoland-74cc37d7da2c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.776704 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 03:19:42.944953) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 03:19:42.945293) ========= script_repo_revision: 74cc37d7da2c4f830787a2eb8af5a7543131237f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 03:19:42.945685) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 03:19:42.945945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 03:19:42.956464) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-26 03:19:42.956725) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:19:44 INFO - MultiFileLogger online at 20160926 03:19:44 in /builds/slave/test 03:19:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 03:19:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:19:44 INFO - {'append_to_log': False, 03:19:44 INFO - 'base_work_dir': '/builds/slave/test', 03:19:44 INFO - 'blob_upload_branch': 'Autoland', 03:19:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:19:44 INFO - 'branch': 'Autoland', 03:19:44 INFO - 'buildbot_json_path': 'buildprops.json', 03:19:44 INFO - 'config_files': ('talos/linux_config.py',), 03:19:44 INFO - 'default_actions': ('clobber', 03:19:44 INFO - 'read-buildbot-config', 03:19:44 INFO - 'download-and-extract', 03:19:44 INFO - 'populate-webroot', 03:19:44 INFO - 'create-virtualenv', 03:19:44 INFO - 'install', 03:19:44 INFO - 'run-tests'), 03:19:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:19:44 INFO - 'download_minidump_stackwalk': True, 03:19:44 INFO - 'download_symbols': 'ondemand', 03:19:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:19:44 INFO - 'tooltool.py': '/tools/tooltool.py', 03:19:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:19:44 INFO - '/tools/misc-python/virtualenv.py')}, 03:19:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:19:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:19:44 INFO - 'installer_path': 'installer.exe', 03:19:44 INFO - 'log_level': 'info', 03:19:44 INFO - 'log_name': 'talos', 03:19:44 INFO - 'log_to_console': True, 03:19:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:19:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:19:44 INFO - 'opt_config_files': (), 03:19:44 INFO - 'pip_index': False, 03:19:44 INFO - 'sps_profile': False, 03:19:44 INFO - 'sps_profile_interval': 0, 03:19:44 INFO - 'suite': 'dromaeojs', 03:19:44 INFO - 'system_bits': '32', 03:19:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:19:44 INFO - 'title': 'talos-linux64-ix-008', 03:19:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:19:44 INFO - 'use_talos_json': True, 03:19:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:19:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:19:44 INFO - 'work_dir': 'build'} 03:19:44 INFO - [mozharness: 2016-09-26 10:19:44.552280Z] Running clobber step. 03:19:44 INFO - Running pre-action listener: _resource_record_pre_action 03:19:44 INFO - Running main action method: clobber 03:19:44 INFO - rmtree: /builds/slave/test/build 03:19:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:19:45 INFO - Running post-action listener: _resource_record_post_action 03:19:45 INFO - [mozharness: 2016-09-26 10:19:45.007511Z] Finished clobber step (success) 03:19:45 INFO - [mozharness: 2016-09-26 10:19:45.007611Z] Running read-buildbot-config step. 03:19:45 INFO - Running pre-action listener: _resource_record_pre_action 03:19:45 INFO - Running main action method: read_buildbot_config 03:19:45 INFO - Using buildbot properties: 03:19:45 INFO - { 03:19:45 INFO - "project": "", 03:19:45 INFO - "product": "firefox", 03:19:45 INFO - "script_repo_revision": "production", 03:19:45 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:19:45 INFO - "repository": "", 03:19:45 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 03:19:45 INFO - "buildid": "20160926003006", 03:19:45 INFO - "pgo_build": "True", 03:19:45 INFO - "basedir": "/builds/slave/test", 03:19:45 INFO - "buildnumber": 272, 03:19:45 INFO - "slavename": "talos-linux64-ix-008", 03:19:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:19:45 INFO - "platform": "ubuntu64_hw", 03:19:45 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 03:19:45 INFO - "branch": "autoland", 03:19:45 INFO - "repo_path": "integration/autoland", 03:19:45 INFO - "revision": "74cc37d7da2c4f830787a2eb8af5a7543131237f", 03:19:45 INFO - "stage_platform": "linux64-pgo", 03:19:45 INFO - "builduid": "5c3b420fe49641a1ac71e248365c368a", 03:19:45 INFO - "slavebuilddir": "test" 03:19:45 INFO - } 03:19:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:19:45 INFO - Running post-action listener: _resource_record_post_action 03:19:45 INFO - [mozharness: 2016-09-26 10:19:45.010065Z] Finished read-buildbot-config step (success) 03:19:45 INFO - [mozharness: 2016-09-26 10:19:45.010155Z] Running download-and-extract step. 03:19:45 INFO - Running pre-action listener: _resource_record_pre_action 03:19:45 INFO - Running main action method: download_and_extract 03:19:45 INFO - mkdir: /builds/slave/test/build/tests 03:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:45 INFO - trying https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:19:45 INFO - Downloading https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:19:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:19:45 INFO - Downloaded 1361 bytes. 03:19:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:19:45 INFO - Using the following test package requirements: 03:19:45 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:19:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:19:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:19:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:45 INFO - u'jsshell-linux-x86_64.zip'], 03:19:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:19:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:19:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:19:45 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:19:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:19:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:19:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:19:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:19:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:19:45 INFO - Fetch https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:19:46 INFO - Expected file size: 21948297 03:19:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:19:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:19:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:19:50 INFO - Fetch https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:19:51 INFO - Expected file size: 21948297 03:19:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:19:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:19:55 INFO - Fetch https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:19:56 INFO - Expected file size: 14414059 03:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:56 INFO - trying https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:19:56 INFO - Downloading https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:19:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:19:58 INFO - Downloaded 59698851 bytes. 03:19:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:19:58 INFO - mkdir: /builds/slave/test/properties 03:19:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:19:58 INFO - Writing to file /builds/slave/test/properties/build_url 03:19:58 INFO - Contents: 03:19:58 INFO - build_url:https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:19:58 INFO - Running post-action listener: _resource_record_post_action 03:19:58 INFO - Running post-action listener: set_extra_try_arguments 03:19:58 INFO - [mozharness: 2016-09-26 10:19:58.658292Z] Finished download-and-extract step (success) 03:19:58 INFO - [mozharness: 2016-09-26 10:19:58.658521Z] Running populate-webroot step. 03:19:58 INFO - Running pre-action listener: _resource_record_pre_action 03:19:58 INFO - Running main action method: populate_webroot 03:19:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:19:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:19:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:19:58 INFO - '--tppagecycles', 03:19:58 INFO - '7'], 03:19:58 INFO - 'tests': ['tsvgm']}}, 03:19:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:19:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:19:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:19:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:19:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:19:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:19:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:58 INFO - 'talos_options': ['--disable-e10s'], 03:19:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:19:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:19:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:58 INFO - 'talos_options': ['--disable-e10s'], 03:19:58 INFO - 'tests': ['damp', 'tps']}, 03:19:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:58 INFO - 'tests': ['damp', 'tps']}, 03:19:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:19:58 INFO - 'tests': ['dromaeo_dom']}, 03:19:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:19:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:19:58 INFO - 'tests': ['basic_compositor_video']}, 03:19:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:19:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:19:58 INFO - 'tests': ['a11yr', 03:19:58 INFO - 'ts_paint', 03:19:58 INFO - 'tpaint', 03:19:58 INFO - 'sessionrestore', 03:19:58 INFO - 'sessionrestore_no_auto_restore', 03:19:58 INFO - 'tabpaint']}, 03:19:58 INFO - 'other-e10s': {'tests': ['a11yr', 03:19:58 INFO - 'ts_paint', 03:19:58 INFO - 'tpaint', 03:19:58 INFO - 'sessionrestore', 03:19:58 INFO - 'sessionrestore_no_auto_restore', 03:19:58 INFO - 'tabpaint']}, 03:19:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:19:58 INFO - 'ts_paint', 03:19:58 INFO - 'tpaint', 03:19:58 INFO - 'sessionrestore', 03:19:58 INFO - 'sessionrestore_no_auto_restore', 03:19:58 INFO - 'tabpaint']}, 03:19:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:19:58 INFO - 'ts_paint', 03:19:58 INFO - 'tpaint', 03:19:58 INFO - 'sessionrestore', 03:19:58 INFO - 'sessionrestore_no_auto_restore', 03:19:58 INFO - 'tabpaint']}, 03:19:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:19:58 INFO - 'tests': ['a11yr', 03:19:58 INFO - 'ts_paint', 03:19:58 INFO - 'tpaint', 03:19:58 INFO - 'sessionrestore', 03:19:58 INFO - 'sessionrestore_no_auto_restore', 03:19:58 INFO - 'tabpaint']}, 03:19:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:19:58 INFO - 'tests': ['a11yr', 03:19:58 INFO - 'ts_paint', 03:19:58 INFO - 'tpaint', 03:19:58 INFO - 'sessionrestore', 03:19:58 INFO - 'sessionrestore_no_auto_restore', 03:19:58 INFO - 'tabpaint']}, 03:19:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:19:58 INFO - 'tests': ['tsvgx', 03:19:58 INFO - 'tsvgr_opacity', 03:19:58 INFO - 'tart', 03:19:58 INFO - 'tscrollx', 03:19:58 INFO - 'cart']}, 03:19:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:19:58 INFO - 'tsvgr_opacity', 03:19:58 INFO - 'tart', 03:19:58 INFO - 'tscrollx', 03:19:58 INFO - 'cart']}, 03:19:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:58 INFO - 'talos_options': ['--disable-e10s'], 03:19:58 INFO - 'tests': ['tp5o']}, 03:19:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:58 INFO - 'tests': ['tp5o']}, 03:19:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:58 INFO - 'talos_options': ['--disable-e10s', 03:19:58 INFO - '--xperf_path', 03:19:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:19:58 INFO - 'tests': ['tp5n']}, 03:19:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:58 INFO - 'talos_options': ['--xperf_path', 03:19:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:19:58 INFO - 'tests': ['tp5n']}}, 03:19:58 INFO - 'talos.zip': {'path': '', 03:19:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:19:58 INFO - Running post-action listener: _resource_record_post_action 03:19:58 INFO - [mozharness: 2016-09-26 10:19:58.680993Z] Finished populate-webroot step (success) 03:19:58 INFO - [mozharness: 2016-09-26 10:19:58.681083Z] Running create-virtualenv step. 03:19:58 INFO - Running pre-action listener: _resource_record_pre_action 03:19:58 INFO - Running main action method: create_virtualenv 03:19:58 INFO - Creating virtualenv /builds/slave/test/build/venv 03:19:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:19:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:19:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:19:58 INFO - Using real prefix '/usr' 03:19:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:19:59 INFO - Installing distribute.............................................................................................................................................................................................done. 03:20:01 INFO - Installing pip.................done. 03:20:01 INFO - Return code: 0 03:20:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:20:01 INFO - Reading from file tmpfile_stdout 03:20:01 INFO - Output received: 03:20:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:20:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:01 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 0x7fcf8db88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2997930>, '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 0x2998830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2998cc0>, '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': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:20:01 INFO - Using env: {'DISPLAY': ':0', 03:20:01 INFO - 'HOME': '/home/cltbld', 03:20:01 INFO - 'LANG': 'en_US.UTF-8', 03:20:01 INFO - 'LANGUAGE': 'en_US:en', 03:20:01 INFO - 'LOGNAME': 'cltbld', 03:20:01 INFO - 'MAIL': '/var/mail/cltbld', 03:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:01 INFO - 'MOZ_NO_REMOTE': '1', 03:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:01 INFO - 'NO_EM_RESTART': '1', 03:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:01 INFO - 'PWD': '/builds/slave/test', 03:20:01 INFO - 'SHELL': '/bin/bash', 03:20:01 INFO - 'SHLVL': '1', 03:20:01 INFO - 'TERM': 'linux', 03:20:01 INFO - 'TMOUT': '86400', 03:20:01 INFO - 'USER': 'cltbld', 03:20:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 03:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:01 INFO - '_': '/tools/buildbot/bin/python'} 03:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:20:01 INFO - Cleaning up... 03:20:01 INFO - Return code: 0 03:20:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:01 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 0x7fcf8db88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2997930>, '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 0x2998830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2998cc0>, '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': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:20:01 INFO - Using env: {'DISPLAY': ':0', 03:20:01 INFO - 'HOME': '/home/cltbld', 03:20:01 INFO - 'LANG': 'en_US.UTF-8', 03:20:01 INFO - 'LANGUAGE': 'en_US:en', 03:20:01 INFO - 'LOGNAME': 'cltbld', 03:20:01 INFO - 'MAIL': '/var/mail/cltbld', 03:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:01 INFO - 'MOZ_NO_REMOTE': '1', 03:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:01 INFO - 'NO_EM_RESTART': '1', 03:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:01 INFO - 'PWD': '/builds/slave/test', 03:20:01 INFO - 'SHELL': '/bin/bash', 03:20:01 INFO - 'SHLVL': '1', 03:20:01 INFO - 'TERM': 'linux', 03:20:01 INFO - 'TMOUT': '86400', 03:20:01 INFO - 'USER': 'cltbld', 03:20:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 03:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:01 INFO - '_': '/tools/buildbot/bin/python'} 03:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:01 INFO - Downloading/unpacking psutil>=3.1.1 03:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:20:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:03 INFO - Installing collected packages: psutil 03:20:03 INFO - Running setup.py install for psutil 03:20:03 INFO - building 'psutil._psutil_linux' extension 03:20:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:20:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:20:04 INFO - building 'psutil._psutil_posix' extension 03:20:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:20:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:20:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:04 INFO - Successfully installed psutil 03:20:04 INFO - Cleaning up... 03:20:04 INFO - Return code: 0 03:20:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:04 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 0x7fcf8db88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2997930>, '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 0x2998830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2998cc0>, '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': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:20:04 INFO - Using env: {'DISPLAY': ':0', 03:20:04 INFO - 'HOME': '/home/cltbld', 03:20:04 INFO - 'LANG': 'en_US.UTF-8', 03:20:04 INFO - 'LANGUAGE': 'en_US:en', 03:20:04 INFO - 'LOGNAME': 'cltbld', 03:20:04 INFO - 'MAIL': '/var/mail/cltbld', 03:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:04 INFO - 'MOZ_NO_REMOTE': '1', 03:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:04 INFO - 'NO_EM_RESTART': '1', 03:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:04 INFO - 'PWD': '/builds/slave/test', 03:20:04 INFO - 'SHELL': '/bin/bash', 03:20:04 INFO - 'SHLVL': '1', 03:20:04 INFO - 'TERM': 'linux', 03:20:04 INFO - 'TMOUT': '86400', 03:20:04 INFO - 'USER': 'cltbld', 03:20:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 03:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:04 INFO - '_': '/tools/buildbot/bin/python'} 03:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:20:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:20:06 INFO - Installing collected packages: mozsystemmonitor 03:20:06 INFO - Running setup.py install for mozsystemmonitor 03:20:06 INFO - Successfully installed mozsystemmonitor 03:20:06 INFO - Cleaning up... 03:20:06 INFO - Return code: 0 03:20:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:06 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 0x7fcf8db88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2997930>, '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 0x2998830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2998cc0>, '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': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:20:06 INFO - Using env: {'DISPLAY': ':0', 03:20:06 INFO - 'HOME': '/home/cltbld', 03:20:06 INFO - 'LANG': 'en_US.UTF-8', 03:20:06 INFO - 'LANGUAGE': 'en_US:en', 03:20:06 INFO - 'LOGNAME': 'cltbld', 03:20:06 INFO - 'MAIL': '/var/mail/cltbld', 03:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:06 INFO - 'MOZ_NO_REMOTE': '1', 03:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:06 INFO - 'NO_EM_RESTART': '1', 03:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:06 INFO - 'PWD': '/builds/slave/test', 03:20:06 INFO - 'SHELL': '/bin/bash', 03:20:06 INFO - 'SHLVL': '1', 03:20:06 INFO - 'TERM': 'linux', 03:20:06 INFO - 'TMOUT': '86400', 03:20:06 INFO - 'USER': 'cltbld', 03:20:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 03:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:06 INFO - '_': '/tools/buildbot/bin/python'} 03:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:06 INFO - Downloading/unpacking jsonschema==2.5.1 03:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:20:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:20: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 03:20: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 03:20: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 03:20: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 03:20: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 03:20: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 03:20:09 INFO - Downloading functools32-3.2.3-2.tar.gz 03:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:20:09 INFO - warning: no files found matching '*.txt' 03:20:09 INFO - no previously-included directories found matching 'build' 03:20:09 INFO - no previously-included directories found matching 'dist' 03:20:09 INFO - no previously-included directories found matching '.git*' 03:20:09 INFO - Installing collected packages: jsonschema, functools32 03:20:09 INFO - Running setup.py install for functools32 03:20:09 INFO - warning: no files found matching '*.txt' 03:20:09 INFO - no previously-included directories found matching 'build' 03:20:09 INFO - no previously-included directories found matching 'dist' 03:20:09 INFO - no previously-included directories found matching '.git*' 03:20:09 INFO - Successfully installed jsonschema functools32 03:20:09 INFO - Cleaning up... 03:20:09 INFO - Return code: 0 03:20:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:09 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 0x7fcf8db88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2997930>, '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 0x2998830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2998cc0>, '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': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:20:09 INFO - Using env: {'DISPLAY': ':0', 03:20:09 INFO - 'HOME': '/home/cltbld', 03:20:09 INFO - 'LANG': 'en_US.UTF-8', 03:20:09 INFO - 'LANGUAGE': 'en_US:en', 03:20:09 INFO - 'LOGNAME': 'cltbld', 03:20:09 INFO - 'MAIL': '/var/mail/cltbld', 03:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:09 INFO - 'MOZ_NO_REMOTE': '1', 03:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:09 INFO - 'NO_EM_RESTART': '1', 03:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:09 INFO - 'PWD': '/builds/slave/test', 03:20:09 INFO - 'SHELL': '/bin/bash', 03:20:09 INFO - 'SHLVL': '1', 03:20:09 INFO - 'TERM': 'linux', 03:20:09 INFO - 'TMOUT': '86400', 03:20:09 INFO - 'USER': 'cltbld', 03:20:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 03:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:09 INFO - '_': '/tools/buildbot/bin/python'} 03:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:20:09 INFO - Cleaning up... 03:20:09 INFO - Return code: 0 03:20:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:09 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 0x7fcf8db88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2997930>, '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 0x2998830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2998cc0>, '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': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:20:09 INFO - Using env: {'DISPLAY': ':0', 03:20:09 INFO - 'HOME': '/home/cltbld', 03:20:09 INFO - 'LANG': 'en_US.UTF-8', 03:20:09 INFO - 'LANGUAGE': 'en_US:en', 03:20:09 INFO - 'LOGNAME': 'cltbld', 03:20:09 INFO - 'MAIL': '/var/mail/cltbld', 03:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:09 INFO - 'MOZ_NO_REMOTE': '1', 03:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:09 INFO - 'NO_EM_RESTART': '1', 03:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:09 INFO - 'PWD': '/builds/slave/test', 03:20:09 INFO - 'SHELL': '/bin/bash', 03:20:09 INFO - 'SHLVL': '1', 03:20:09 INFO - 'TERM': 'linux', 03:20:09 INFO - 'TMOUT': '86400', 03:20:09 INFO - 'USER': 'cltbld', 03:20:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 03:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:09 INFO - '_': '/tools/buildbot/bin/python'} 03:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:09 INFO - Downloading/unpacking blobuploader==1.2.4 03:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:11 INFO - Downloading blobuploader-1.2.4.tar.gz 03:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:20:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:20:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:12 INFO - Downloading docopt-0.6.1.tar.gz 03:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:20:12 INFO - Installing collected packages: blobuploader, requests, docopt 03:20:12 INFO - Running setup.py install for blobuploader 03:20:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:20:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:20:12 INFO - Running setup.py install for requests 03:20:12 INFO - Running setup.py install for docopt 03:20:12 INFO - Successfully installed blobuploader requests docopt 03:20:12 INFO - Cleaning up... 03:20:13 INFO - Return code: 0 03:20:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:13 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 0x7fcf8db88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2997930>, '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 0x2998830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2998cc0>, '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': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:13 INFO - Using env: {'DISPLAY': ':0', 03:20:13 INFO - 'HOME': '/home/cltbld', 03:20:13 INFO - 'LANG': 'en_US.UTF-8', 03:20:13 INFO - 'LANGUAGE': 'en_US:en', 03:20:13 INFO - 'LOGNAME': 'cltbld', 03:20:13 INFO - 'MAIL': '/var/mail/cltbld', 03:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:13 INFO - 'MOZ_NO_REMOTE': '1', 03:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:13 INFO - 'NO_EM_RESTART': '1', 03:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:13 INFO - 'PWD': '/builds/slave/test', 03:20:13 INFO - 'SHELL': '/bin/bash', 03:20:13 INFO - 'SHLVL': '1', 03:20:13 INFO - 'TERM': 'linux', 03:20:13 INFO - 'TMOUT': '86400', 03:20:13 INFO - 'USER': 'cltbld', 03:20:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 03:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:13 INFO - '_': '/tools/buildbot/bin/python'} 03:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:13 INFO - Running setup.py (path:/tmp/pip-PquO_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:13 INFO - Running setup.py (path:/tmp/pip-wE3wsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:13 INFO - Running setup.py (path:/tmp/pip-6igAXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:13 INFO - Running setup.py (path:/tmp/pip-tU9DXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:13 INFO - Running setup.py (path:/tmp/pip-8_Sbhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:13 INFO - Running setup.py (path:/tmp/pip-3qu9GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:13 INFO - Running setup.py (path:/tmp/pip-5_Ttw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:13 INFO - Running setup.py (path:/tmp/pip-g2e0Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:13 INFO - Running setup.py (path:/tmp/pip-76sZ_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:13 INFO - Running setup.py (path:/tmp/pip-6qTLuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:13 INFO - Running setup.py (path:/tmp/pip-LR_mBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:14 INFO - Running setup.py (path:/tmp/pip-1oBpl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:14 INFO - Running setup.py (path:/tmp/pip-RwhIph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:14 INFO - Running setup.py (path:/tmp/pip-nRTvco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:14 INFO - Running setup.py (path:/tmp/pip-gBCVfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:14 INFO - Running setup.py (path:/tmp/pip-ydaWeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:14 INFO - Running setup.py (path:/tmp/pip-rVJReA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:20:14 INFO - Running setup.py install for manifestparser 03:20:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:20:14 INFO - Running setup.py install for mozcrash 03:20:14 INFO - Running setup.py install for mozdebug 03:20:14 INFO - Running setup.py install for mozdevice 03:20:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:20:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:20:14 INFO - Running setup.py install for mozfile 03:20:14 INFO - Running setup.py install for mozhttpd 03:20:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:20:15 INFO - Running setup.py install for mozinfo 03:20:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:20:15 INFO - Running setup.py install for mozInstall 03:20:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:20:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:20:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:20:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:20:15 INFO - Running setup.py install for mozleak 03:20:15 INFO - Running setup.py install for mozlog 03:20:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:20:15 INFO - Running setup.py install for moznetwork 03:20:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:20:15 INFO - Running setup.py install for mozprocess 03:20:15 INFO - Running setup.py install for mozprofile 03:20:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:20:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:20:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:20:15 INFO - Running setup.py install for mozrunner 03:20:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:20:15 INFO - Running setup.py install for mozscreenshot 03:20:16 INFO - Running setup.py install for moztest 03:20:16 INFO - Running setup.py install for mozversion 03:20:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:20:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:20:16 INFO - Cleaning up... 03:20:16 INFO - Return code: 0 03:20:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:16 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 0x7fcf8db88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2997930>, '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 0x2998830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2998cc0>, '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': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:16 INFO - Using env: {'DISPLAY': ':0', 03:20:16 INFO - 'HOME': '/home/cltbld', 03:20:16 INFO - 'LANG': 'en_US.UTF-8', 03:20:16 INFO - 'LANGUAGE': 'en_US:en', 03:20:16 INFO - 'LOGNAME': 'cltbld', 03:20:16 INFO - 'MAIL': '/var/mail/cltbld', 03:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:16 INFO - 'MOZ_NO_REMOTE': '1', 03:20:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:16 INFO - 'NO_EM_RESTART': '1', 03:20:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:16 INFO - 'PWD': '/builds/slave/test', 03:20:16 INFO - 'SHELL': '/bin/bash', 03:20:16 INFO - 'SHLVL': '1', 03:20:16 INFO - 'TERM': 'linux', 03:20:16 INFO - 'TMOUT': '86400', 03:20:16 INFO - 'USER': 'cltbld', 03:20:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 03:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:16 INFO - '_': '/tools/buildbot/bin/python'} 03:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:16 INFO - Running setup.py (path:/tmp/pip-xiTft9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:16 INFO - Running setup.py (path:/tmp/pip-PSRpd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:16 INFO - Running setup.py (path:/tmp/pip-W7XSiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:16 INFO - Running setup.py (path:/tmp/pip-GWfr1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:16 INFO - Running setup.py (path:/tmp/pip-4OtVJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:16 INFO - Running setup.py (path:/tmp/pip-CS_KCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:16 INFO - Running setup.py (path:/tmp/pip-0yevvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:16 INFO - Running setup.py (path:/tmp/pip-bX7Fy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:17 INFO - Running setup.py (path:/tmp/pip-f_pjjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:17 INFO - Running setup.py (path:/tmp/pip-96oqoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:17 INFO - Running setup.py (path:/tmp/pip-23FN8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:17 INFO - Running setup.py (path:/tmp/pip-EKF337-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:17 INFO - Running setup.py (path:/tmp/pip-vl6PZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:17 INFO - Running setup.py (path:/tmp/pip-wPwKQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:17 INFO - Running setup.py (path:/tmp/pip-DtiEy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:17 INFO - Running setup.py (path:/tmp/pip-mUjPv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:17 INFO - Running setup.py (path:/tmp/pip-NlgxWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:20:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:19 INFO - Downloading blessings-1.6.tar.gz 03:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:20:19 INFO - Installing collected packages: blessings 03:20:19 INFO - Running setup.py install for blessings 03:20:19 INFO - Successfully installed blessings 03:20:19 INFO - Cleaning up... 03:20:19 INFO - Return code: 0 03:20:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:20:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:20 INFO - Reading from file tmpfile_stdout 03:20:20 INFO - Current package versions: 03:20:20 INFO - argparse == 1.2.1 03:20:20 INFO - blessings == 1.6 03:20:20 INFO - blobuploader == 1.2.4 03:20:20 INFO - docopt == 0.6.1 03:20:20 INFO - functools32 == 3.2.3-2 03:20:20 INFO - jsonschema == 2.5.1 03:20:20 INFO - manifestparser == 1.1 03:20:20 INFO - mozInstall == 1.12 03:20:20 INFO - mozcrash == 0.17 03:20:20 INFO - mozdebug == 0.1 03:20:20 INFO - mozdevice == 0.48 03:20:20 INFO - mozfile == 1.2 03:20:20 INFO - mozhttpd == 0.7 03:20:20 INFO - mozinfo == 0.9 03:20:20 INFO - mozleak == 0.1 03:20:20 INFO - mozlog == 3.4 03:20:20 INFO - moznetwork == 0.27 03:20:20 INFO - mozprocess == 0.23 03:20:20 INFO - mozprofile == 0.28 03:20:20 INFO - mozrunner == 6.12 03:20:20 INFO - mozscreenshot == 0.1 03:20:20 INFO - mozsystemmonitor == 0.3 03:20:20 INFO - moztest == 0.7 03:20:20 INFO - mozversion == 1.4 03:20:20 INFO - psutil == 3.1.1 03:20:20 INFO - requests == 1.2.3 03:20:20 INFO - wsgiref == 0.1.2 03:20:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:20 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 0x7fcf8db88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2997930>, '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 0x2998830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2998cc0>, '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': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:20 INFO - Using env: {'DISPLAY': ':0', 03:20:20 INFO - 'HOME': '/home/cltbld', 03:20:20 INFO - 'LANG': 'en_US.UTF-8', 03:20:20 INFO - 'LANGUAGE': 'en_US:en', 03:20:20 INFO - 'LOGNAME': 'cltbld', 03:20:20 INFO - 'MAIL': '/var/mail/cltbld', 03:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:20 INFO - 'MOZ_NO_REMOTE': '1', 03:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:20 INFO - 'NO_EM_RESTART': '1', 03:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:20 INFO - 'PWD': '/builds/slave/test', 03:20:20 INFO - 'SHELL': '/bin/bash', 03:20:20 INFO - 'SHLVL': '1', 03:20:20 INFO - 'TERM': 'linux', 03:20:20 INFO - 'TMOUT': '86400', 03:20:20 INFO - 'USER': 'cltbld', 03:20:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 03:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:20 INFO - '_': '/tools/buildbot/bin/python'} 03:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:20:20 INFO - Cleaning up... 03:20:20 INFO - Return code: 0 03:20:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf8db88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2997930>, '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 0x2998830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2998cc0>, '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': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:20:20 INFO - Using env: {'DISPLAY': ':0', 03:20:20 INFO - 'HOME': '/home/cltbld', 03:20:20 INFO - 'LANG': 'en_US.UTF-8', 03:20:20 INFO - 'LANGUAGE': 'en_US:en', 03:20:20 INFO - 'LOGNAME': 'cltbld', 03:20:20 INFO - 'MAIL': '/var/mail/cltbld', 03:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:20 INFO - 'MOZ_NO_REMOTE': '1', 03:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:20 INFO - 'NO_EM_RESTART': '1', 03:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:20 INFO - 'PWD': '/builds/slave/test', 03:20:20 INFO - 'SHELL': '/bin/bash', 03:20:20 INFO - 'SHLVL': '1', 03:20:20 INFO - 'TERM': 'linux', 03:20:20 INFO - 'TMOUT': '86400', 03:20:20 INFO - 'USER': 'cltbld', 03:20:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 03:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:20 INFO - '_': '/tools/buildbot/bin/python'} 03:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:20:20 INFO - Cleaning up... 03:20:20 INFO - Return code: 0 03:20:20 INFO - Running post-action listener: _resource_record_post_action 03:20:20 INFO - Running post-action listener: _start_resource_monitoring 03:20:20 INFO - Starting resource monitoring. 03:20:20 INFO - [mozharness: 2016-09-26 10:20:20.580729Z] Finished create-virtualenv step (success) 03:20:20 INFO - [mozharness: 2016-09-26 10:20:20.581254Z] Running install step. 03:20:20 INFO - Running pre-action listener: _resource_record_pre_action 03:20:20 INFO - Running main action method: install 03:20:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:20 INFO - Reading from file tmpfile_stdout 03:20:20 INFO - Detecting whether we're running mozinstall >=1.0... 03:20:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:20:20 INFO - Reading from file tmpfile_stdout 03:20:20 INFO - Output received: 03:20:20 INFO - Usage: mozinstall [options] installer 03:20:20 INFO - Options: 03:20:20 INFO - -h, --help show this help message and exit 03:20:20 INFO - -d DEST, --destination=DEST 03:20:20 INFO - Directory to install application into. [default: 03:20:20 INFO - "/builds/slave/test"] 03:20:20 INFO - --app=APP Application being installed. [default: firefox] 03:20:20 INFO - mkdir: /builds/slave/test/build/application 03:20:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:20:37 INFO - Reading from file tmpfile_stdout 03:20:37 INFO - Output received: 03:20:37 INFO - /builds/slave/test/build/application/firefox/firefox 03:20:37 INFO - Running post-action listener: _resource_record_post_action 03:20:37 INFO - [mozharness: 2016-09-26 10:20:37.870834Z] Finished install step (success) 03:20:37 INFO - [mozharness: 2016-09-26 10:20:37.871168Z] Running run-tests step. 03:20:37 INFO - Running pre-action listener: _resource_record_pre_action 03:20:37 INFO - Running main action method: run_tests 03:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:20:37 INFO - Python 2.7.3 03:20:37 INFO - Return code: 0 03:20:37 INFO - grabbing minidump binary from tooltool 03:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:37 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 0x2997930>, '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 0x2998830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2998cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:20:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:20:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:20:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:20:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:20:37 INFO - Return code: 0 03:20:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:20:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:20:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:20:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:20:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:20:37 INFO - Using env: {'DISPLAY': ':0', 03:20:37 INFO - 'HOME': '/home/cltbld', 03:20:37 INFO - 'LANG': 'en_US.UTF-8', 03:20:37 INFO - 'LANGUAGE': 'en_US:en', 03:20:37 INFO - 'LOGNAME': 'cltbld', 03:20:37 INFO - 'MAIL': '/var/mail/cltbld', 03:20:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:20:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:37 INFO - 'MOZ_NO_REMOTE': '1', 03:20:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:37 INFO - 'NO_EM_RESTART': '1', 03:20:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:37 INFO - 'PWD': '/builds/slave/test', 03:20:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:20:37 INFO - 'SHELL': '/bin/bash', 03:20:37 INFO - 'SHLVL': '1', 03:20:37 INFO - 'TERM': 'linux', 03:20:37 INFO - 'TMOUT': '86400', 03:20:37 INFO - 'USER': 'cltbld', 03:20:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276', 03:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:37 INFO - '_': '/tools/buildbot/bin/python'} 03:20:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:20:38 INFO - mozversion application_buildid: 20160926003006 03:20:38 INFO - mozversion application_changeset: 74cc37d7da2c4f830787a2eb8af5a7543131237f 03:20:38 INFO - mozversion application_display_name: Nightly 03:20:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:20:38 INFO - mozversion application_name: Firefox 03:20:38 INFO - mozversion application_remotingname: firefox 03:20:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:20:38 INFO - mozversion application_vendor: Mozilla 03:20:38 INFO - mozversion application_version: 52.0a1 03:20:38 INFO - mozversion platform_buildid: 20160926003006 03:20:38 INFO - mozversion platform_changeset: 74cc37d7da2c4f830787a2eb8af5a7543131237f 03:20:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:20:38 INFO - mozversion platform_version: 52.0a1 03:20:38 INFO - using testdate: 1474885238 03:20:38 INFO - actual date: 1474885238 03:20:38 INFO - starting webserver on 'localhost:52409' 03:20:38 INFO - SUITE-START | Running 2 tests 03:20:38 INFO - TEST-START | dromaeo_css 03:20:38 INFO - operating with platform_type : linux_ 03:20:38 INFO - Initialising browser for dromaeo_css test... 03:20:38 INFO - TEST-INFO | started process 15450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGOzMzn/profile http://localhost:52409/getInfo.html) 03:20:42 INFO - PROCESS | 15450 | __metrics Screen width/height:1600/1200 03:20:42 INFO - PROCESS | 15450 | colorDepth:24 03:20:42 INFO - PROCESS | 15450 | Browser inner width/height: 1024/697 03:20:42 INFO - PROCESS | 15450 | __metrics 03:20:42 INFO - PROCESS | 15450 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:20:42 INFO - PROCESS | 15450 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:20:43 INFO - PROCESS | 15450 | console.error: PushService: 03:20:43 INFO - PROCESS | 15450 | stateChangeProcessEnqueue: Error transitioning state 03:20:43 INFO - PROCESS | 15450 | UnknownError 03:20:44 INFO - TEST-INFO | 15450: exit 0 03:20:44 INFO - Browser initialized. 03:20:44 INFO - Running cycle 1/1 for dromaeo_css test... 03:20:44 INFO - TEST-INFO | started process 15530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGOzMzn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:56 INFO - PROCESS | 15530 | RSS: Main: 173916160 03:20:56 INFO - PROCESS | 15530 | 03:21:47 INFO - PROCESS | 15530 | 1474885307899 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:23:56 INFO - PROCESS | 15530 | Cycle 1(1): loaded http://localhost:52409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52409/tests/dromaeo/cssquery-ext.html) 03:23:58 INFO - PROCESS | 15530 | RSS: Main: 305393664 03:23:58 INFO - PROCESS | 15530 | 03:27:00 INFO - PROCESS | 15530 | Cycle 1(1): loaded http://localhost:52409/tests/dromaeo/cssquery-ext.html (next: http://localhost:52409/tests/dromaeo/cssquery-jquery.html) 03:27:01 INFO - PROCESS | 15530 | RSS: Main: 275832832 03:27:01 INFO - PROCESS | 15530 | 03:30:03 INFO - PROCESS | 15530 | Cycle 1(1): loaded http://localhost:52409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52409/tests/dromaeo/cssquery-mootools.html) 03:30:03 INFO - PROCESS | 15530 | RSS: Main: 245706752 03:30:03 INFO - PROCESS | 15530 | 03:33:05 INFO - PROCESS | 15530 | Cycle 1(1): loaded http://localhost:52409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52409/tests/dromaeo/cssquery-prototype.html) 03:33:06 INFO - PROCESS | 15530 | RSS: Main: 216014848 03:33:06 INFO - PROCESS | 15530 | 03:36:09 INFO - PROCESS | 15530 | Cycle 1(1): loaded http://localhost:52409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52409/tests/dromaeo/cssquery-yui.html) 03:36:09 INFO - PROCESS | 15530 | RSS: Main: 217944064 03:36:09 INFO - PROCESS | 15530 | 03:39:12 INFO - PROCESS | 15530 | Cycle 1(1): loaded http://localhost:52409/tests/dromaeo/cssquery-yui.html (next: http://localhost:52409/tests/dromaeo/cssquery-dojo.html) 03:39:12 INFO - PROCESS | 15530 | RSS: Main: 309641216 03:39:12 INFO - PROCESS | 15530 | 03:39:12 INFO - PROCESS | 15530 | __start_tp_report 03:39:12 INFO - PROCESS | 15530 | _x_x_mozilla_page_load 03:39:12 INFO - PROCESS | 15530 | _x_x_mozilla_page_load_details 03:39:12 INFO - PROCESS | 15530 | |i|pagename|runs| 03:39:12 INFO - PROCESS | 15530 | |0;dojo.html;2975.7321841034304;3022.07826612883;3022.7128422799833;3051.1456792098193;3063.096386565964;5164.225366195073;5233.424323324441;5237.685738855666;5352.946470535294;5360.329958755151;5229.163333866582;5278.9208161877505;5304.045271851065;5327.813526526573;5380.461953804617;4750.216214324632;4761.119192949315;4805.495422980572;4821.421429428465;4848.272759086148;4821.228603423453;4851.684640498374;4928.1129396708575;4937.975310123462;4944.110060189165;4873.731944743037;4877.146499362598;4920.655554111214;4944.456109827934;4970.70175789452;4746.4541577718655;4793.832215872462;4802.4957379475;4833.830815921426;4853.514648535153;4692.319613656035;4694.436667599875;4706.435227772655;4709.364235828188;4768.785404656799;5256.658317209369;5264.894702105937;5268.130758424855;5280.920786188171;5306.177542480922;5489.64317319373;5523.558115350803;5556.333240011184;5612.326520817487;5614.6631202128;5627.493525582717;5655.915161272585;5662.773489060474;5670.659760414388;5717.399673034354;5272.156454967264;5279.70961597112;5286.471352864722;5286.5770738341225;5349.117395629755;5659.434056594308;5734.655920644775;5762.366139724711;5791.102379131242;5798.82603521895;5569.582281328917;5574.637648552831;5585.720713964367;5642.069058605284;5645.266115404971;5657.773689052392;5663.037283661787;5668.433156684298;5669.262995810518;5673.347565030074;5466.1527463243265;5514.751836167382;5601.271834661468;5647.745851436695;5659.6321239119325;5535.197396377503;5542.722863856791;5561.888762224733;5626.043572592669;5640.210370548127;4333.826646934087;4335.761533115646;4343.305071188594;4351.978240108842;4391.451068616423;3870.7871067091583;3874.612538746103;3900.629440203233;3904.1606054698377;3909.58949310324;5129.9743501283;5181.35233095863;5197.350331208599;5275.894482110336;5318.308619879391;5634.577406694432;5643.887122257532;5648.15277708347;5699.629524080921;5717.742701578439;5311.628186026941;5314.70769107695;5318.601104917069;5319.627626066215;5323.494268044529;4785.473597904228;4828;4865.464798872121;4919.803207871645;4926.162552366106;5729.9713501432225;5885.264341957255;5885.352611212763;5890.705464726747;5894.38108998549;5614.24207731951;5645.294338207724;5649.265595472562;5651.350094739158;5656.88686226265;5809.9419005809405;5818.418158184148;5822.621529600562;5824.068149096124;5828.417158284307;5387.946120538744;5416.889537644852;5537.501624853621;5591.552675785846;5607.271054762855;5733.455321744427;5734.799282025276;5735.426457354231;5736.110902810071;5791.507721843691;5570.972145139248;5571.749271282721;5575.776968921197;5577.888442231214;5578.665280083208;5449.891002180014;5453.15476101205;5484.095124304605;5550.111982082847;5553.389127195925;5489.835304940858;5524.613277070566;5530.91703624454;5576;5589.80435684749;5607.943920560905;5609.747561359667;5616.017196990592;5616.466435688603;5623.409541998031;5296.973515132399;5332.200169974535;5337.306150200449;5496.862578435571;5561.6663000220115 03:39:12 INFO - PROCESS | 15530 | |1;ext.html;549.5274064304697;600.3126420248815;606.5784279925451;609.6494515653501;615.5752530753781;33693.32613347735;41109.177816443655;42025.15949681005;42141.7892910535;46188;44312.3353149703;45011.324830127574;45031;45061;45137.77431112848;8054.154313797055;8267.751967440987;8839.46963182208;9004.054574269705;9007.774805629846;10473.790524189511;10708.41103739294;10725.892741072568;11093.1125509959;11104.61133860315;10751.62369317074;10843.566257349696;10850;10857.51141198648;10861.13110951126;10731.678049658483;10792.892071079266;10795.136389088853;10802.891971080306;10808.081313088318;10590.894091059068;10652;10658.893411065868;10664.520096595672;10665.573377064908;41653.791731041456;41971.7901410494;41999.7900010501;42036.369454457905;42045.789771051255;3423.5720534933134;3466.012186526853;3636.2000359920776;3763.473113764075;3917.5690674025836;31583.84208078968;31849.681503184904;31876.521852172235;31929.52105718416;32780.18049548756;4325.718828276152;4444.355568442557;4485.9102817943785;4499.945425138169;4564.977175114136;370060;371686;371886;372464;372887;56579;57094;57121.71439142778;57126.7143664279;57197.71401142968;35252.647473524936;36112.27775444477;36177.638223617956;38309.808450957564;38367.42448863213;16238;16405.507834764976;16416.507504774876;16424.1787910604;16428.6714265714;11524.423778811193;11735.941320293345;12254.571090011807;12416.068794840423;12489.50041998328;18225.179866906023;18776.155073021746;18923.52691182704;18997.430077097433;19145.329913452963;6840.965795170992;7214.747483838146;7347.228541003117;7348.191698913115;7370.5946172961;909.2362415570952;1009.9293049486612;1035.3632516002604;1061.3154515337565;1124.2692250037378;31207;31306.045020239344;31910.840445798087;32009;32315.51526727101;1078.5577913055608;1127.3630398824637;1132.4903793293051;1158.9710257243637;1195.384377045822;15883.52349429519;16750.4137355192;16751.91624041872;16821.32714691423;16864.241109150116;578278;580454;581806;582903;583743.8694550096;45733.54266457293;46061;46070;46084;46084.308735369;1211.0977321895068;1213.9696507587205;1260.4517035089766;1286.8713128687243;1355.586546103448;28124.296892577848;32140.678593214703;32426.83786581052;32800.83599581987;32995.175120622174;48688.2696759556;49425.75287123685;49518.50481495139;49527.75236123797;49544.75227623839;408016;408778;410262;410757;411361;24765.752342476346;26878.32804179911;27286.181414557595;27699.723002769715;28824.135275941757;45593.77203113963;45812.54187458083;45977.540224597324;46058.76970615125;46685.533144669476;38667.419988700756;40099;40507.59492405038;40564.79717601393;42061;39392.40911386274;39572.61495847631;40414;40595.59404405918;41332.1733565321;39051.41422878716;39660.80169599134;39906.40140397838;40261.39607905825;40462.39306410465;34094.48858267078;35900.28199436049;36510.817445913664;36695.449568255965;36744.265114697024;27027.86486067557;27571.86214068997;27575.448491030467;27584.44831103407;27616.309592260353 03:39:12 INFO - PROCESS | 15530 | |2;jquery.html;381.5612046146932;391.48324212040103;409.66612211047993;411.5041375142952;422.2252167273054;13409.932950335247;15288;18979.33572324969;19012;19741.407757767254;17643.382481613146;17705.203265853037;18166.909165454188;18632.627347453075;18646.81353186468;5444.537214336776;5507.284053073115;5701.971490142543;5712.200291959129;5714.25714657094;5543.77824887004;5634.126710359901;5635.520980716644;5666.716664166795;5673.6879471629045;5511.9724401377935;5738.942610573882;5741.4785081953105;5746.48281654651;5751.1373294006025;5601.80393686221;5613.46672066153;5637.548996080303;5646.887062258773;5704.258446401962;4881.951180488185;5014.147594908874;5070.3915530136255;5075.619328550373;5081.339425874649;20764.792352076438;20870.165193392248;20879.164833406798;20962.475938101517;21377.35867923965;2189.2337681811396;2258.6499092640665;2352.1414683640346;2399.052374312137;2872.741453269216;9970.536828963795;10437.478126093665;10523.368597884075;14081.366338514792;14420.639484012983;1853.5273505256073;1888.4051523769967;1933.9613207735767;1982.9008549572463;2077.8649387789746;80894.19105808984;82537.58731206365;82748.58625706832;83833;85845.14154858435;9943.552540135712;10155.644552440777;10356.533955972;10361.792764144675;11104.222704410775;15598.142102184262;15630.687386252212;15637.452689155825;15649.921750391175;15661.60845978837;7891.487053341514;8115.269625733712;8126;8153.6738530458115;8313.256625313632;7700.268474494914;7748.341390981717;7874.133845277015;7978;8030.39772017101;4737.620990320766;4775.761211939389;4779.713217206979;4824.903501929942;4910.582600478928;1977.604479104185;1994.6808510638227;2015.637185306659;2018.9495262618552;2029.6651052576456;884.3367474394204;950.4724877692809;951.8239125761756;967.8209531236603;986.807572523351;18012;19042.809571904105;19202.13590388436;19288.1320340585;19479.220831166596;818.46684511437;921.1755478846395;930.63240020193;946.9857952130724;952.8904176019707;10059.748506287402;11140.220184587;11266.94366528162;11657.18399712012;11669.649910502698;430584;450726;460979;461536;464469;56142.15786763202;89209.10790892008;91682;93336;96819.51590242004;996.9202463803024;1031.4481752262654;1052.7473406382412;1058.9311694739818;1060.5757696921294;16729.395652456562;16820;16883.7467437991;17143.14284285806;17439.389621363698;43648.78175609102;43689.975652800335;43763.562364375946;43839.123217534834;45249.54750452453;57621.71189144195;57838.7108064457;58002;58077.4192258072;59091.113633296394;8199.467034642728;8344.791380215544;8378;8512.829743405222;8681.742746885982;12014.63956081319;12702.745945081231;12874.420651070537;13101.868981310065;13263.204207747565;11055.72360690957;11063.668089957315;11408.087353011904;11582.07343412508;11743;11366.829497557377;11373.886261137613;11423.543058277908;11520.654380368602;12116.970057545208;11135.777284454427;11461.48423320936;11614.128940329678;11745.412729363668;11805.173637845268;8320.417570769989;8469.407141500036;8564.48613083217;8641.52471614042;8711.782205444915;8500.44747091437;10918.617848375268;11267.718307042061;11438.142139339416;11449.885501144881 03:39:12 INFO - PROCESS | 15530 | |3;mootools.html;1293.1142167615178;1411.0616440067356;1494.7683109118086;1565.545991662418;1732.8093909669933;7942.602869856506;8775.6050977706;9086.818263634723;9135.451872887623;9360.438373697565;9039.50282734451;9119.908800912006;9121.498317592546;9123.863142052875;9146;2332.603457412244;2353.1293421434093;2360.2093298744853;2361.055577768889;2361.291612516247;2305.9308220753405;2365.077619728307;2369.087901158058;2377.9762202378015;2384.511175209078;2286.588414085464;2298.310506847947;2299.7125359330084;2343.297010896733;2352.2590384028977;2245.786650268222;2268.3875353654503;2272.545490901818;2290.690756747843;2309.618912879373;2254.887255637228;2259.051198496635;2259.0850705464313;2263.038208761286;2265.2184996176293;8833.911660883437;9011.954940225258;9108.590113444845;9116.954415227949;9195.678151264741;5273.683578985273;5401.216823560561;5419.566434685215;5428.185772134172;5431.945680543184;3470.7570470067108;3510.80690562019;3569.214772749991;3581.83881725323;3596;1107.6012635451232;1118.815395459748;1121.1423261205184;1121.1479275750407;1140.6064907606863;12569.428821397325;12610.621681349574;12626.179298345578;12656.55702050433;12756.979441644646;4346.543612920598;4607.216773148572;4616.76916154191;4717.410323709536;4762.738049407247;10007.14939230159;10049.69850904474;10050.447225402673;10056.094951454257;10083.546240419199;5382.784688612412;5389.083855744533;5394.649347792381;5397.379301380392;5399;4453.087117140978;4582.198115329804;4797.280407938837;4927.063857866994;5033.0688822567945;3790.77255364679;3811.6569508744346;3922.9019274518364;3925.7055720821054;3950.881473555798;1139.5954436175205;1147.0651419093413;1184.8933595976403;1188.3523479703583;1210.1347536511437;938.4275591888942;952.7522844060455;953.7138858342609;962.2350231565922;998.3909815012836;5821.18503409523;5937.435943585352;6005.879882402415;6068.2111325528285;6148.907766383508;460.64760458249464;461.9467613840449;462.27192172328716;463.31429484362656;465.3461886050105;3779.6220377961986;3876.457295978565;3911.5697273299916;3925;4105.89735256615;10724.78550428987;11502.137339699557;11677.124215683687;11677.532898684127;11685.357305348287;11355.659330220107;11543.422828858524;11544;11589.594364197214;11617.76764464706;8524;8614.956925215334;8622.310215182895;8623.31013518917;8624.051354351017;5854.736536855767;5932.110183472513;6003.0695242237525;6085.117657939662;6089.086637004308;9935.354201976848;10463.94768026155;10553.736156596147;10557.313774604934;10736.141108711128;10517.842232366367;10695.839562406414;10755.838662420227;10815;10865.945670271598;7155.606441645759;7402.9629851850395;7652.196519365609;7889.605519724106;8067.55628440418;8049.195080491904;8187.26314631686;8193.71322003727;8217.342612590859;8222.83554328898;7217.855642887218;7427.071616047994;7639.618019098912;7717.961410192913;7796.9220307796195;7359.926400735924;7541.208173141741;7641.847163056596;7723.652435640297;8029.638666259915;7022.4382049436945;7156.284371562802;7159.248278930846;7162.534435261691;7170.067891174114;5134.15286477727;5160.587153027674;5189.221616757365;5198.246254293031;5441.319835020622;5001;5150.40770311419;5162.767675454688;5184.948150518447;5215.452377500308 03:39:12 INFO - PROCESS | 15530 | |4;prototype.html;323.9676032396759;332.93341331733654;342.3632044397421;343.84698809029993;347.3868621882378;5275.472452754722;5308.893822123555;5311.326932016417;5349.866253343668;5358.767483478792;5276.894462110756;5298.867528311795;5302.814401495948;5314.441983591725;5315.36215654121;3886.844526218948;4091.9386209206887;4184.97907510462;4192.5807419258135;4206.242876282268;4103.051050750899;4132.925439385751;4133.677223288549;4156.896077598054;4179.20595086934;4096.119334343116;4109.6506796922295;4113.218488487193;4126.5254495732925;4134.552906482722;3886.3393223152134;3996.9200615987515;4007.599240075969;4091.8772436826944;4131.380292956065;3618.8371523281517;3631.4734363517405;3634;3637.5453068366455;3639.9272014559824;5130.948690513084;5132.769025393866;5135.35808023997;5151.665141765773;5173.508516690908;4337.240982828024;4458.264386376244;4616.0532744503635;4617.676762626617;4680.859574212779;5442.374126975409;5443.863903402407;5454.53636440903;5457.563394928436;5496.615236933416;3915.6280153385383;3915.8629447969183;3930.292547341506;3937.1141493164096;3947.4473573699706;5519.282493275889;5704.401037891003;5753.079507278857;5775.306963164405;5795.971020144957;4193.861130823241;4227;4239.597238262422;4245.278302688489;4253.936190957138;4259.936100958488;4282.379055037002;4299.97850010748;4305.138972205571;4305.526392096866;4695.460022097434;4798.616110711135;4801.911168641652;4823.517648235148;4832.782524786393;5575.383138889677;5577.274954256002;5585.720713964285;5593.74828132735;5594.300712410949;1476.9630759231104;1478.9112653240625;1491.6942026884462;1491.8508149184995;1494.2080697230485;945.4610871803006;975.5073687787622;978.9021097890154;993.5330394714473;995.6813819577666;5298.841034768963;5307.203919412119;5316.494932981361;5332.33345831771;5333;5633.521150702154;5635.520980716603;5638.35158956717;5643.730160713889;5644.717764111778;5138.97430512845;5223;5270.868228294324;5303.443138470482;5326.733663316819;2898.6086878271585;2917.679055303915;2965.3920946205976;3004.459197344499;3008.127642983554;5867.70661466925;5874.353821079678;5875.708473695262;5885.676287804126;5892.641194519083;5590.385057643656;5747.683877386784;5816.912746308809;5823.330317013598;5826.31036999274;5849.415058494116;5854.385289544536;5859;5860.413958604106;5871.324797648154;5565.693886836263;5612.466815652507;5637.88724225505;5673.234113394804;5699.743511542073;5401.891962160814;5675.233843431084;5680.147977803363;5706.3152421709665;5707.857303567444;5893.876245589844;5906.379830117776;5916;5924.644521328734;5931.525477961839;3955.92088158241;4053.9797301013305;4058.7970601470397;4060.573639767782;4087.6934229933468;5664.971675141598;5701.857453563694;5714.457126572969;5716.485516303553;5717.771289148387;5583.581231407742;5584.134459158837;5625.381208067028;5625.381208067191;5644.491995720405;5427.968685949657;5551.389347171727;5556.111022236423;5582.944170558242;5606.159076138611;5470.8358749235995;5481.205225242397;5498.285222920995;5499.642523235977;5514.696691681836;5490.835274941598;5583.218349431002;5593.608447408805;5594.188842617879;5600.35595906476;5457.672539647634;5490;5492.80775172867;5497.340319161726;5507.284053073075 03:39:12 INFO - PROCESS | 15530 | |5;yui.html;629.9842503937401;636.7484843486823;642.9453496452801;656.9441597464215;718.4719231364946;14315.785263221047;14459.060161089521;14580.416783328681;14591.124532528043;15300.00549964253;13511.864881351183;13537.458501659947;13553.457861685545;13609.523666671668;13617.45530178794;768.9730859419907;792.8493586218628;794.9443538952247;794.964226609801;796.6176235406979;647.6340867409898;665.9600423974578;776.8057985503624;794.964226609804;800.1118758178417;821.8520666280067;824.3570015387977;825.529448214518;827.4662842466605;828.0725587342185;827.7516744976483;827.7971896885301;827.8302947895667;827.9917200828005;828.5567221536479;502.2315856739195;513.709753988995;593.1547544748715;598.467364045995;607.7265230646227;13802.792958105636;13803.2408217548;13853.722925541433;13870.930645346709;13915.791263131061;12541.623751287476;12758.80861787074;13211.669708257274;13223.603291901258;13452.1256118352;12244.81632775509;12292.508299668003;12360.505579776798;12414.193077449936;12468.189567678071;3744.719146064029;4279.5078565965005;4297.505786834523;4314.762688052156;4329.545397733255;70364.64817675878;80941;81008.9999999994;81244;81477;9860.950695246622;10815.513301901434;10840.241183117107;10998.450077496092;11055.226134170693;20044.799552004584;20050.699239511418;20310.08604612796;20326.695099573517;20327;8465.111163327885;8629.395942284105;8637.352198585006;8834.160754728291;8837.911620883837;4617.653675974316;4620.745858977722;4700.858974230779;4707.764611769467;4814.662973591815;3360.1095709636966;3475.2007038380807;3484.5295885055193;3487.232808782064;3488.075659950115;615.7444660465947;622.2595111816923;625.221599109103;637.9266384365858;666.5933780393956;553.6097051578628;571.977120915167;576.1099101887594;630.3412933484519;632.2160520953984;9747.805043899083;9843.704688859345;9924.136940008295;9951.651692190739;10057.29598928068;559.932808063035;574.2477354665401;644.297715490118;662.8409181796334;663.3466035954581;4502.189605870909;4819.662623616383;4832.371791667061;4868.3427737255015;4919.532644398776;80300.59849700831;125520;126960;131145;132420.33789831182;107515;108008.45995769971;108758.45620772004;108800;113453;76350.61824690952;78015.60992195003;78514.21485785069;87799.56100219458;96074;9079.68221112258;9228.907710923073;9462.195713364441;9548.570314335733;9669.371490853073;50476.49523504865;51790.74104629603;52417.213741794665;53085.46914530805;53547;73462.63268683836;74159;76681.22357721695;76695;79290.20709792829;11828.52685892589;12161.635150945485;12401.689957750768;12513.624591262276;12628.747425051632;13651.711538651913;13799.03406761517;13886.444542218198;13971.301434928417;14496.782548261574;13169.670758231121;13182.934085329513;13550.728985420434;13635.659108522366;14082.859171408154;11999.76000480003;12120.939395302967;12205.450754716237;12241.510339586674;12263.64640552591;12722.300273485047;13030.153040052366;13183.604491865259;13291.136076155019;13376.598702038955;10375.584976600852;10418.426986515815;10522.684319470429;10543.736406589896;10796.136309095096;10927.180461465263;11063.72340691489;11149.386783726974;11244.831327530257;11247.493862776359 03:39:12 INFO - PROCESS | 15530 | __end_tp_report 03:39:12 INFO - PROCESS | 15530 | __start_cc_report 03:39:12 INFO - PROCESS | 15530 | _x_x_mozilla_cycle_collect,1041 03:39:12 INFO - PROCESS | 15530 | __end_cc_report 03:39:12 INFO - PROCESS | 15530 | __startTimestamp1474886352670__endTimestamp 03:39:12 INFO - PROCESS | 15530 | 03:39:12 INFO - PROCESS | 15530 | ------- Summary: start ------- 03:39:12 INFO - PROCESS | 15530 | Number of tests: 6 03:39:12 INFO - PROCESS | 15530 | 03:39:12 INFO - PROCESS | 15530 | [#0] dojo.html Cycles:165 Average:5249.48 Median:5466.15 stddev:592.85 (10.8%) stddev-sans-first:567.20 03:39:12 INFO - PROCESS | 15530 | Values: 2975.7 3022.1 3022.7 3051.1 3063.1 5164.2 5233.4 5237.7 5352.9 5360.3 5229.2 5278.9 5304.0 5327.8 5380.5 4750.2 4761.1 4805.5 4821.4 4848.3 4821.2 4851.7 4928.1 4938.0 4944.1 4873.7 4877.1 4920.7 4944.5 4970.7 4746.5 4793.8 4802.5 4833.8 4853.5 4692.3 4694.4 4706.4 4709.4 4768.8 5256.7 5264.9 5268.1 5280.9 5306.2 5489.6 5523.6 5556.3 5612.3 5614.7 5627.5 5655.9 5662.8 5670.7 5717.4 5272.2 5279.7 5286.5 5286.6 5349.1 5659.4 5734.7 5762.4 5791.1 5798.8 5569.6 5574.6 5585.7 5642.1 5645.3 5657.8 5663.0 5668.4 5669.3 5673.3 5466.2 5514.8 5601.3 5647.7 5659.6 5535.2 5542.7 5561.9 5626.0 5640.2 4333.8 4335.8 4343.3 4352.0 4391.5 3870.8 3874.6 3900.6 3904.2 3909.6 5130.0 5181.4 5197.4 5275.9 5318.3 5634.6 5643.9 5648.2 5699.6 5717.7 5311.6 5314.7 5318.6 5319.6 5323.5 4785.5 4828.0 4865.5 4919.8 4926.2 5730.0 5885.3 5885.4 5890.7 5894.4 5614.2 5645.3 5649.3 5651.4 5656.9 5809.9 5818.4 5822.6 5824.1 5828.4 5387.9 5416.9 5537.5 5591.6 5607.3 5733.5 5734.8 5735.4 5736.1 5791.5 5571.0 5571.7 5575.8 5577.9 5578.7 5449.9 5453.2 5484.1 5550.1 5553.4 5489.8 5524.6 5530.9 5576.0 5589.8 5607.9 5609.7 5616.0 5616.5 5623.4 5297.0 5332.2 5337.3 5496.9 5561.7 03:39:12 INFO - PROCESS | 15530 | 03:39:12 INFO - PROCESS | 15530 | [#1] ext.html Cycles:180 Average:60213.42 Median:203402.13 stddev:123139.74 (60.5%) stddev-sans-first:123403.70 03:39:12 INFO - PROCESS | 15530 | Values: 549.5 600.3 606.6 609.6 615.6 33693.3 41109.2 42025.2 42141.8 46188.0 44312.3 45011.3 45031.0 45061.0 45137.8 8054.2 8267.8 8839.5 9004.1 9007.8 10473.8 10708.4 10725.9 11093.1 11104.6 10751.6 10843.6 10850.0 10857.5 10861.1 10731.7 10792.9 10795.1 10802.9 10808.1 10590.9 10652.0 10658.9 10664.5 10665.6 41653.8 41971.8 41999.8 42036.4 42045.8 3423.6 3466.0 3636.2 3763.5 3917.6 31583.8 31849.7 31876.5 31929.5 32780.2 4325.7 4444.4 4485.9 4499.9 4565.0 370060.0 371686.0 371886.0 372464.0 372887.0 56579.0 57094.0 57121.7 57126.7 57197.7 35252.6 36112.3 36177.6 38309.8 38367.4 16238.0 16405.5 16416.5 16424.2 16428.7 11524.4 11735.9 12254.6 12416.1 12489.5 18225.2 18776.2 18923.5 18997.4 19145.3 6841.0 7214.7 7347.2 7348.2 7370.6 909.2 1009.9 1035.4 1061.3 1124.3 31207.0 31306.0 31910.8 32009.0 32315.5 1078.6 1127.4 1132.5 1159.0 1195.4 15883.5 16750.4 16751.9 16821.3 16864.2 578278.0 580454.0 581806.0 582903.0 583743.9 45733.5 46061.0 46070.0 46084.0 46084.3 1211.1 1214.0 1260.5 1286.9 1355.6 28124.3 32140.7 32426.8 32800.8 32995.2 48688.3 49425.8 49518.5 49527.8 49544.8 408016.0 408778.0 410262.0 410757.0 411361.0 24765.8 26878.3 27286.2 27699.7 28824.1 45593.8 45812.5 45977.5 46058.8 46685.5 38667.4 40099.0 40507.6 40564.8 42061.0 39392.4 39572.6 40414.0 40595.6 41332.2 39051.4 39660.8 39906.4 40261.4 40462.4 34094.5 35900.3 36510.8 36695.4 36744.3 27027.9 27571.9 27575.4 27584.4 27616.3 03:39:12 INFO - PROCESS | 15530 | 03:39:12 INFO - PROCESS | 15530 | [#2] jquery.html Cycles:180 Average:27748.70 Median:215503.11 stddev:75021.25 (34.8%) stddev-sans-first:75203.56 03:39:12 INFO - PROCESS | 15530 | Values: 381.6 391.5 409.7 411.5 422.2 13409.9 15288.0 18979.3 19012.0 19741.4 17643.4 17705.2 18166.9 18632.6 18646.8 5444.5 5507.3 5702.0 5712.2 5714.3 5543.8 5634.1 5635.5 5666.7 5673.7 5512.0 5738.9 5741.5 5746.5 5751.1 5601.8 5613.5 5637.5 5646.9 5704.3 4882.0 5014.1 5070.4 5075.6 5081.3 20764.8 20870.2 20879.2 20962.5 21377.4 2189.2 2258.6 2352.1 2399.1 2872.7 9970.5 10437.5 10523.4 14081.4 14420.6 1853.5 1888.4 1934.0 1982.9 2077.9 80894.2 82537.6 82748.6 83833.0 85845.1 9943.6 10155.6 10356.5 10361.8 11104.2 15598.1 15630.7 15637.5 15649.9 15661.6 7891.5 8115.3 8126.0 8153.7 8313.3 7700.3 7748.3 7874.1 7978.0 8030.4 4737.6 4775.8 4779.7 4824.9 4910.6 1977.6 1994.7 2015.6 2018.9 2029.7 884.3 950.5 951.8 967.8 986.8 18012.0 19042.8 19202.1 19288.1 19479.2 818.5 921.2 930.6 947.0 952.9 10059.7 11140.2 11266.9 11657.2 11669.6 430584.0 450726.0 460979.0 461536.0 464469.0 56142.2 89209.1 91682.0 93336.0 96819.5 996.9 1031.4 1052.7 1058.9 1060.6 16729.4 16820.0 16883.7 17143.1 17439.4 43648.8 43690.0 43763.6 43839.1 45249.5 57621.7 57838.7 58002.0 58077.4 59091.1 8199.5 8344.8 8378.0 8512.8 8681.7 12014.6 12702.7 12874.4 13101.9 13263.2 11055.7 11063.7 11408.1 11582.1 11743.0 11366.8 11373.9 11423.5 11520.7 12117.0 11135.8 11461.5 11614.1 11745.4 11805.2 8320.4 8469.4 8564.5 8641.5 8711.8 8500.4 10918.6 11267.7 11438.1 11449.9 03:39:12 INFO - PROCESS | 15530 | 03:39:12 INFO - PROCESS | 15530 | [#3] mootools.html Cycles:180 Average:5869.01 Median:2539.52 stddev:3436.71 (135.3%) stddev-sans-first:3429.14 03:39:12 INFO - PROCESS | 15530 | Values: 1293.1 1411.1 1494.8 1565.5 1732.8 7942.6 8775.6 9086.8 9135.5 9360.4 9039.5 9119.9 9121.5 9123.9 9146.0 2332.6 2353.1 2360.2 2361.1 2361.3 2305.9 2365.1 2369.1 2378.0 2384.5 2286.6 2298.3 2299.7 2343.3 2352.3 2245.8 2268.4 2272.5 2290.7 2309.6 2254.9 2259.1 2259.1 2263.0 2265.2 8833.9 9012.0 9108.6 9117.0 9195.7 5273.7 5401.2 5419.6 5428.2 5431.9 3470.8 3510.8 3569.2 3581.8 3596.0 1107.6 1118.8 1121.1 1121.1 1140.6 12569.4 12610.6 12626.2 12656.6 12757.0 4346.5 4607.2 4616.8 4717.4 4762.7 10007.1 10049.7 10050.4 10056.1 10083.5 5382.8 5389.1 5394.6 5397.4 5399.0 4453.1 4582.2 4797.3 4927.1 5033.1 3790.8 3811.7 3922.9 3925.7 3950.9 1139.6 1147.1 1184.9 1188.4 1210.1 938.4 952.8 953.7 962.2 998.4 5821.2 5937.4 6005.9 6068.2 6148.9 460.6 461.9 462.3 463.3 465.3 3779.6 3876.5 3911.6 3925.0 4105.9 10724.8 11502.1 11677.1 11677.5 11685.4 11355.7 11543.4 11544.0 11589.6 11617.8 8524.0 8615.0 8622.3 8623.3 8624.1 5854.7 5932.1 6003.1 6085.1 6089.1 9935.4 10463.9 10553.7 10557.3 10736.1 10517.8 10695.8 10755.8 10815.0 10865.9 7155.6 7403.0 7652.2 7889.6 8067.6 8049.2 8187.3 8193.7 8217.3 8222.8 7217.9 7427.1 7639.6 7718.0 7796.9 7359.9 7541.2 7641.8 7723.7 8029.6 7022.4 7156.3 7159.2 7162.5 7170.1 5134.2 5160.6 5189.2 5198.2 5441.3 5001.0 5150.4 5162.8 5184.9 5215.5 03:39:12 INFO - PROCESS | 15530 | 03:39:12 INFO - PROCESS | 15530 | [#4] prototype.html Cycles:180 Average:4679.04 Median:5329.53 stddev:1367.04 (25.7%) stddev-sans-first:1331.22 03:39:12 INFO - PROCESS | 15530 | Values: 324.0 332.9 342.4 343.8 347.4 5275.5 5308.9 5311.3 5349.9 5358.8 5276.9 5298.9 5302.8 5314.4 5315.4 3886.8 4091.9 4185.0 4192.6 4206.2 4103.1 4132.9 4133.7 4156.9 4179.2 4096.1 4109.7 4113.2 4126.5 4134.6 3886.3 3996.9 4007.6 4091.9 4131.4 3618.8 3631.5 3634.0 3637.5 3639.9 5130.9 5132.8 5135.4 5151.7 5173.5 4337.2 4458.3 4616.1 4617.7 4680.9 5442.4 5443.9 5454.5 5457.6 5496.6 3915.6 3915.9 3930.3 3937.1 3947.4 5519.3 5704.4 5753.1 5775.3 5796.0 4193.9 4227.0 4239.6 4245.3 4253.9 4259.9 4282.4 4300.0 4305.1 4305.5 4695.5 4798.6 4801.9 4823.5 4832.8 5575.4 5577.3 5585.7 5593.7 5594.3 1477.0 1478.9 1491.7 1491.9 1494.2 945.5 975.5 978.9 993.5 995.7 5298.8 5307.2 5316.5 5332.3 5333.0 5633.5 5635.5 5638.4 5643.7 5644.7 5139.0 5223.0 5270.9 5303.4 5326.7 2898.6 2917.7 2965.4 3004.5 3008.1 5867.7 5874.4 5875.7 5885.7 5892.6 5590.4 5747.7 5816.9 5823.3 5826.3 5849.4 5854.4 5859.0 5860.4 5871.3 5565.7 5612.5 5637.9 5673.2 5699.7 5401.9 5675.2 5680.1 5706.3 5707.9 5893.9 5906.4 5916.0 5924.6 5931.5 3955.9 4054.0 4058.8 4060.6 4087.7 5665.0 5701.9 5714.5 5716.5 5717.8 5583.6 5584.1 5625.4 5625.4 5644.5 5428.0 5551.4 5556.1 5582.9 5606.2 5470.8 5481.2 5498.3 5499.6 5514.7 5490.8 5583.2 5593.6 5594.2 5600.4 5457.7 5490.0 5492.8 5497.3 5507.3 03:39:12 INFO - PROCESS | 15530 | 03:39:12 INFO - PROCESS | 15530 | [#5] yui.html Cycles:180 Average:20992.79 Median:4619.20 stddev:31422.23 (680.3%) stddev-sans-first:31473.18 03:39:12 INFO - PROCESS | 15530 | Values: 630.0 636.7 642.9 656.9 718.5 14315.8 14459.1 14580.4 14591.1 15300.0 13511.9 13537.5 13553.5 13609.5 13617.5 769.0 792.8 794.9 795.0 796.6 647.6 666.0 776.8 795.0 800.1 821.9 824.4 825.5 827.5 828.1 827.8 827.8 827.8 828.0 828.6 502.2 513.7 593.2 598.5 607.7 13802.8 13803.2 13853.7 13870.9 13915.8 12541.6 12758.8 13211.7 13223.6 13452.1 12244.8 12292.5 12360.5 12414.2 12468.2 3744.7 4279.5 4297.5 4314.8 4329.5 70364.6 80941.0 81009.0 81244.0 81477.0 9861.0 10815.5 10840.2 10998.5 11055.2 20044.8 20050.7 20310.1 20326.7 20327.0 8465.1 8629.4 8637.4 8834.2 8837.9 4617.7 4620.7 4700.9 4707.8 4814.7 3360.1 3475.2 3484.5 3487.2 3488.1 615.7 622.3 625.2 637.9 666.6 553.6 572.0 576.1 630.3 632.2 9747.8 9843.7 9924.1 9951.7 10057.3 559.9 574.2 644.3 662.8 663.3 4502.2 4819.7 4832.4 4868.3 4919.5 80300.6 125520.0 126960.0 131145.0 132420.3 107515.0 108008.5 108758.5 108800.0 113453.0 76350.6 78015.6 78514.2 87799.6 96074.0 9079.7 9228.9 9462.2 9548.6 9669.4 50476.5 51790.7 52417.2 53085.5 53547.0 73462.6 74159.0 76681.2 76695.0 79290.2 11828.5 12161.6 12401.7 12513.6 12628.7 13651.7 13799.0 13886.4 13971.3 14496.8 13169.7 13182.9 13550.7 13635.7 14082.9 11999.8 12120.9 12205.5 12241.5 12263.6 12722.3 13030.2 13183.6 13291.1 13376.6 10375.6 10418.4 10522.7 10543.7 10796.1 10927.2 11063.7 11149.4 11244.8 11247.5 03:39:12 INFO - PROCESS | 15530 | -------- Summary: end -------- 03:39:12 INFO - PROCESS | 15530 | 03:39:13 INFO - TEST-INFO | 15530: exit 0 03:39:13 INFO - TEST-OK | dromaeo_css | took 1115611ms 03:39:13 INFO - TEST-START | kraken 03:39:13 INFO - operating with platform_type : linux_ 03:39:13 INFO - Initialising browser for kraken test... 03:39:13 INFO - TEST-INFO | started process 15839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzWU2bT/profile http://localhost:52409/getInfo.html) 03:39:18 INFO - PROCESS | 15839 | __metrics Screen width/height:1600/1200 03:39:18 INFO - PROCESS | 15839 | colorDepth:24 03:39:18 INFO - PROCESS | 15839 | Browser inner width/height: 1024/697 03:39:18 INFO - PROCESS | 15839 | __metrics 03:39:18 INFO - PROCESS | 15839 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:39:18 INFO - PROCESS | 15839 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:39:19 INFO - PROCESS | 15839 | console.error: PushService: 03:39:19 INFO - PROCESS | 15839 | stateChangeProcessEnqueue: Error transitioning state 03:39:19 INFO - PROCESS | 15839 | UnknownError 03:39:19 INFO - TEST-INFO | 15839: exit 0 03:39:19 INFO - Browser initialized. 03:39:19 INFO - Running cycle 1/1 for kraken test... 03:39:19 INFO - TEST-INFO | started process 15922 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzWU2bT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:31 INFO - PROCESS | 15922 | RSS: Main: 174587904 03:39:31 INFO - PROCESS | 15922 | 03:39:34 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52409/tests/kraken/driver.html?testName=audio-beat-detection) 03:39:35 INFO - PROCESS | 15922 | RSS: Main: 232882176 03:39:35 INFO - PROCESS | 15922 | 03:39:37 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52409/tests/kraken/driver.html?testName=audio-dft) 03:39:38 INFO - PROCESS | 15922 | RSS: Main: 217452544 03:39:38 INFO - PROCESS | 15922 | 03:39:41 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52409/tests/kraken/driver.html?testName=audio-fft) 03:39:42 INFO - PROCESS | 15922 | RSS: Main: 299388928 03:39:42 INFO - PROCESS | 15922 | 03:39:44 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52409/tests/kraken/driver.html?testName=audio-oscillator) 03:39:44 INFO - PROCESS | 15922 | RSS: Main: 208695296 03:39:44 INFO - PROCESS | 15922 | 03:39:46 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:39:47 INFO - PROCESS | 15922 | RSS: Main: 212750336 03:39:47 INFO - PROCESS | 15922 | 03:39:50 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52409/tests/kraken/driver.html?testName=imaging-darkroom) 03:39:51 INFO - PROCESS | 15922 | RSS: Main: 249999360 03:39:51 INFO - PROCESS | 15922 | 03:39:54 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52409/tests/kraken/driver.html?testName=imaging-desaturate) 03:39:55 INFO - PROCESS | 15922 | RSS: Main: 249180160 03:39:55 INFO - PROCESS | 15922 | 03:39:57 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52409/tests/kraken/driver.html?testName=json-parse-financial) 03:39:58 INFO - PROCESS | 15922 | RSS: Main: 248725504 03:39:58 INFO - PROCESS | 15922 | 03:40:00 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:00 INFO - PROCESS | 15922 | RSS: Main: 210980864 03:40:00 INFO - PROCESS | 15922 | 03:40:02 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52409/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:40:03 INFO - PROCESS | 15922 | RSS: Main: 219250688 03:40:03 INFO - PROCESS | 15922 | 03:40:05 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:40:05 INFO - PROCESS | 15922 | RSS: Main: 223297536 03:40:05 INFO - PROCESS | 15922 | 03:40:08 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:40:08 INFO - PROCESS | 15922 | RSS: Main: 224382976 03:40:08 INFO - PROCESS | 15922 | 03:40:11 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:40:12 INFO - PROCESS | 15922 | RSS: Main: 222531584 03:40:12 INFO - PROCESS | 15922 | 03:40:13 INFO - PROCESS | 15922 | Cycle 1(1): loaded http://localhost:52409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52409/tests/kraken/driver.html?testName=ai-astar) 03:40:14 INFO - PROCESS | 15922 | RSS: Main: 273489920 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | __start_tp_report 03:40:14 INFO - PROCESS | 15922 | _x_x_mozilla_page_load 03:40:14 INFO - PROCESS | 15922 | _x_x_mozilla_page_load_details 03:40:14 INFO - PROCESS | 15922 | |i|pagename|runs| 03:40:14 INFO - PROCESS | 15922 | |0;ai-astar;107;111;110;110;111;110;109;112;110;110 03:40:14 INFO - PROCESS | 15922 | |1;audio-beat-detection;146;118;126;159;125;119;117;117;150;121 03:40:14 INFO - PROCESS | 15922 | |2;audio-dft;160;161;161;161;161;162;159;161;159;159 03:40:14 INFO - PROCESS | 15922 | |3;audio-fft;74;76;75;119;76;75;75;77;102;74 03:40:14 INFO - PROCESS | 15922 | |4;audio-oscillator;83;82;132;82;81;81;101;83;81;112 03:40:14 INFO - PROCESS | 15922 | |5;imaging-gaussian-blur;116;117;117;117;116;118;117;117;117;117 03:40:14 INFO - PROCESS | 15922 | |6;imaging-darkroom;145;147;145;146;146;146;146;145;146;146 03:40:14 INFO - PROCESS | 15922 | |7;imaging-desaturate;96;94;95;95;94;95;95;95;95;95 03:40:14 INFO - PROCESS | 15922 | |8;json-parse-financial;53;52;53;51;57;52;53;52;53;53 03:40:14 INFO - PROCESS | 15922 | |9;json-stringify-tinderbox;61;60;61;61;61;61;61;61;61;60 03:40:14 INFO - PROCESS | 15922 | |10;stanford-crypto-aes;79;79;80;79;83;85;78;79;78;78 03:40:14 INFO - PROCESS | 15922 | |11;stanford-crypto-ccm;135;123;124;123;133;124;130;130;157;134 03:40:14 INFO - PROCESS | 15922 | |12;stanford-crypto-pbkdf2;168;167;165;163;161;162;163;164;164;163 03:40:14 INFO - PROCESS | 15922 | |13;stanford-crypto-sha256-iterative;64;66;65;65;65;65;65;64;62;65 03:40:14 INFO - PROCESS | 15922 | __end_tp_report 03:40:14 INFO - PROCESS | 15922 | __start_cc_report 03:40:14 INFO - PROCESS | 15922 | _x_x_mozilla_cycle_collect,1647 03:40:14 INFO - PROCESS | 15922 | __end_cc_report 03:40:14 INFO - PROCESS | 15922 | __startTimestamp1474886414191__endTimestamp 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | ------- Summary: start ------- 03:40:14 INFO - PROCESS | 15922 | Number of tests: 14 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:1.33 (1.2%) stddev-sans-first:0.87 03:40:14 INFO - PROCESS | 15922 | Values: 107.0 111.0 110.0 110.0 111.0 110.0 109.0 112.0 110.0 110.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:125.50 stddev:15.71 (12.5%) stddev-sans-first:15.53 03:40:14 INFO - PROCESS | 15922 | Values: 146.0 118.0 126.0 159.0 125.0 119.0 117.0 117.0 150.0 121.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 03:40:14 INFO - PROCESS | 15922 | Values: 160.0 161.0 161.0 161.0 161.0 162.0 159.0 161.0 159.0 159.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:15.42 (20.6%) stddev-sans-first:16.06 03:40:14 INFO - PROCESS | 15922 | Values: 74.0 76.0 75.0 119.0 76.0 75.0 75.0 77.0 102.0 74.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:81.50 stddev:17.66 (21.7%) stddev-sans-first:18.44 03:40:14 INFO - PROCESS | 15922 | Values: 83.0 82.0 132.0 82.0 81.0 81.0 101.0 83.0 81.0 112.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 03:40:14 INFO - PROCESS | 15922 | Values: 116.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 117.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 03:40:14 INFO - PROCESS | 15922 | Values: 145.0 147.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 03:40:14 INFO - PROCESS | 15922 | Values: 96.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.60 (3.0%) stddev-sans-first:1.69 03:40:14 INFO - PROCESS | 15922 | Values: 53.0 52.0 53.0 51.0 57.0 52.0 53.0 52.0 53.0 53.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 03:40:14 INFO - PROCESS | 15922 | Values: 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 60.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:2.35 (3.0%) stddev-sans-first:2.47 03:40:14 INFO - PROCESS | 15922 | Values: 79.0 79.0 80.0 79.0 83.0 85.0 78.0 79.0 78.0 78.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:131.50 stddev:10.18 (7.7%) stddev-sans-first:10.71 03:40:14 INFO - PROCESS | 15922 | Values: 135.0 123.0 124.0 123.0 133.0 124.0 130.0 130.0 157.0 134.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.00 stddev:2.16 (1.3%) stddev-sans-first:1.74 03:40:14 INFO - PROCESS | 15922 | Values: 168.0 167.0 165.0 163.0 161.0 162.0 163.0 164.0 164.0 163.0 03:40:14 INFO - PROCESS | 15922 | 03:40:14 INFO - PROCESS | 15922 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:1.12 03:40:14 INFO - PROCESS | 15922 | Values: 64.0 66.0 65.0 65.0 65.0 65.0 65.0 64.0 62.0 65.0 03:40:14 INFO - PROCESS | 15922 | -------- Summary: end -------- 03:40:14 INFO - PROCESS | 15922 | 03:40:15 INFO - TEST-INFO | 15922: exit 0 03:40:15 INFO - TEST-OK | kraken | took 61650ms 03:40:15 INFO - SUITE-END | took 1177s 03:40:15 INFO - Completed test suite (00:19:37) 03:40:15 INFO - javascript benchmark 03:40:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.7321841034304, 3022.07826612883, 3022.7128422799833, 3051.1456792098193, 3063.096386565964, 5164.225366195073, 5233.424323324441, 5237.685738855666, 5352.946470535294, 5360.329958755151, 5229.163333866582, 5278.9208161877505, 5304.045271851065, 5327.813526526573, 5380.461953804617, 4750.216214324632, 4761.119192949315, 4805.495422980572, 4821.421429428465, 4848.272759086148, 4821.228603423453, 4851.684640498374, 4928.1129396708575, 4937.975310123462, 4944.110060189165, 4873.731944743037, 4877.146499362598, 4920.655554111214, 4944.456109827934, 4970.70175789452, 4746.4541577718655, 4793.832215872462, 4802.4957379475, 4833.830815921426, 4853.514648535153, 4692.319613656035, 4694.436667599875, 4706.435227772655, 4709.364235828188, 4768.785404656799, 5256.658317209369, 5264.894702105937, 5268.130758424855, 5280.920786188171, 5306.177542480922, 5489.64317319373, 5523.558115350803, 5556.333240011184, 5612.326520817487, 5614.6631202128, 5627.493525582717, 5655.915161272585, 5662.773489060474, 5670.659760414388, 5717.399673034354, 5272.156454967264, 5279.70961597112, 5286.471352864722, 5286.5770738341225, 5349.117395629755, 5659.434056594308, 5734.655920644775, 5762.366139724711, 5791.102379131242, 5798.82603521895, 5569.582281328917, 5574.637648552831, 5585.720713964367, 5642.069058605284, 5645.266115404971, 5657.773689052392, 5663.037283661787, 5668.433156684298, 5669.262995810518, 5673.347565030074, 5466.1527463243265, 5514.751836167382, 5601.271834661468, 5647.745851436695, 5659.6321239119325, 5535.197396377503, 5542.722863856791, 5561.888762224733, 5626.043572592669, 5640.210370548127, 4333.826646934087, 4335.761533115646, 4343.305071188594, 4351.978240108842, 4391.451068616423, 3870.7871067091583, 3874.612538746103, 3900.629440203233, 3904.1606054698377, 3909.58949310324, 5129.9743501283, 5181.35233095863, 5197.350331208599, 5275.894482110336, 5318.308619879391, 5634.577406694432, 5643.887122257532, 5648.15277708347, 5699.629524080921, 5717.742701578439, 5311.628186026941, 5314.70769107695, 5318.601104917069, 5319.627626066215, 5323.494268044529, 4785.473597904228, 4828.0, 4865.464798872121, 4919.803207871645, 4926.162552366106, 5729.9713501432225, 5885.264341957255, 5885.352611212763, 5890.705464726747, 5894.38108998549, 5614.24207731951, 5645.294338207724, 5649.265595472562, 5651.350094739158, 5656.88686226265, 5809.9419005809405, 5818.418158184148, 5822.621529600562, 5824.068149096124, 5828.417158284307, 5387.946120538744, 5416.889537644852, 5537.501624853621, 5591.552675785846, 5607.271054762855, 5733.455321744427, 5734.799282025276, 5735.426457354231, 5736.110902810071, 5791.507721843691, 5570.972145139248, 5571.749271282721, 5575.776968921197, 5577.888442231214, 5578.665280083208, 5449.891002180014, 5453.15476101205, 5484.095124304605, 5550.111982082847, 5553.389127195925, 5489.835304940858, 5524.613277070566, 5530.91703624454, 5576.0, 5589.80435684749, 5607.943920560905, 5609.747561359667, 5616.017196990592, 5616.466435688603, 5623.409541998031, 5296.973515132399, 5332.200169974535, 5337.306150200449, 5496.862578435571, 5561.6663000220115], "value": 5209.384304745987, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.5274064304697, 600.3126420248815, 606.5784279925451, 609.6494515653501, 615.5752530753781, 33693.32613347735, 41109.177816443655, 42025.15949681005, 42141.7892910535, 46188.0, 44312.3353149703, 45011.324830127574, 45031.0, 45061.0, 45137.77431112848, 8054.154313797055, 8267.751967440987, 8839.46963182208, 9004.054574269705, 9007.774805629846, 10473.790524189511, 10708.41103739294, 10725.892741072568, 11093.1125509959, 11104.61133860315, 10751.62369317074, 10843.566257349696, 10850.0, 10857.51141198648, 10861.13110951126, 10731.678049658483, 10792.892071079266, 10795.136389088853, 10802.891971080306, 10808.081313088318, 10590.894091059068, 10652.0, 10658.893411065868, 10664.520096595672, 10665.573377064908, 41653.791731041456, 41971.7901410494, 41999.7900010501, 42036.369454457905, 42045.789771051255, 3423.5720534933134, 3466.012186526853, 3636.2000359920776, 3763.473113764075, 3917.5690674025836, 31583.84208078968, 31849.681503184904, 31876.521852172235, 31929.52105718416, 32780.18049548756, 4325.718828276152, 4444.355568442557, 4485.9102817943785, 4499.945425138169, 4564.977175114136, 370060.0, 371686.0, 371886.0, 372464.0, 372887.0, 56579.0, 57094.0, 57121.71439142778, 57126.7143664279, 57197.71401142968, 35252.647473524936, 36112.27775444477, 36177.638223617956, 38309.808450957564, 38367.42448863213, 16238.0, 16405.507834764976, 16416.507504774876, 16424.1787910604, 16428.6714265714, 11524.423778811193, 11735.941320293345, 12254.571090011807, 12416.068794840423, 12489.50041998328, 18225.179866906023, 18776.155073021746, 18923.52691182704, 18997.430077097433, 19145.329913452963, 6840.965795170992, 7214.747483838146, 7347.228541003117, 7348.191698913115, 7370.5946172961, 909.2362415570952, 1009.9293049486612, 1035.3632516002604, 1061.3154515337565, 1124.2692250037378, 31207.0, 31306.045020239344, 31910.840445798087, 32009.0, 32315.51526727101, 1078.5577913055608, 1127.3630398824637, 1132.4903793293051, 1158.9710257243637, 1195.384377045822, 15883.52349429519, 16750.4137355192, 16751.91624041872, 16821.32714691423, 16864.241109150116, 578278.0, 580454.0, 581806.0, 582903.0, 583743.8694550096, 45733.54266457293, 46061.0, 46070.0, 46084.0, 46084.308735369, 1211.0977321895068, 1213.9696507587205, 1260.4517035089766, 1286.8713128687243, 1355.586546103448, 28124.296892577848, 32140.678593214703, 32426.83786581052, 32800.83599581987, 32995.175120622174, 48688.2696759556, 49425.75287123685, 49518.50481495139, 49527.75236123797, 49544.75227623839, 408016.0, 408778.0, 410262.0, 410757.0, 411361.0, 24765.752342476346, 26878.32804179911, 27286.181414557595, 27699.723002769715, 28824.135275941757, 45593.77203113963, 45812.54187458083, 45977.540224597324, 46058.76970615125, 46685.533144669476, 38667.419988700756, 40099.0, 40507.59492405038, 40564.79717601393, 42061.0, 39392.40911386274, 39572.61495847631, 40414.0, 40595.59404405918, 41332.1733565321, 39051.41422878716, 39660.80169599134, 39906.40140397838, 40261.39607905825, 40462.39306410465, 34094.48858267078, 35900.28199436049, 36510.817445913664, 36695.449568255965, 36744.265114697024, 27027.86486067557, 27571.86214068997, 27575.448491030467, 27584.44831103407, 27616.309592260353], "value": 19951.68860292939, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.5612046146932, 391.48324212040103, 409.66612211047993, 411.5041375142952, 422.2252167273054, 13409.932950335247, 15288.0, 18979.33572324969, 19012.0, 19741.407757767254, 17643.382481613146, 17705.203265853037, 18166.909165454188, 18632.627347453075, 18646.81353186468, 5444.537214336776, 5507.284053073115, 5701.971490142543, 5712.200291959129, 5714.25714657094, 5543.77824887004, 5634.126710359901, 5635.520980716644, 5666.716664166795, 5673.6879471629045, 5511.9724401377935, 5738.942610573882, 5741.4785081953105, 5746.48281654651, 5751.1373294006025, 5601.80393686221, 5613.46672066153, 5637.548996080303, 5646.887062258773, 5704.258446401962, 4881.951180488185, 5014.147594908874, 5070.3915530136255, 5075.619328550373, 5081.339425874649, 20764.792352076438, 20870.165193392248, 20879.164833406798, 20962.475938101517, 21377.35867923965, 2189.2337681811396, 2258.6499092640665, 2352.1414683640346, 2399.052374312137, 2872.741453269216, 9970.536828963795, 10437.478126093665, 10523.368597884075, 14081.366338514792, 14420.639484012983, 1853.5273505256073, 1888.4051523769967, 1933.9613207735767, 1982.9008549572463, 2077.8649387789746, 80894.19105808984, 82537.58731206365, 82748.58625706832, 83833.0, 85845.14154858435, 9943.552540135712, 10155.644552440777, 10356.533955972, 10361.792764144675, 11104.222704410775, 15598.142102184262, 15630.687386252212, 15637.452689155825, 15649.921750391175, 15661.60845978837, 7891.487053341514, 8115.269625733712, 8126.0, 8153.6738530458115, 8313.256625313632, 7700.268474494914, 7748.341390981717, 7874.133845277015, 7978.0, 8030.39772017101, 4737.620990320766, 4775.761211939389, 4779.713217206979, 4824.903501929942, 4910.582600478928, 1977.604479104185, 1994.6808510638227, 2015.637185306659, 2018.9495262618552, 2029.6651052576456, 884.3367474394204, 950.4724877692809, 951.8239125761756, 967.8209531236603, 986.807572523351, 18012.0, 19042.809571904105, 19202.13590388436, 19288.1320340585, 19479.220831166596, 818.46684511437, 921.1755478846395, 930.63240020193, 946.9857952130724, 952.8904176019707, 10059.748506287402, 11140.220184587, 11266.94366528162, 11657.18399712012, 11669.649910502698, 430584.0, 450726.0, 460979.0, 461536.0, 464469.0, 56142.15786763202, 89209.10790892008, 91682.0, 93336.0, 96819.51590242004, 996.9202463803024, 1031.4481752262654, 1052.7473406382412, 1058.9311694739818, 1060.5757696921294, 16729.395652456562, 16820.0, 16883.7467437991, 17143.14284285806, 17439.389621363698, 43648.78175609102, 43689.975652800335, 43763.562364375946, 43839.123217534834, 45249.54750452453, 57621.71189144195, 57838.7108064457, 58002.0, 58077.4192258072, 59091.113633296394, 8199.467034642728, 8344.791380215544, 8378.0, 8512.829743405222, 8681.742746885982, 12014.63956081319, 12702.745945081231, 12874.420651070537, 13101.868981310065, 13263.204207747565, 11055.72360690957, 11063.668089957315, 11408.087353011904, 11582.07343412508, 11743.0, 11366.829497557377, 11373.886261137613, 11423.543058277908, 11520.654380368602, 12116.970057545208, 11135.777284454427, 11461.48423320936, 11614.128940329678, 11745.412729363668, 11805.173637845268, 8320.417570769989, 8469.407141500036, 8564.48613083217, 8641.52471614042, 8711.782205444915, 8500.44747091437, 10918.617848375268, 11267.718307042061, 11438.142139339416, 11449.885501144881], "value": 9077.08060699324, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.1142167615178, 1411.0616440067356, 1494.7683109118086, 1565.545991662418, 1732.8093909669933, 7942.602869856506, 8775.6050977706, 9086.818263634723, 9135.451872887623, 9360.438373697565, 9039.50282734451, 9119.908800912006, 9121.498317592546, 9123.863142052875, 9146.0, 2332.603457412244, 2353.1293421434093, 2360.2093298744853, 2361.055577768889, 2361.291612516247, 2305.9308220753405, 2365.077619728307, 2369.087901158058, 2377.9762202378015, 2384.511175209078, 2286.588414085464, 2298.310506847947, 2299.7125359330084, 2343.297010896733, 2352.2590384028977, 2245.786650268222, 2268.3875353654503, 2272.545490901818, 2290.690756747843, 2309.618912879373, 2254.887255637228, 2259.051198496635, 2259.0850705464313, 2263.038208761286, 2265.2184996176293, 8833.911660883437, 9011.954940225258, 9108.590113444845, 9116.954415227949, 9195.678151264741, 5273.683578985273, 5401.216823560561, 5419.566434685215, 5428.185772134172, 5431.945680543184, 3470.7570470067108, 3510.80690562019, 3569.214772749991, 3581.83881725323, 3596.0, 1107.6012635451232, 1118.815395459748, 1121.1423261205184, 1121.1479275750407, 1140.6064907606863, 12569.428821397325, 12610.621681349574, 12626.179298345578, 12656.55702050433, 12756.979441644646, 4346.543612920598, 4607.216773148572, 4616.76916154191, 4717.410323709536, 4762.738049407247, 10007.14939230159, 10049.69850904474, 10050.447225402673, 10056.094951454257, 10083.546240419199, 5382.784688612412, 5389.083855744533, 5394.649347792381, 5397.379301380392, 5399.0, 4453.087117140978, 4582.198115329804, 4797.280407938837, 4927.063857866994, 5033.0688822567945, 3790.77255364679, 3811.6569508744346, 3922.9019274518364, 3925.7055720821054, 3950.881473555798, 1139.5954436175205, 1147.0651419093413, 1184.8933595976403, 1188.3523479703583, 1210.1347536511437, 938.4275591888942, 952.7522844060455, 953.7138858342609, 962.2350231565922, 998.3909815012836, 5821.18503409523, 5937.435943585352, 6005.879882402415, 6068.2111325528285, 6148.907766383508, 460.64760458249464, 461.9467613840449, 462.27192172328716, 463.31429484362656, 465.3461886050105, 3779.6220377961986, 3876.457295978565, 3911.5697273299916, 3925.0, 4105.89735256615, 10724.78550428987, 11502.137339699557, 11677.124215683687, 11677.532898684127, 11685.357305348287, 11355.659330220107, 11543.422828858524, 11544.0, 11589.594364197214, 11617.76764464706, 8524.0, 8614.956925215334, 8622.310215182895, 8623.31013518917, 8624.051354351017, 5854.736536855767, 5932.110183472513, 6003.0695242237525, 6085.117657939662, 6089.086637004308, 9935.354201976848, 10463.94768026155, 10553.736156596147, 10557.313774604934, 10736.141108711128, 10517.842232366367, 10695.839562406414, 10755.838662420227, 10815.0, 10865.945670271598, 7155.606441645759, 7402.9629851850395, 7652.196519365609, 7889.605519724106, 8067.55628440418, 8049.195080491904, 8187.26314631686, 8193.71322003727, 8217.342612590859, 8222.83554328898, 7217.855642887218, 7427.071616047994, 7639.618019098912, 7717.961410192913, 7796.9220307796195, 7359.926400735924, 7541.208173141741, 7641.847163056596, 7723.652435640297, 8029.638666259915, 7022.4382049436945, 7156.284371562802, 7159.248278930846, 7162.534435261691, 7170.067891174114, 5134.15286477727, 5160.587153027674, 5189.221616757365, 5198.246254293031, 5441.319835020622, 5001.0, 5150.40770311419, 5162.767675454688, 5184.948150518447, 5215.452377500308], "value": 4574.307560148052, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.9676032396759, 332.93341331733654, 342.3632044397421, 343.84698809029993, 347.3868621882378, 5275.472452754722, 5308.893822123555, 5311.326932016417, 5349.866253343668, 5358.767483478792, 5276.894462110756, 5298.867528311795, 5302.814401495948, 5314.441983591725, 5315.36215654121, 3886.844526218948, 4091.9386209206887, 4184.97907510462, 4192.5807419258135, 4206.242876282268, 4103.051050750899, 4132.925439385751, 4133.677223288549, 4156.896077598054, 4179.20595086934, 4096.119334343116, 4109.6506796922295, 4113.218488487193, 4126.5254495732925, 4134.552906482722, 3886.3393223152134, 3996.9200615987515, 4007.599240075969, 4091.8772436826944, 4131.380292956065, 3618.8371523281517, 3631.4734363517405, 3634.0, 3637.5453068366455, 3639.9272014559824, 5130.948690513084, 5132.769025393866, 5135.35808023997, 5151.665141765773, 5173.508516690908, 4337.240982828024, 4458.264386376244, 4616.0532744503635, 4617.676762626617, 4680.859574212779, 5442.374126975409, 5443.863903402407, 5454.53636440903, 5457.563394928436, 5496.615236933416, 3915.6280153385383, 3915.8629447969183, 3930.292547341506, 3937.1141493164096, 3947.4473573699706, 5519.282493275889, 5704.401037891003, 5753.079507278857, 5775.306963164405, 5795.971020144957, 4193.861130823241, 4227.0, 4239.597238262422, 4245.278302688489, 4253.936190957138, 4259.936100958488, 4282.379055037002, 4299.97850010748, 4305.138972205571, 4305.526392096866, 4695.460022097434, 4798.616110711135, 4801.911168641652, 4823.517648235148, 4832.782524786393, 5575.383138889677, 5577.274954256002, 5585.720713964285, 5593.74828132735, 5594.300712410949, 1476.9630759231104, 1478.9112653240625, 1491.6942026884462, 1491.8508149184995, 1494.2080697230485, 945.4610871803006, 975.5073687787622, 978.9021097890154, 993.5330394714473, 995.6813819577666, 5298.841034768963, 5307.203919412119, 5316.494932981361, 5332.33345831771, 5333.0, 5633.521150702154, 5635.520980716603, 5638.35158956717, 5643.730160713889, 5644.717764111778, 5138.97430512845, 5223.0, 5270.868228294324, 5303.443138470482, 5326.733663316819, 2898.6086878271585, 2917.679055303915, 2965.3920946205976, 3004.459197344499, 3008.127642983554, 5867.70661466925, 5874.353821079678, 5875.708473695262, 5885.676287804126, 5892.641194519083, 5590.385057643656, 5747.683877386784, 5816.912746308809, 5823.330317013598, 5826.31036999274, 5849.415058494116, 5854.385289544536, 5859.0, 5860.413958604106, 5871.324797648154, 5565.693886836263, 5612.466815652507, 5637.88724225505, 5673.234113394804, 5699.743511542073, 5401.891962160814, 5675.233843431084, 5680.147977803363, 5706.3152421709665, 5707.857303567444, 5893.876245589844, 5906.379830117776, 5916.0, 5924.644521328734, 5931.525477961839, 3955.92088158241, 4053.9797301013305, 4058.7970601470397, 4060.573639767782, 4087.6934229933468, 5664.971675141598, 5701.857453563694, 5714.457126572969, 5716.485516303553, 5717.771289148387, 5583.581231407742, 5584.134459158837, 5625.381208067028, 5625.381208067191, 5644.491995720405, 5427.968685949657, 5551.389347171727, 5556.111022236423, 5582.944170558242, 5606.159076138611, 5470.8358749235995, 5481.205225242397, 5498.285222920995, 5499.642523235977, 5514.696691681836, 5490.835274941598, 5583.218349431002, 5593.608447408805, 5594.188842617879, 5600.35595906476, 5457.672539647634, 5490.0, 5492.80775172867, 5497.340319161726, 5507.284053073075], "value": 4248.897474915353, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.9842503937401, 636.7484843486823, 642.9453496452801, 656.9441597464215, 718.4719231364946, 14315.785263221047, 14459.060161089521, 14580.416783328681, 14591.124532528043, 15300.00549964253, 13511.864881351183, 13537.458501659947, 13553.457861685545, 13609.523666671668, 13617.45530178794, 768.9730859419907, 792.8493586218628, 794.9443538952247, 794.964226609801, 796.6176235406979, 647.6340867409898, 665.9600423974578, 776.8057985503624, 794.964226609804, 800.1118758178417, 821.8520666280067, 824.3570015387977, 825.529448214518, 827.4662842466605, 828.0725587342185, 827.7516744976483, 827.7971896885301, 827.8302947895667, 827.9917200828005, 828.5567221536479, 502.2315856739195, 513.709753988995, 593.1547544748715, 598.467364045995, 607.7265230646227, 13802.792958105636, 13803.2408217548, 13853.722925541433, 13870.930645346709, 13915.791263131061, 12541.623751287476, 12758.80861787074, 13211.669708257274, 13223.603291901258, 13452.1256118352, 12244.81632775509, 12292.508299668003, 12360.505579776798, 12414.193077449936, 12468.189567678071, 3744.719146064029, 4279.5078565965005, 4297.505786834523, 4314.762688052156, 4329.545397733255, 70364.64817675878, 80941.0, 81008.9999999994, 81244.0, 81477.0, 9860.950695246622, 10815.513301901434, 10840.241183117107, 10998.450077496092, 11055.226134170693, 20044.799552004584, 20050.699239511418, 20310.08604612796, 20326.695099573517, 20327.0, 8465.111163327885, 8629.395942284105, 8637.352198585006, 8834.160754728291, 8837.911620883837, 4617.653675974316, 4620.745858977722, 4700.858974230779, 4707.764611769467, 4814.662973591815, 3360.1095709636966, 3475.2007038380807, 3484.5295885055193, 3487.232808782064, 3488.075659950115, 615.7444660465947, 622.2595111816923, 625.221599109103, 637.9266384365858, 666.5933780393956, 553.6097051578628, 571.977120915167, 576.1099101887594, 630.3412933484519, 632.2160520953984, 9747.805043899083, 9843.704688859345, 9924.136940008295, 9951.651692190739, 10057.29598928068, 559.932808063035, 574.2477354665401, 644.297715490118, 662.8409181796334, 663.3466035954581, 4502.189605870909, 4819.662623616383, 4832.371791667061, 4868.3427737255015, 4919.532644398776, 80300.59849700831, 125520.0, 126960.0, 131145.0, 132420.33789831182, 107515.0, 108008.45995769971, 108758.45620772004, 108800.0, 113453.0, 76350.61824690952, 78015.60992195003, 78514.21485785069, 87799.56100219458, 96074.0, 9079.68221112258, 9228.907710923073, 9462.195713364441, 9548.570314335733, 9669.371490853073, 50476.49523504865, 51790.74104629603, 52417.213741794665, 53085.46914530805, 53547.0, 73462.63268683836, 74159.0, 76681.22357721695, 76695.0, 79290.20709792829, 11828.52685892589, 12161.635150945485, 12401.689957750768, 12513.624591262276, 12628.747425051632, 13651.711538651913, 13799.03406761517, 13886.444542218198, 13971.301434928417, 14496.782548261574, 13169.670758231121, 13182.934085329513, 13550.728985420434, 13635.659108522366, 14082.859171408154, 11999.76000480003, 12120.939395302967, 12205.450754716237, 12241.510339586674, 12263.64640552591, 12722.300273485047, 13030.153040052366, 13183.604491865259, 13291.136076155019, 13376.598702038955, 10375.584976600852, 10418.426986515815, 10522.684319470429, 10543.736406589896, 10796.136309095096, 10927.180461465263, 11063.72340691489, 11149.386783726974, 11244.831327530257, 11247.493862776359], "value": 7316.218824866608, "unit": "score"}], "name": "dromaeo_css", "value": 7154.967085350506, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 110.0, 110.0, 111.0, 110.0, 109.0, 112.0, 110.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 126.0, 159.0, 125.0, 119.0, 117.0, 117.0, 150.0, 121.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 161.0, 162.0, 159.0, 161.0, 159.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 119.0, 76.0, 75.0, 75.0, 77.0, 102.0, 74.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 132.0, 82.0, 81.0, 81.0, 101.0, 83.0, 81.0, 112.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 51.0, 57.0, 52.0, 53.0, 52.0, 53.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 79.0, 83.0, 85.0, 78.0, 79.0, 78.0, 78.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 123.0, 124.0, 123.0, 133.0, 124.0, 130.0, 130.0, 157.0, 134.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 165.0, 163.0, 161.0, 162.0, 163.0, 164.0, 164.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 62.0, 65.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1485.2999999999997, "alertThreshold": 2.0}]} 03:40:15 INFO - Return code: 0 03:40:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:40:16 INFO - # TBPL SUCCESS # 03:40:16 INFO - Running post-action listener: _resource_record_post_action 03:40:16 INFO - [mozharness: 2016-09-26 10:40:16.008692Z] Finished run-tests step (success) 03:40:16 INFO - Running post-run listener: _resource_record_post_run 03:40:16 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392859648; Read time: 12; Write time: 287500 03:40:16 INFO - TinderboxPrint: CPU usage
13.0% 03:40:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:40:16 INFO - TinderboxPrint: I/O write bytes / time
392,859,648 / 287,500 03:40:16 INFO - TinderboxPrint: CPU idle
8,290.3 (86.9%) 03:40:16 INFO - TinderboxPrint: CPU user
1,195.6 (12.5%) 03:40:16 INFO - TinderboxPrint: Swap in / out
0 / 0 03:40:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103972864; Read time: 0; Write time: 92508 03:40:16 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288886784; Read time: 0; Write time: 194992 03:40:16 INFO - Running post-run listener: _upload_blobber_files 03:40:16 INFO - Blob upload gear active. 03:40:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:40:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:40:16 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:40:16 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:40:17 INFO - (blobuploader) - INFO - Open directory for files ... 03:40:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:40:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:40:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:21 INFO - (blobuploader) - INFO - Done attempting. 03:40:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:40:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:40:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:22 INFO - (blobuploader) - INFO - Done attempting. 03:40:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:40:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:40:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:22 INFO - (blobuploader) - INFO - Done attempting. 03:40:22 INFO - (blobuploader) - INFO - Iteration through files over. 03:40:22 INFO - Return code: 0 03:40:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:40:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:40:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2e8dc7366f4f38ac3050c541c90a1809a278773d6174f91d1a77a6dcbf188a56c36f92fbf27f33e66af244f365e935b9963abe5e83e77c955ba07093f26b5462", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9ced0b6f9e281841ad2139e716f34b62c34b2e51f651671e24d32ca2dd81d3703e601a98f4d6f461bd44be241983e6ffd33352acf7c73151e65af2d7d19d766b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e25b7ac1483fa7208b9419499de8b7d59a21597d8bbb4e0fe351809f4475af92d7e331b3f7df9d84f2570c767202bf2576aa0501b2cc12d2ff8aaf03c6697825"} 03:40:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:40:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:40:22 INFO - Contents: 03:40:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2e8dc7366f4f38ac3050c541c90a1809a278773d6174f91d1a77a6dcbf188a56c36f92fbf27f33e66af244f365e935b9963abe5e83e77c955ba07093f26b5462", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9ced0b6f9e281841ad2139e716f34b62c34b2e51f651671e24d32ca2dd81d3703e601a98f4d6f461bd44be241983e6ffd33352acf7c73151e65af2d7d19d766b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e25b7ac1483fa7208b9419499de8b7d59a21597d8bbb4e0fe351809f4475af92d7e331b3f7df9d84f2570c767202bf2576aa0501b2cc12d2ff8aaf03c6697825"} 03:40:22 INFO - Running post-run listener: copy_logs_to_upload_dir 03:40:22 INFO - Copying logs to upload dir... 03:40:22 INFO - mkdir: /builds/slave/test/build/upload/logs 03:40:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.596104 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-26 03:40:21.558704) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 03:40:21.562555) ========= 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=32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2e8dc7366f4f38ac3050c541c90a1809a278773d6174f91d1a77a6dcbf188a56c36f92fbf27f33e66af244f365e935b9963abe5e83e77c955ba07093f26b5462", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9ced0b6f9e281841ad2139e716f34b62c34b2e51f651671e24d32ca2dd81d3703e601a98f4d6f461bd44be241983e6ffd33352acf7c73151e65af2d7d19d766b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e25b7ac1483fa7208b9419499de8b7d59a21597d8bbb4e0fe351809f4475af92d7e331b3f7df9d84f2570c767202bf2576aa0501b2cc12d2ff8aaf03c6697825"} build_url:https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/PLJ-nA7cSU2rUwORJ30icw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2e8dc7366f4f38ac3050c541c90a1809a278773d6174f91d1a77a6dcbf188a56c36f92fbf27f33e66af244f365e935b9963abe5e83e77c955ba07093f26b5462", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9ced0b6f9e281841ad2139e716f34b62c34b2e51f651671e24d32ca2dd81d3703e601a98f4d6f461bd44be241983e6ffd33352acf7c73151e65af2d7d19d766b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e25b7ac1483fa7208b9419499de8b7d59a21597d8bbb4e0fe351809f4475af92d7e331b3f7df9d84f2570c767202bf2576aa0501b2cc12d2ff8aaf03c6697825"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 03:40:21.590687) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 03:40:21.590996) ========= 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=32c5991c409366f7fec8a718000001d2-1474884937.369247-1431402276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 03:40:21.672933) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 03:40:21.673250) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 03:40:21.673532) ========= ========= Total master_lag: 0.28 =========