builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1474538434.37 results: success (0) buildid: 20160922012859 builduid: 72cc20b40c7e4d86b8efad6cd2b9b178 revision: d527e405b0112b00ac8792967bab4d7bdbd821a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:34.368668) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:34.369086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:34.369377) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:34.422223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:34.422536) ========= 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=5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 03:00:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-09-22 03:00:35 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094788 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:34.548199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:34.548634) ========= 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=5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019922 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:34.602602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:34.602916) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d527e405b0112b00ac8792967bab4d7bdbd821a0 --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 d527e405b0112b00ac8792967bab4d7bdbd821a0 --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=5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 03:00:35,301 truncating revision to first 12 chars 2016-09-22 03:00:35,301 Setting DEBUG logging. 2016-09-22 03:00:35,302 attempt 1/10 2016-09-22 03:00:35,302 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d527e405b011?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 03:00:35,632 unpacking tar archive at: autoland-d527e405b011/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668335 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:35.289852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:35.290219) ========= script_repo_revision: d527e405b0112b00ac8792967bab4d7bdbd821a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:35.290698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:35.290997) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 03:00:35.341556) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-22 03:00:35.342202) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:00:36 INFO - MultiFileLogger online at 20160922 03:00:36 in /builds/slave/test 03:00:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 03:00:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:00:36 INFO - {'append_to_log': False, 03:00:36 INFO - 'base_work_dir': '/builds/slave/test', 03:00:36 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 03:00:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:00:36 INFO - 'branch': 'Autoland-Non-PGO', 03:00:36 INFO - 'buildbot_json_path': 'buildprops.json', 03:00:36 INFO - 'config_files': ('talos/linux_config.py',), 03:00:36 INFO - 'default_actions': ('clobber', 03:00:36 INFO - 'read-buildbot-config', 03:00:36 INFO - 'download-and-extract', 03:00:36 INFO - 'populate-webroot', 03:00:36 INFO - 'create-virtualenv', 03:00:36 INFO - 'install', 03:00:36 INFO - 'run-tests'), 03:00:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:00:36 INFO - 'download_minidump_stackwalk': True, 03:00:36 INFO - 'download_symbols': 'ondemand', 03:00:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:00:36 INFO - 'tooltool.py': '/tools/tooltool.py', 03:00:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:00:36 INFO - '/tools/misc-python/virtualenv.py')}, 03:00:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:00:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:00:36 INFO - 'installer_path': 'installer.exe', 03:00:36 INFO - 'log_level': 'info', 03:00:36 INFO - 'log_name': 'talos', 03:00:36 INFO - 'log_to_console': True, 03:00:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:00:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:00:36 INFO - 'opt_config_files': (), 03:00:36 INFO - 'pip_index': False, 03:00:36 INFO - 'sps_profile': False, 03:00:36 INFO - 'sps_profile_interval': 0, 03:00:36 INFO - 'suite': 'dromaeojs', 03:00:36 INFO - 'system_bits': '32', 03:00:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:00:36 INFO - 'title': 'talos-linux64-ix-039', 03:00:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:00:36 INFO - 'use_talos_json': True, 03:00:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:00:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:00:36 INFO - 'work_dir': 'build'} 03:00:36 INFO - [mozharness: 2016-09-22 10:00:36.145070Z] Running clobber step. 03:00:36 INFO - Running pre-action listener: _resource_record_pre_action 03:00:36 INFO - Running main action method: clobber 03:00:36 INFO - rmtree: /builds/slave/test/build 03:00:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:00:36 INFO - Running post-action listener: _resource_record_post_action 03:00:36 INFO - [mozharness: 2016-09-22 10:00:36.605148Z] Finished clobber step (success) 03:00:36 INFO - [mozharness: 2016-09-22 10:00:36.605261Z] Running read-buildbot-config step. 03:00:36 INFO - Running pre-action listener: _resource_record_pre_action 03:00:36 INFO - Running main action method: read_buildbot_config 03:00:36 INFO - Using buildbot properties: 03:00:36 INFO - { 03:00:36 INFO - "project": "", 03:00:36 INFO - "product": "firefox", 03:00:36 INFO - "script_repo_revision": "production", 03:00:36 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:00:36 INFO - "repository": "", 03:00:36 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 03:00:36 INFO - "buildid": "20160922012859", 03:00:36 INFO - "pgo_build": "False", 03:00:36 INFO - "basedir": "/builds/slave/test", 03:00:36 INFO - "buildnumber": 495, 03:00:36 INFO - "slavename": "talos-linux64-ix-039", 03:00:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:00:36 INFO - "platform": "ubuntu64_hw", 03:00:36 INFO - "scheduler": "tests-autoland-linux64-talos", 03:00:36 INFO - "branch": "autoland", 03:00:36 INFO - "repo_path": "integration/autoland", 03:00:36 INFO - "revision": "d527e405b0112b00ac8792967bab4d7bdbd821a0", 03:00:36 INFO - "stage_platform": "linux64", 03:00:36 INFO - "builduid": "72cc20b40c7e4d86b8efad6cd2b9b178", 03:00:36 INFO - "slavebuilddir": "test" 03:00:36 INFO - } 03:00:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:00:36 INFO - Running post-action listener: _resource_record_post_action 03:00:36 INFO - [mozharness: 2016-09-22 10:00:36.607758Z] Finished read-buildbot-config step (success) 03:00:36 INFO - [mozharness: 2016-09-22 10:00:36.607848Z] Running download-and-extract step. 03:00:36 INFO - Running pre-action listener: _resource_record_pre_action 03:00:36 INFO - Running main action method: download_and_extract 03:00:36 INFO - mkdir: /builds/slave/test/build/tests 03:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:36 INFO - trying https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:00:36 INFO - Downloading https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/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:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/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:00:37 INFO - Downloaded 1361 bytes. 03:00:37 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:00:37 INFO - Using the following test package requirements: 03:00:37 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:00:37 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:00:37 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:00:37 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:37 INFO - u'jsshell-linux-x86_64.zip'], 03:00:37 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:00:37 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:00:37 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:00:37 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:00:37 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:00:37 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:00:37 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:00:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:00:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:00:37 INFO - Fetch https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:00:37 INFO - Expected file size: 20372711 03:00:42 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:00:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:00:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:00:42 INFO - Fetch https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:00:42 INFO - Expected file size: 20372711 03:00:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:00:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:00:47 INFO - Fetch https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:00:47 INFO - Expected file size: 14414059 03:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:49 INFO - trying https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:00:49 INFO - Downloading https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/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:00:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/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:00:50 INFO - Downloaded 55618826 bytes. 03:00:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:00:50 INFO - mkdir: /builds/slave/test/properties 03:00:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:00:50 INFO - Writing to file /builds/slave/test/properties/build_url 03:00:50 INFO - Contents: 03:00:50 INFO - build_url:https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:00:51 INFO - Running post-action listener: _resource_record_post_action 03:00:51 INFO - Running post-action listener: set_extra_try_arguments 03:00:51 INFO - [mozharness: 2016-09-22 10:00:51.709822Z] Finished download-and-extract step (success) 03:00:51 INFO - [mozharness: 2016-09-22 10:00:51.710051Z] Running populate-webroot step. 03:00:51 INFO - Running pre-action listener: _resource_record_pre_action 03:00:51 INFO - Running main action method: populate_webroot 03:00:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:00:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:00:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:00:51 INFO - '--tppagecycles', 03:00:51 INFO - '7'], 03:00:51 INFO - 'tests': ['tsvgm']}}, 03:00:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:00:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:00:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:00:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:00:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:00:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:00:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:51 INFO - 'talos_options': ['--disable-e10s'], 03:00:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:51 INFO - 'talos_options': ['--disable-e10s'], 03:00:51 INFO - 'tests': ['damp', 'tps']}, 03:00:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:51 INFO - 'tests': ['damp', 'tps']}, 03:00:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:00:51 INFO - 'tests': ['dromaeo_dom']}, 03:00:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:00:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:00:51 INFO - 'tests': ['basic_compositor_video']}, 03:00:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:00:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:00:51 INFO - 'tests': ['a11yr', 03:00:51 INFO - 'ts_paint', 03:00:51 INFO - 'tpaint', 03:00:51 INFO - 'sessionrestore', 03:00:51 INFO - 'sessionrestore_no_auto_restore', 03:00:51 INFO - 'tabpaint']}, 03:00:51 INFO - 'other-e10s': {'tests': ['a11yr', 03:00:51 INFO - 'ts_paint', 03:00:51 INFO - 'tpaint', 03:00:51 INFO - 'sessionrestore', 03:00:51 INFO - 'sessionrestore_no_auto_restore', 03:00:51 INFO - 'tabpaint']}, 03:00:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:00:51 INFO - 'ts_paint', 03:00:51 INFO - 'tpaint', 03:00:51 INFO - 'sessionrestore', 03:00:51 INFO - 'sessionrestore_no_auto_restore', 03:00:51 INFO - 'tabpaint']}, 03:00:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:00:51 INFO - 'ts_paint', 03:00:51 INFO - 'tpaint', 03:00:51 INFO - 'sessionrestore', 03:00:51 INFO - 'sessionrestore_no_auto_restore', 03:00:51 INFO - 'tabpaint']}, 03:00:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:00:51 INFO - 'tests': ['a11yr', 03:00:51 INFO - 'ts_paint', 03:00:51 INFO - 'tpaint', 03:00:51 INFO - 'sessionrestore', 03:00:51 INFO - 'sessionrestore_no_auto_restore', 03:00:51 INFO - 'tabpaint']}, 03:00:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:00:51 INFO - 'tests': ['a11yr', 03:00:51 INFO - 'ts_paint', 03:00:51 INFO - 'tpaint', 03:00:51 INFO - 'sessionrestore', 03:00:51 INFO - 'sessionrestore_no_auto_restore', 03:00:51 INFO - 'tabpaint']}, 03:00:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:00:51 INFO - 'tests': ['tsvgx', 03:00:51 INFO - 'tsvgr_opacity', 03:00:51 INFO - 'tart', 03:00:51 INFO - 'tscrollx', 03:00:51 INFO - 'cart']}, 03:00:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:00:51 INFO - 'tsvgr_opacity', 03:00:51 INFO - 'tart', 03:00:51 INFO - 'tscrollx', 03:00:51 INFO - 'cart']}, 03:00:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:51 INFO - 'talos_options': ['--disable-e10s'], 03:00:51 INFO - 'tests': ['tp5o']}, 03:00:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:51 INFO - 'tests': ['tp5o']}, 03:00:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:51 INFO - 'talos_options': ['--disable-e10s', 03:00:51 INFO - '--xperf_path', 03:00:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:51 INFO - 'tests': ['tp5n']}, 03:00:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:51 INFO - 'talos_options': ['--xperf_path', 03:00:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:51 INFO - 'tests': ['tp5n']}}, 03:00:51 INFO - 'talos.zip': {'path': '', 03:00:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:00:51 INFO - Running post-action listener: _resource_record_post_action 03:00:51 INFO - [mozharness: 2016-09-22 10:00:51.727973Z] Finished populate-webroot step (success) 03:00:51 INFO - [mozharness: 2016-09-22 10:00:51.728062Z] Running create-virtualenv step. 03:00:51 INFO - Running pre-action listener: _resource_record_pre_action 03:00:51 INFO - Running main action method: create_virtualenv 03:00:51 INFO - Creating virtualenv /builds/slave/test/build/venv 03:00:51 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:00:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:00:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:00:51 INFO - Using real prefix '/usr' 03:00:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:00:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:00:54 INFO - Installing pip.................done. 03:00:54 INFO - Return code: 0 03:00:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f471ecf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e13f60>, '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 0x1e14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e151d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', '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:00:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:00:54 INFO - Using env: {'DISPLAY': ':0', 03:00:54 INFO - 'HOME': '/home/cltbld', 03:00:54 INFO - 'LANG': 'en_US.UTF-8', 03:00:54 INFO - 'LANGUAGE': 'en_US:en', 03:00:54 INFO - 'LOGNAME': 'cltbld', 03:00:54 INFO - 'MAIL': '/var/mail/cltbld', 03:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:54 INFO - 'MOZ_NO_REMOTE': '1', 03:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:54 INFO - 'NO_EM_RESTART': '1', 03:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:54 INFO - 'PWD': '/builds/slave/test', 03:00:54 INFO - 'SHELL': '/bin/bash', 03:00:54 INFO - 'SHLVL': '1', 03:00:54 INFO - 'TERM': 'linux', 03:00:54 INFO - 'TMOUT': '86400', 03:00:54 INFO - 'USER': 'cltbld', 03:00:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', 03:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:54 INFO - '_': '/tools/buildbot/bin/python'} 03:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:54 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:00:54 INFO - Cleaning up... 03:00:54 INFO - Return code: 0 03:00:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f471ecf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e13f60>, '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 0x1e14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e151d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', '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:00:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:00:54 INFO - Using env: {'DISPLAY': ':0', 03:00:54 INFO - 'HOME': '/home/cltbld', 03:00:54 INFO - 'LANG': 'en_US.UTF-8', 03:00:54 INFO - 'LANGUAGE': 'en_US:en', 03:00:54 INFO - 'LOGNAME': 'cltbld', 03:00:54 INFO - 'MAIL': '/var/mail/cltbld', 03:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:54 INFO - 'MOZ_NO_REMOTE': '1', 03:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:54 INFO - 'NO_EM_RESTART': '1', 03:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:54 INFO - 'PWD': '/builds/slave/test', 03:00:54 INFO - 'SHELL': '/bin/bash', 03:00:54 INFO - 'SHLVL': '1', 03:00:54 INFO - 'TERM': 'linux', 03:00:54 INFO - 'TMOUT': '86400', 03:00:54 INFO - 'USER': 'cltbld', 03:00:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', 03:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:54 INFO - '_': '/tools/buildbot/bin/python'} 03:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:54 INFO - Downloading/unpacking psutil>=3.1.1 03:00:54 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:00:54 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:00:54 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:00:54 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:00:54 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:00:54 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:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:56 INFO - Installing collected packages: psutil 03:00:56 INFO - Running setup.py install for psutil 03:00:56 INFO - building 'psutil._psutil_linux' extension 03:00:56 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:00:56 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:00:56 INFO - building 'psutil._psutil_posix' extension 03:00:56 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:00:57 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:00:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:57 INFO - Successfully installed psutil 03:00:57 INFO - Cleaning up... 03:00:57 INFO - Return code: 0 03:00:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f471ecf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e13f60>, '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 0x1e14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e151d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', '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:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:00:57 INFO - Using env: {'DISPLAY': ':0', 03:00:57 INFO - 'HOME': '/home/cltbld', 03:00:57 INFO - 'LANG': 'en_US.UTF-8', 03:00:57 INFO - 'LANGUAGE': 'en_US:en', 03:00:57 INFO - 'LOGNAME': 'cltbld', 03:00:57 INFO - 'MAIL': '/var/mail/cltbld', 03:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:57 INFO - 'MOZ_NO_REMOTE': '1', 03:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:57 INFO - 'NO_EM_RESTART': '1', 03:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:57 INFO - 'PWD': '/builds/slave/test', 03:00:57 INFO - 'SHELL': '/bin/bash', 03:00:57 INFO - 'SHLVL': '1', 03:00:57 INFO - 'TERM': 'linux', 03:00:57 INFO - 'TMOUT': '86400', 03:00:57 INFO - 'USER': 'cltbld', 03:00:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', 03:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:57 INFO - '_': '/tools/buildbot/bin/python'} 03:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:00:59 INFO - Installing collected packages: mozsystemmonitor 03:00:59 INFO - Running setup.py install for mozsystemmonitor 03:00:59 INFO - Successfully installed mozsystemmonitor 03:00:59 INFO - Cleaning up... 03:00:59 INFO - Return code: 0 03:00:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f471ecf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e13f60>, '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 0x1e14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e151d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', '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:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:00:59 INFO - Using env: {'DISPLAY': ':0', 03:00:59 INFO - 'HOME': '/home/cltbld', 03:00:59 INFO - 'LANG': 'en_US.UTF-8', 03:00:59 INFO - 'LANGUAGE': 'en_US:en', 03:00:59 INFO - 'LOGNAME': 'cltbld', 03:00:59 INFO - 'MAIL': '/var/mail/cltbld', 03:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:59 INFO - 'MOZ_NO_REMOTE': '1', 03:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:59 INFO - 'NO_EM_RESTART': '1', 03:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:59 INFO - 'PWD': '/builds/slave/test', 03:00:59 INFO - 'SHELL': '/bin/bash', 03:00:59 INFO - 'SHLVL': '1', 03:00:59 INFO - 'TERM': 'linux', 03:00:59 INFO - 'TMOUT': '86400', 03:00:59 INFO - 'USER': 'cltbld', 03:00:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', 03:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:59 INFO - '_': '/tools/buildbot/bin/python'} 03:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:59 INFO - Downloading/unpacking jsonschema==2.5.1 03:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:01:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:01:02 INFO - warning: no files found matching '*.txt' 03:01:02 INFO - no previously-included directories found matching 'build' 03:01:02 INFO - no previously-included directories found matching 'dist' 03:01:02 INFO - no previously-included directories found matching '.git*' 03:01:02 INFO - Installing collected packages: jsonschema, functools32 03:01:03 INFO - Running setup.py install for functools32 03:01:03 INFO - warning: no files found matching '*.txt' 03:01:03 INFO - no previously-included directories found matching 'build' 03:01:03 INFO - no previously-included directories found matching 'dist' 03:01:03 INFO - no previously-included directories found matching '.git*' 03:01:03 INFO - Successfully installed jsonschema functools32 03:01:03 INFO - Cleaning up... 03:01:03 INFO - Return code: 0 03:01:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:03 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 0x7f471ecf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e13f60>, '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 0x1e14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e151d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', '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:01:03 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:01:03 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:01:03 INFO - Using env: {'DISPLAY': ':0', 03:01:03 INFO - 'HOME': '/home/cltbld', 03:01:03 INFO - 'LANG': 'en_US.UTF-8', 03:01:03 INFO - 'LANGUAGE': 'en_US:en', 03:01:03 INFO - 'LOGNAME': 'cltbld', 03:01:03 INFO - 'MAIL': '/var/mail/cltbld', 03:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:03 INFO - 'MOZ_NO_REMOTE': '1', 03:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:03 INFO - 'NO_EM_RESTART': '1', 03:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:03 INFO - 'PWD': '/builds/slave/test', 03:01:03 INFO - 'SHELL': '/bin/bash', 03:01:03 INFO - 'SHLVL': '1', 03:01:03 INFO - 'TERM': 'linux', 03:01:03 INFO - 'TMOUT': '86400', 03:01:03 INFO - 'USER': 'cltbld', 03:01:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', 03:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:03 INFO - '_': '/tools/buildbot/bin/python'} 03:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:01:03 INFO - Cleaning up... 03:01:03 INFO - Return code: 0 03:01:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:03 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 0x7f471ecf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e13f60>, '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 0x1e14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e151d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', '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:01:03 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:01:03 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:01:03 INFO - Using env: {'DISPLAY': ':0', 03:01:03 INFO - 'HOME': '/home/cltbld', 03:01:03 INFO - 'LANG': 'en_US.UTF-8', 03:01:03 INFO - 'LANGUAGE': 'en_US:en', 03:01:03 INFO - 'LOGNAME': 'cltbld', 03:01:03 INFO - 'MAIL': '/var/mail/cltbld', 03:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:03 INFO - 'MOZ_NO_REMOTE': '1', 03:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:03 INFO - 'NO_EM_RESTART': '1', 03:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:03 INFO - 'PWD': '/builds/slave/test', 03:01:03 INFO - 'SHELL': '/bin/bash', 03:01:03 INFO - 'SHLVL': '1', 03:01:03 INFO - 'TERM': 'linux', 03:01:03 INFO - 'TMOUT': '86400', 03:01:03 INFO - 'USER': 'cltbld', 03:01:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', 03:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:03 INFO - '_': '/tools/buildbot/bin/python'} 03:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:01:03 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:01:03 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:01:03 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:01:03 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:01:03 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:01:03 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:01:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:01:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:01:05 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:01:05 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:01:05 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:01:05 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:01:05 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:01:05 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:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:01:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:01:05 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:01:05 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:01:05 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:01:05 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:01:05 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:01:05 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:01:06 INFO - Downloading docopt-0.6.1.tar.gz 03:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:01:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:01:06 INFO - Running setup.py install for blobuploader 03:01:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:01:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:01:06 INFO - Running setup.py install for requests 03:01:06 INFO - Running setup.py install for docopt 03:01:06 INFO - Successfully installed blobuploader requests docopt 03:01:06 INFO - Cleaning up... 03:01:06 INFO - Return code: 0 03:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01: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:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:06 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 0x7f471ecf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e13f60>, '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 0x1e14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e151d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', '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:01:06 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:01:06 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:01:06 INFO - Using env: {'DISPLAY': ':0', 03:01:06 INFO - 'HOME': '/home/cltbld', 03:01:06 INFO - 'LANG': 'en_US.UTF-8', 03:01:06 INFO - 'LANGUAGE': 'en_US:en', 03:01:06 INFO - 'LOGNAME': 'cltbld', 03:01:06 INFO - 'MAIL': '/var/mail/cltbld', 03:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:06 INFO - 'MOZ_NO_REMOTE': '1', 03:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:06 INFO - 'NO_EM_RESTART': '1', 03:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:06 INFO - 'PWD': '/builds/slave/test', 03:01:06 INFO - 'SHELL': '/bin/bash', 03:01:06 INFO - 'SHLVL': '1', 03:01:06 INFO - 'TERM': 'linux', 03:01:06 INFO - 'TMOUT': '86400', 03:01:06 INFO - 'USER': 'cltbld', 03:01:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', 03:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:06 INFO - '_': '/tools/buildbot/bin/python'} 03:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:07 INFO - Running setup.py (path:/tmp/pip-aZW_jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:07 INFO - Running setup.py (path:/tmp/pip-4wJZz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:07 INFO - Running setup.py (path:/tmp/pip-NVh63v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:07 INFO - Running setup.py (path:/tmp/pip-e6qUKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:07 INFO - Running setup.py (path:/tmp/pip-ioVrQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:07 INFO - Running setup.py (path:/tmp/pip-650V5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:07 INFO - Running setup.py (path:/tmp/pip-18_mPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:07 INFO - Running setup.py (path:/tmp/pip-IOxUwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:07 INFO - Running setup.py (path:/tmp/pip-SAf37N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:07 INFO - Running setup.py (path:/tmp/pip-Fkkzc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:07 INFO - Running setup.py (path:/tmp/pip-YSD_jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:07 INFO - Running setup.py (path:/tmp/pip-5qO2lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:07 INFO - Running setup.py (path:/tmp/pip-e2PILh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:07 INFO - Running setup.py (path:/tmp/pip-EZzNZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:08 INFO - Running setup.py (path:/tmp/pip-IeijUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:08 INFO - Running setup.py (path:/tmp/pip-PyU6Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:08 INFO - Running setup.py (path:/tmp/pip-eFIOSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:01:08 INFO - Running setup.py install for manifestparser 03:01:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:01:08 INFO - Running setup.py install for mozcrash 03:01:08 INFO - Running setup.py install for mozdebug 03:01:08 INFO - Running setup.py install for mozdevice 03:01:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:01:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:01:08 INFO - Running setup.py install for mozfile 03:01:08 INFO - Running setup.py install for mozhttpd 03:01:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:01:08 INFO - Running setup.py install for mozinfo 03:01:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:01:08 INFO - Running setup.py install for mozInstall 03:01:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:01:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:01:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:01:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:01:09 INFO - Running setup.py install for mozleak 03:01:09 INFO - Running setup.py install for mozlog 03:01:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:01:09 INFO - Running setup.py install for moznetwork 03:01:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:01:09 INFO - Running setup.py install for mozprocess 03:01:09 INFO - Running setup.py install for mozprofile 03:01:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:01:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:01:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:01:09 INFO - Running setup.py install for mozrunner 03:01:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:01:09 INFO - Running setup.py install for mozscreenshot 03:01:09 INFO - Running setup.py install for moztest 03:01:09 INFO - Running setup.py install for mozversion 03:01:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:01:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:01:10 INFO - Cleaning up... 03:01:10 INFO - Return code: 0 03:01:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:10 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 0x7f471ecf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e13f60>, '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 0x1e14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e151d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', '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:01:10 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:01:10 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:01:10 INFO - Using env: {'DISPLAY': ':0', 03:01:10 INFO - 'HOME': '/home/cltbld', 03:01:10 INFO - 'LANG': 'en_US.UTF-8', 03:01:10 INFO - 'LANGUAGE': 'en_US:en', 03:01:10 INFO - 'LOGNAME': 'cltbld', 03:01:10 INFO - 'MAIL': '/var/mail/cltbld', 03:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:10 INFO - 'MOZ_NO_REMOTE': '1', 03:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:10 INFO - 'NO_EM_RESTART': '1', 03:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:10 INFO - 'PWD': '/builds/slave/test', 03:01:10 INFO - 'SHELL': '/bin/bash', 03:01:10 INFO - 'SHLVL': '1', 03:01:10 INFO - 'TERM': 'linux', 03:01:10 INFO - 'TMOUT': '86400', 03:01:10 INFO - 'USER': 'cltbld', 03:01:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', 03:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:10 INFO - '_': '/tools/buildbot/bin/python'} 03:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:10 INFO - Running setup.py (path:/tmp/pip-at4ZFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:10 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:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:10 INFO - Running setup.py (path:/tmp/pip-ShlrmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:10 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:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:10 INFO - Running setup.py (path:/tmp/pip-Bsa88F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:10 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:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:10 INFO - Running setup.py (path:/tmp/pip-O6pnnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:10 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:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:10 INFO - Running setup.py (path:/tmp/pip-d83nUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:10 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:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:10 INFO - Running setup.py (path:/tmp/pip-KbKEop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:10 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:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:10 INFO - Running setup.py (path:/tmp/pip-zlZf_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:10 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:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:10 INFO - Running setup.py (path:/tmp/pip-Ok5C6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:10 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:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:10 INFO - Running setup.py (path:/tmp/pip-6g7u4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:10 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:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:10 INFO - Running setup.py (path:/tmp/pip-fZqQus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:11 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:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:11 INFO - Running setup.py (path:/tmp/pip-P6MoiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:11 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:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:11 INFO - Running setup.py (path:/tmp/pip-6G5tGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:11 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:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:11 INFO - Running setup.py (path:/tmp/pip-V9d_AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:11 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:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:11 INFO - Running setup.py (path:/tmp/pip-Ips6n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:11 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:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:11 INFO - Running setup.py (path:/tmp/pip-6NcEd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:11 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:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:11 INFO - Running setup.py (path:/tmp/pip-Yr51wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:11 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:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:11 INFO - Running setup.py (path:/tmp/pip-DIKsRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:11 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:01:11 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:01:11 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:01:11 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:01:11 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:01:11 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:01:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:01: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:01: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:01: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:01: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:01: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:01: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:01:13 INFO - Downloading blessings-1.6.tar.gz 03:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:01:13 INFO - Installing collected packages: blessings 03:01:13 INFO - Running setup.py install for blessings 03:01:13 INFO - Successfully installed blessings 03:01:13 INFO - Cleaning up... 03:01:13 INFO - Return code: 0 03:01:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:01:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:13 INFO - Reading from file tmpfile_stdout 03:01:13 INFO - Current package versions: 03:01:13 INFO - argparse == 1.2.1 03:01:13 INFO - blessings == 1.6 03:01:13 INFO - blobuploader == 1.2.4 03:01:13 INFO - docopt == 0.6.1 03:01:13 INFO - functools32 == 3.2.3-2 03:01:13 INFO - jsonschema == 2.5.1 03:01:13 INFO - manifestparser == 1.1 03:01:13 INFO - mozInstall == 1.12 03:01:13 INFO - mozcrash == 0.17 03:01:13 INFO - mozdebug == 0.1 03:01:13 INFO - mozdevice == 0.48 03:01:13 INFO - mozfile == 1.2 03:01:13 INFO - mozhttpd == 0.7 03:01:13 INFO - mozinfo == 0.9 03:01:13 INFO - mozleak == 0.1 03:01:13 INFO - mozlog == 3.4 03:01:13 INFO - moznetwork == 0.27 03:01:13 INFO - mozprocess == 0.23 03:01:13 INFO - mozprofile == 0.28 03:01:13 INFO - mozrunner == 6.12 03:01:13 INFO - mozscreenshot == 0.1 03:01:13 INFO - mozsystemmonitor == 0.3 03:01:13 INFO - moztest == 0.7 03:01:13 INFO - mozversion == 1.4 03:01:13 INFO - psutil == 3.1.1 03:01:13 INFO - requests == 1.2.3 03:01:13 INFO - wsgiref == 0.1.2 03:01:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01: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:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:13 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 0x7f471ecf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e13f60>, '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 0x1e14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e151d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', '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:01:13 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:01:13 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:01:13 INFO - Using env: {'DISPLAY': ':0', 03:01:13 INFO - 'HOME': '/home/cltbld', 03:01:13 INFO - 'LANG': 'en_US.UTF-8', 03:01:13 INFO - 'LANGUAGE': 'en_US:en', 03:01:13 INFO - 'LOGNAME': 'cltbld', 03:01:13 INFO - 'MAIL': '/var/mail/cltbld', 03:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:13 INFO - 'MOZ_NO_REMOTE': '1', 03:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:13 INFO - 'NO_EM_RESTART': '1', 03:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:13 INFO - 'PWD': '/builds/slave/test', 03:01:13 INFO - 'SHELL': '/bin/bash', 03:01:13 INFO - 'SHLVL': '1', 03:01:13 INFO - 'TERM': 'linux', 03:01:13 INFO - 'TMOUT': '86400', 03:01:13 INFO - 'USER': 'cltbld', 03:01:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', 03:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:13 INFO - '_': '/tools/buildbot/bin/python'} 03:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:14 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:01:14 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:01:14 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:01:14 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:01:14 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:01:14 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:01:14 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:01:14 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:01:14 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:01:14 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:01:14 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:01:14 INFO - Cleaning up... 03:01:14 INFO - Return code: 0 03:01:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:01:14 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:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:14 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:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:14 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 0x7f471ecf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e13f60>, '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 0x1e14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e151d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', '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:01:14 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:01:14 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:01:14 INFO - Using env: {'DISPLAY': ':0', 03:01:14 INFO - 'HOME': '/home/cltbld', 03:01:14 INFO - 'LANG': 'en_US.UTF-8', 03:01:14 INFO - 'LANGUAGE': 'en_US:en', 03:01:14 INFO - 'LOGNAME': 'cltbld', 03:01:14 INFO - 'MAIL': '/var/mail/cltbld', 03:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:14 INFO - 'MOZ_NO_REMOTE': '1', 03:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:14 INFO - 'NO_EM_RESTART': '1', 03:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:14 INFO - 'PWD': '/builds/slave/test', 03:01:14 INFO - 'SHELL': '/bin/bash', 03:01:14 INFO - 'SHLVL': '1', 03:01:14 INFO - 'TERM': 'linux', 03:01:14 INFO - 'TMOUT': '86400', 03:01:14 INFO - 'USER': 'cltbld', 03:01:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', 03:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:14 INFO - '_': '/tools/buildbot/bin/python'} 03:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:01:14 INFO - Cleaning up... 03:01:14 INFO - Return code: 0 03:01:14 INFO - Running post-action listener: _resource_record_post_action 03:01:14 INFO - Running post-action listener: _start_resource_monitoring 03:01:14 INFO - Starting resource monitoring. 03:01:14 INFO - [mozharness: 2016-09-22 10:01:14.342693Z] Finished create-virtualenv step (success) 03:01:14 INFO - [mozharness: 2016-09-22 10:01:14.343151Z] Running install step. 03:01:14 INFO - Running pre-action listener: _resource_record_pre_action 03:01:14 INFO - Running main action method: install 03:01:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:14 INFO - Reading from file tmpfile_stdout 03:01:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:01:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:01:14 INFO - Reading from file tmpfile_stdout 03:01:14 INFO - Output received: 03:01:14 INFO - Usage: mozinstall [options] installer 03:01:14 INFO - Options: 03:01:14 INFO - -h, --help show this help message and exit 03:01:14 INFO - -d DEST, --destination=DEST 03:01:14 INFO - Directory to install application into. [default: 03:01:14 INFO - "/builds/slave/test"] 03:01:14 INFO - --app=APP Application being installed. [default: firefox] 03:01:14 INFO - mkdir: /builds/slave/test/build/application 03:01:14 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:01:14 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:01:31 INFO - Reading from file tmpfile_stdout 03:01:31 INFO - Output received: 03:01:31 INFO - /builds/slave/test/build/application/firefox/firefox 03:01:31 INFO - Running post-action listener: _resource_record_post_action 03:01:31 INFO - [mozharness: 2016-09-22 10:01:31.695705Z] Finished install step (success) 03:01:31 INFO - [mozharness: 2016-09-22 10:01:31.695951Z] Running run-tests step. 03:01:31 INFO - Running pre-action listener: _resource_record_pre_action 03:01:31 INFO - Running main action method: run_tests 03:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:01:31 INFO - Python 2.7.3 03:01:31 INFO - Return code: 0 03:01:31 INFO - grabbing minidump binary from tooltool 03:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:31 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 0x1e13f60>, '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 0x1e14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e151d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:01:31 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:01:31 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:01:31 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:01:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:01:31 INFO - Return code: 0 03:01:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:01:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:01:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:01:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:01:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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:01:31 INFO - Using env: {'DISPLAY': ':0', 03:01:31 INFO - 'HOME': '/home/cltbld', 03:01:31 INFO - 'LANG': 'en_US.UTF-8', 03:01:31 INFO - 'LANGUAGE': 'en_US:en', 03:01:31 INFO - 'LOGNAME': 'cltbld', 03:01:31 INFO - 'MAIL': '/var/mail/cltbld', 03:01:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:01:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:31 INFO - 'MOZ_NO_REMOTE': '1', 03:01:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:31 INFO - 'NO_EM_RESTART': '1', 03:01:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:31 INFO - 'PWD': '/builds/slave/test', 03:01:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:01:31 INFO - 'SHELL': '/bin/bash', 03:01:31 INFO - 'SHLVL': '1', 03:01:31 INFO - 'TERM': 'linux', 03:01:31 INFO - 'TMOUT': '86400', 03:01:31 INFO - 'USER': 'cltbld', 03:01:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563', 03:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:31 INFO - '_': '/tools/buildbot/bin/python'} 03:01:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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:01:31 INFO - mozversion application_buildid: 20160922012859 03:01:31 INFO - mozversion application_changeset: d527e405b0112b00ac8792967bab4d7bdbd821a0 03:01:31 INFO - mozversion application_display_name: Nightly 03:01:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:01:31 INFO - mozversion application_name: Firefox 03:01:31 INFO - mozversion application_remotingname: firefox 03:01:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:01:31 INFO - mozversion application_vendor: Mozilla 03:01:31 INFO - mozversion application_version: 52.0a1 03:01:31 INFO - mozversion platform_buildid: 20160922012859 03:01:31 INFO - mozversion platform_changeset: d527e405b0112b00ac8792967bab4d7bdbd821a0 03:01:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:01:31 INFO - mozversion platform_version: 52.0a1 03:01:31 INFO - using testdate: 1474538491 03:01:31 INFO - actual date: 1474538491 03:01:31 INFO - starting webserver on 'localhost:44385' 03:01:31 INFO - SUITE-START | Running 2 tests 03:01:31 INFO - TEST-START | dromaeo_css 03:01:31 INFO - operating with platform_type : linux_ 03:01:31 INFO - Initialising browser for dromaeo_css test... 03:01:31 INFO - TEST-INFO | started process 23657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp24txuv/profile http://localhost:44385/getInfo.html) 03:01:36 INFO - PROCESS | 23657 | __metrics Screen width/height:1600/1200 03:01:36 INFO - PROCESS | 23657 | colorDepth:24 03:01:36 INFO - PROCESS | 23657 | Browser inner width/height: 1024/697 03:01:36 INFO - PROCESS | 23657 | __metrics 03:01:37 INFO - PROCESS | 23657 | 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:01:37 INFO - PROCESS | 23657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:01:37 INFO - PROCESS | 23657 | console.error: PushService: 03:01:37 INFO - PROCESS | 23657 | stateChangeProcessEnqueue: Error transitioning state 03:01:37 INFO - PROCESS | 23657 | UnknownError 03:01:38 INFO - TEST-INFO | 23657: exit 0 03:01:38 INFO - Browser initialized. 03:01:38 INFO - Running cycle 1/1 for dromaeo_css test... 03:01:38 INFO - TEST-INFO | started process 23740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp24txuv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:50 INFO - PROCESS | 23740 | RSS: Main: 175415296 03:01:50 INFO - PROCESS | 23740 | 03:02:41 INFO - PROCESS | 23740 | 1474538561593 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:04:54 INFO - PROCESS | 23740 | Cycle 1(1): loaded http://localhost:44385/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44385/tests/dromaeo/cssquery-ext.html) 03:04:55 INFO - PROCESS | 23740 | RSS: Main: 307625984 03:04:55 INFO - PROCESS | 23740 | 03:07:58 INFO - PROCESS | 23740 | Cycle 1(1): loaded http://localhost:44385/tests/dromaeo/cssquery-ext.html (next: http://localhost:44385/tests/dromaeo/cssquery-jquery.html) 03:07:59 INFO - PROCESS | 23740 | RSS: Main: 277475328 03:07:59 INFO - PROCESS | 23740 | 03:11:01 INFO - PROCESS | 23740 | Cycle 1(1): loaded http://localhost:44385/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44385/tests/dromaeo/cssquery-mootools.html) 03:11:02 INFO - PROCESS | 23740 | RSS: Main: 219701248 03:11:02 INFO - PROCESS | 23740 | 03:14:04 INFO - PROCESS | 23740 | Cycle 1(1): loaded http://localhost:44385/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44385/tests/dromaeo/cssquery-prototype.html) 03:14:05 INFO - PROCESS | 23740 | RSS: Main: 218791936 03:14:05 INFO - PROCESS | 23740 | 03:17:08 INFO - PROCESS | 23740 | Cycle 1(1): loaded http://localhost:44385/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44385/tests/dromaeo/cssquery-yui.html) 03:17:08 INFO - PROCESS | 23740 | RSS: Main: 219394048 03:17:08 INFO - PROCESS | 23740 | 03:20:11 INFO - PROCESS | 23740 | Cycle 1(1): loaded http://localhost:44385/tests/dromaeo/cssquery-yui.html (next: http://localhost:44385/tests/dromaeo/cssquery-dojo.html) 03:20:12 INFO - PROCESS | 23740 | RSS: Main: 305094656 03:20:12 INFO - PROCESS | 23740 | 03:20:12 INFO - PROCESS | 23740 | __start_tp_report 03:20:12 INFO - PROCESS | 23740 | _x_x_mozilla_page_load 03:20:12 INFO - PROCESS | 23740 | _x_x_mozilla_page_load_details 03:20:12 INFO - PROCESS | 23740 | |i|pagename|runs| 03:20:12 INFO - PROCESS | 23740 | |0;dojo.html;2570.8200425970185;2609.1781088956964;2636.9868150659245;2638.6174004769305;2655.96016059759;4501.90996180077;4593.862184134473;4693.671442998992;4726.929096063557;4741.928871066937;4527.230370836965;4612.377329060576;4675.672702910789;4701.27130294804;4703.082898834728;4125.938110928339;4173;4196.475440569929;4197.202531519017;4294.355846623016;3781.9054523636855;4271;4315.395844581761;4317.395564620955;4372.344148377737;4167.6457501112445;4216.662666986634;4312.878651550588;4386.4736231652405;4402.647788176954;4249.702520823544;4292.334688123346;4316.935245971313;4327;4337.891552711208;4296.419983302246;4338.869833904988;4342.174986752507;4370.759608221547;4398.494173170095;4575.725456472589;4693.366395536593;4725.763711814396;4730.2431610942085;4751.548602882721;4935.901281974377;4953.356063711731;5005.074061298671;5015.423226328982;5079.847604571869;4993.126202914512;5003.099442100421;5014.498550144993;5014.949850501484;5074.568661663763;4682.1103990241745;4688.835890743808;4692.6245900327895;4700.600448961808;4746.121967436035;4931.50684931504;4983.800647974041;5090.898182036339;5100.515451032146;5140.511651393112;4869.844691979128;4872.269159626014;4876.463589005207;4928.0390323886495;4980.576650984634;5013.373328333958;5015.523525265094;5019.447860735316;5029.497050295015;5074.264231686385;4830.420349558076;4888.144574699413;4906.31311616374;4913.410390753133;5028.874278143076;4893.119238537026;4905;4906.975465122651;4949.133901567211;4964.329815474937;4137.793110344471;4139.4204811326435;4143.875683729493;4177.540470548237;4190.161967606491;3608.891733248007;3615.023943535231;3635.4001589737927;3650.2699460108083;3705.7220708446976;4315.546867578922;4334.869953901388;4387;4398.780060996937;4413.602775750198;5042.823501177441;5044.646874718735;5047.4952504749235;5048.16705243638;5112.437631860493;4365.563443655673;4369.541198174209;4375.890602734893;4397.934030989538;4403.8238470461465;4368.126374725068;4387.100644367961;4387.846425375096;4441.444819397575;4502.977485112619;4702.576768090888;4702.76486175683;4703.012367402747;4710.222813235846;4712.387389639325;4975.776090076028;4976.950230497793;4977.676451030671;4981.975090124672;5037.471065538066;4635.142498637762;4672.392588963549;4682.953170468251;4689.085628302449;4754.857354279377;4895.46149923501;4922.237053256751;4923.975380123076;4975.402951645826;4987.551120399182;4984.102861484967;4984.451710311935;4998.025385050026;4998.950010499849;5022.924656130088;4744.240921452551;4791.281307803857;4819.95180048195;4861.51384861511;4865.0756356292195;4815.253635686474;4846.17615005457;4857;4877.95122048775;4891.217405215149;4725.6219502439035;4766.737829419415;4770.5944994674455;4772.642051846195;4785.210440277316;4812.735299558558;4868.902621947612;4872.269159626085;4888.2911977762315;4953.777080031336;4781.593564547053;4819.614430845594;4848.418189817104;4895.290182923527;4897.41231052276 03:20:12 INFO - PROCESS | 23740 | |1;ext.html;556.7327682712298;564.2157401212313;576.7433492096017;577.5639392258846;579.6319337220868;28136.718632813667;39117.413238801404;39857.40213896794;39952.400713989315;43675.56324436763;39529.20941581174;39911.60088399115;39915.40126898099;39954.80022599883;39959;7709;7855.8036049098655;7861.371090312761;7862.606869656494;7862.842743145134;7228.349448549629;7440.330370266675;9856.359336643096;10098.394096354206;10109.090181883628;10076.496175191247;10151.23865710071;10151.934046925076;10158.492075396238;10158.59365625374;9929.156021738161;10001.949990250003;10008.749781255454;10013.549390277454;10019.098281154658;9882.35764675301;9942.353747006422;9952.203823694088;9953.90046099537;9955.850662240073;37411.25177496462;37568.24863502742;37708;37744.24511509755;37800;2858.771298296131;2942.440936222111;2972.509535926591;3097.9241429902713;3177;28576.714232857612;30519.237019074702;31007;31312.686873131206;31372.372552548823;3536.929261414783;3555.982220088909;3557;3688.3729765939856;3774.8867533974026;245267;245640;247250;247463;247505;52783.208251876255;53341.1998820018;53408;53413.465865341626;53476.465235347925;29869.253268668457;30280.54579181314;30309.393812124075;32551;56847.863042738914;13533.323333833268;13616.046876718732;13617.727645447234;13642.658933526742;13657.521986730417;9871.802563948824;11259;11333.26333788301;11347.829782553268;11349.602763903224;15292.464763733216;17372.913135434494;17958.19188136537;18051.368202112862;18275.63448731018;6559.770408035792;6787.762428314985;6875.312468753084;7041.260667629927;7068.787936361918;761.5354633673455;797.1271457753751;892.3396686451979;903.1375036839802;952.9475878826731;26672;27901.302467438476;28435.573466398022;28840.278993025342;28993.56509652357;921.1065266691298;930.3627015494408;969.539468752337;1007.6221416968637;1039.6361273554346;14298.213598251989;14865.182414967281;14957.177355245565;15245.771313430307;15254.161021143944;375752;379587;380733;380842;380847;48453.27320090202;48851.26723099085;49003.50996490061;49024;49064.7546762271;1054.8892366301427;1062.3201151263197;1123.7808627317759;1137.4995002199005;1138.2203190814319;27535;29294.26764330909;29329.853350733963;29606;30579.847100764353;41340.586594134875;41907;41969.580304197785;42007.57992420159;42044.78977605092;278910;280925;282366.1752133544;282900;364320;36068.63931360758;38432.615673842905;38644.227115458096;38730.4190437138;39029.80485097556;41590.58409415867;42015.7899210502;42322.153556929305;42372.78813606036;42687;35901;36135.27729445449;36206.818965905004;36312.27375452529;36736.63263367439;36601.81699091594;36938.44592331063;37136.25727485489;37928.24143517059;38316.61683383131;35592;35795.82102089473;36241.27517449584;36715.81642091773;37166;31858;33810.15474613154;34531.827340863136;34539;37746.62253377431;28107.156785296473;28423.28941776472;30958.22604434907;31094.844525777225;31707 03:20:12 INFO - PROCESS | 23740 | |2;jquery.html;339.2056023634971;354.9414346632804;365.4481732583798;369.55099554041834;385.27183622952623;12129.636110916676;15922.522324330273;15929.76105358419;17065.232064557094;17204.741928871077;16348.918255408737;16621;16972.575685607866;17074.573135671584;17082.402115925946;4927.778249978751;5136.512031357015;6573.211214654249;6863.450923926099;6903.998920156574;4042.110735638155;4238.152369526092;6619.4704423646235;6800.659967001655;6805.557638753465;4245.915081698364;4246.554111818261;6863.6568171591225;6980.9650951745425;6981.162260528744;6686.465082793365;6917.342852429011;6967.860642787141;6978.441724662015;6981.371676549135;6729.596224226562;6729.697163627599;6733.595984240912;6734.494912881553;6737.3262673732725;21997.340079797472;22499.212527561456;22819.543609127726;23285.88357058221;23308;1874.9250029998784;1881.708335208045;1918.9424317270505;1991.890446025468;2006.2376297007045;13462.192268463923;14145.646358841112;14275.21486318252;14995.550133495903;15194.46819361328;1640.8441198086164;1667.4914151183884;1716.7424886267036;1737.4179649817327;1792;81098.59450702768;82417.58791206006;82930;83586;85356.57321713414;16396.83603163977;16473;16719.247633856507;16884.493465196065;16999;28448.146555603365;28476;28508.71491285102;28520.714792851806;28729.281767955967;8392.873202562163;8593.914060859437;8758.824823503493;8785.69250076257;8950.104989501127;7258.346748792634;7327.45044121693;7456.664450099758;7480.401567874557;7515.286047825448;8138.755837324889;8480.618372173267;8502.532360720095;8598.398112132216;8648;3255.934881302408;3323.2854936188837;3329.93340133196;3411.880584179542;3416.145963509123;802.3621221129216;869.7043005378075;876.3383645347849;884.6815146547237;924.6162842420321;16375;16410.589735256715;16729.83270167307;17149.91425042892;17701.911490442722;839.5214727605329;845.602566793606;864.489950928955;867.1588559097665;924.8474001789764;8489.4481858679;9641.951790241004;9945.403275803475;9964.103230709126;10062.19502439803;381711.6518104859;389102;403584;405674;405995;57447;72165.6391718038;78519.60740196262;78891.21108788953;80893;903.9050899655441;914.6981496106135;915.4232833315102;944.7213072143734;944.9385789923633;15734.527964161094;16016.599585010003;16152.67694646077;16344.427945021867;16651.16744162763;39262.60737392589;39774.403383949844;40204.39693404543;40277.39583906302;40467.190656186125;53613;53703.46296536984;53708.19437708516;54224.18663720126;54258;6533.41199292066;6940.340667636567;7010.26392228829;7031.859362812817;7040.683169257293;9244.463029615052;11011.44942752843;11146.777064458503;11337;11465.254758440675;9342;9467.147956683932;9846.212303015885;9850.60597576089;10243.07812296897;4967.776450059829;8696.825928499824;9207.539623018956;9807;9823.754406139618;9031.954840225757;9053.366264361432;9131.223845973167;9618.134367906921;9932;6919.37725604698;6992.650367481708;7108.822279443055;7155.177154627285;7337.59643219628;6880.105586273752;8836.91163088361;8871.512066836127;9082.818343632958;9111.407758495676 03:20:12 INFO - PROCESS | 23740 | |3;mootools.html;1337.6388375138713;1375.910565813222;1406.1984668738817;1639.2049855819932;1662.8337166283372;6874.896876546856;7108.85782284354;7433.628318584077;8103.270705636492;8115.472494287875;7414.888776668355;7660.1573826879;7686.807829804257;7879.9212007879905;7885.842283154333;2153.3755210988834;2204.1403852497538;2207.7129973103474;2207.7681843406453;2209.491816882118;1836.97244541332;1886.4812176651394;2084.9166033358647;2116.5661039486945;2149.656055031195;2114.080375036864;2158.136745301876;2172.902219400131;2184.377452426059;2188.7482939461925;2131.3499382688274;2139.454439118023;2172.283146561631;2177.5318306564004;2180.2151225558787;2097.0982477534653;2124.6281900667323;2128.904199311019;2134.893255337227;2135.4661334666334;7963.3231175350165;8019.599020048974;8025.6789728410795;8027.197280271985;8035.718749843786;4493.820247190109;4503.774811259424;4555.2256116460285;4566.269396896514;4626.629869610423;2856.9285767855763;2988.148377712363;2989.387175628991;3042.741366983787;3048.923776905573;972.7748741726348;1007.269729446153;1020.2654089055868;1028.1055481730866;1029.8455231715227;10825.945870270676;10857.294275872044;10874.45627718611;10883.510242039127;10894.891051089546;4049.230646177217;4172.308860784777;4244.278472659656;4291.849785257501;4295.613394794421;9137.908620913706;9146.496942668216;9152.633894644272;9152.72541823733;9192.494412807226;4712.835050773207;4721.197396442544;4721.220998535272;4721.95278047222;4725.669203155746;4160.417541544186;4314.654827613784;4318.093200427883;4320.481542214954;4321.286987647066;3577.123604716809;3613.446218126231;3667.4132138857653;3697.574778900407;3702.444633304972;1085.478970094359;1124.3478782306242;1150.424787606197;1159.9014083802972;1173.2901594535354;749.7863109013905;750.4896670264272;809.287826712501;818.9959050204711;838.053000109872;5384.0847056000575;5409.675419474844;5525.143602741581;5558.44415558441;5565.443455654483;869;883.9071897450804;885.7060214045653;890.519119675381;901.6393442623004;3713.9442908356395;3772.830222639988;3813.542374915028;3819.789911554891;3958.7228893977144;9402.717918462457;9593.376430531993;9772.315937884421;9772.951135244279;9793.657221997197;9746.415215087118;9747.171490423252;9750.073742994404;9754.317197796228;9765.707028789147;6789.592624442549;6973.093497845349;7005.544639598512;7139.785806425815;7282.8179295516975;5548.334199895877;5575.414581469049;5608.691521966331;5838.970805145947;5863.413658634103;8746.868796967923;8819.691310804092;8880.2007819294;8940.195382415613;8958.641654333753;8839.204471597586;9033.051529589298;9123.863142053007;9124.49815260167;9132.543372831466;6937.340952609696;7040.155181378267;7050.541714788523;7055.082839231072;7056.576605403692;7333.889991650023;7397.556146631219;7449.180590135189;7537;7639.809004774703;5393.892122157614;6619.106420633153;6677.899831502435;6784.423324017514;6927.272636373108;6389.424951754364;6396.936030639634;6423.357664233539;6424.421802037652;6429.935700643121;5651.689157096234;5724.656520608777;5731.455511726379;5739.942600573941;5740.942590574041;4487.6185524230805;4488.730676159441;4493.359923627918;4572.474165471013;4621.745803980813;4499.437570303712;4577.29051996941;4584;4654.185517534485;4683.601893839062 03:20:12 INFO - PROCESS | 23740 | |4;prototype.html;294.79511739341166;296.74479947245374;302.9257831831201;304.2075393599674;307.8968545537245;4891.584215341701;4891.902161956758;4911.2633105034265;4926.4334601520795;4935.925961110586;4810.44679861816;4834.685745426545;4850.927236091453;4855.805767769285;4857.149998750214;3624.691901188402;3717.6839968602703;3739.9626003739886;3786.318462676717;3796.114952635989;3817.923641527168;3818.694504439652;3818.77087374757;3824.388097904336;3833.4249862520705;3782.7162962777766;3784.1674831537157;3796.4495148203496;3798.2593394287987;3799.8290076946605;3587.71298296137;3675.191457879262;3700.890492419322;3749.7562658427114;3807.562130355003;3324.5511855899626;3332.9833350833333;3335.3329334133027;3341.214814518586;3354.0943945134923;4658.138244424792;4670.976645116787;4691.812327506896;4716.481187069419;4731.976340118312;4156.646685031776;4318.654507639413;4322.286822674255;4330.133973205371;4337.416842852368;5006.922127317159;5007.948330850526;5028.899422011576;5032.798688052473;5035.219540971156;3640.5631324240994;3655.2689462107683;3658;3659.3350025738223;3678.3746763050344;5121.436641969418;5233.816816411408;5251.816186433456;5285.705726097998;5288.841334759925;3606.314800187956;3628.353504727732;3635.7818530887703;3637.727170462226;3641.4145956370744;3702.7593206441493;3704.870329538453;3705.4622331732567;3710.2023065041144;3726.9813650931574;4124.184899291984;4255.574322636067;4264.869809500485;4275.952391664062;4284.157812140747;5012.198048312325;5012.448630650625;5036.874078148002;5056.6713163644245;5063.240513922941;1268.2834198677717;1274.420138836827;1275.298585777837;1287.7810772168755;1291.7351942851692;783.2402569507568;819.9057108432487;820.5240960243045;832.5046597274612;833.6248688090262;4314.382106709983;4387.210302145644;4447.599716025573;4508.797104130322;4516.299973504112;5194.298769666122;5202.569293444258;5209.1925751507815;5222.529972302511;5225.961874868804;4474.105178964221;4488.663350248679;4518.6503018430885;4523.819047238139;4527.637788976874;2605.749240364598;2769.2446016213994;2780.874860631236;2789.8465584392648;2793.580962855588;4942.838432968249;4947.703137811743;4958.9504104959215;4965.4289756678445;4989.426215985136;5060.51925067118;5343.145096784574;5360.571154307646;5363.678179309254;5398.4871437213405;4882.292067650171;4896.338994235875;4897.4857639948;4900.92648610264;4952.479989601112;5178.689278643143;5188.714620695898;5190.636655434235;5234.738263086754;5238.5547228486;4929.285253638131;5109.208072748581;5114.15616423286;5125.666831655931;5131.615128865275;4873.707577545359;4879.80480780779;4886.315915771724;4905.664148379136;4925.21196608541;3583.1758695500703;3588.623194564533;3594.604593494661;3614.331348700499;3646.872359467406;4998.950010499849;5225.346831646044;5255.264263003259;5278.60410469224;5281.570477580356;5029.616855364804;5063.898722025465;5067.949320506896;5069.493050695049;5069.493050695049;5057.468965758542;5071.670341427795;5072.4673909239;5100.617453690914;5109.386873575195;4737.526247375235;4979.29456663464;5001.574866136273;5001.924971125509;5009.574186194214;4925.408950925912;4997.625178111729;5010.473900240568;5129.563987061141;5136.9743151284;5000.14997450427;5019.945811379651;5029.497050294941;5034.320366750589;5034.622403319839 03:20:12 INFO - PROCESS | 23740 | |5;yui.html;630.294070640882;636.6212103798239;643.3952085040065;647.4076220258464;715.7852644206738;12088.456019479123;12517.12380133391;12898.871011289884;13082.084254102218;13093.214407135567;12248.81626775599;12414.689632759186;12460;12507.124501284914;12509.124361294713;600.3936024615148;734.3097488360951;755.6486233901235;758.9715934908203;759.3431681595408;618.4217756397783;623.4326762645993;623.466935769917;623.6975067092457;737.7159793479523;801.1227705662291;806.9354451643854;809.4212637963855;809.5021561739546;810.1210186947169;801.3268854162474;801.7915342011061;801.7915342011119;802.2218448105328;803.1687203744096;460.5555638808566;466.9813207471697;589.7640943622542;590.2621722846442;590.4243362721355;10717.892821071768;10751.247412681116;10788.676339709742;11015.779684406267;11029.944850275777;12753.808692869614;13551.932240338736;13984.160950343012;14107.576772696835;14184.574462766133;10275.177985761122;10666.893331066745;10906.072983796386;11136.777264454746;11323;3294.802311861296;3317.817520036397;3320.3027364253535;3443.018739659185;3454.3954807908767;69471;70833;72009.99999999948;72796.6360168201;72923.27076729218;9787;10074.949625251827;10210.285280030475;10367.585296588051;10440.112590429746;18890.716639250422;18909.14908829106;19316.613667726848;19334.323298684478;19583.608327833364;6632.1709786276715;6878.518503704692;6905.343992320722;6967.09427774386;7051.894221586577;3692.1877187018813;3692.390755525362;3793.5447746270625;3803.1823158021157;3803.8478460861256;3116.735077518391;3221.7261532769508;3238.0933338665213;3238.9838050809594;3247.1395080303737;496.3820044045187;512.8769095417073;518.8910328830913;566.1507738392411;593.519249407981;470.7081609402193;481.98313059043466;530.1471357605194;598.4165438697236;600.5495878091432;7429.665665044978;7783.377329813715;8211.254635506182;8279.958600207081;8290.212429819157;535.986600334987;552.3592632546228;553.0846449126702;553.9695316757617;557.743438018508;3754.7371683982406;3833.769973801581;3966.3852102924093;3993.4009898515455;4102.487189101363;58339;58505.70747146237;58549.414505855246;59457.40542594605;67348;81989.59005205055;82039.58980205061;82335.58832205921;88453;95638.52180739191;44621.33068003983;61761.382386175566;69010.30989690039;70452.29547704458;70672.29327706656;7242.637868106679;8088.71689490865;8149.511029338259;8263.214994575506;8294.58527073656;42728.78635606802;43975.96384578452;44424;44446;46600.30099548577;55377;59774.70112649409;59793;61529;62098.689506552175;10912.071535022355;11011.669649910515;11016.228863979444;11169.776604467703;11227.775444491228;11899.345535995604;12027.518899243933;12333.321667308384;12350;12424.503019879103;10035.648752293926;10224.386536807815;10449.373037617766;11210.215284929976;11223.270487418291;11017.83473247918;11021.393823339473;11062.889371106186;11408.942955285502;12024.458899349374;10037.146842518468;10521.631742888962;10729.9463502682;10802.243842930919;10806.297590656583;9266.490343031199;9377.953110234404;9518.23854091685;9707.466089365153;9717.076877696607;8981.865272020794;9251.121143491358;9252.629894804133;9264.11990860867;9382 03:20:12 INFO - PROCESS | 23740 | __end_tp_report 03:20:12 INFO - PROCESS | 23740 | __start_cc_report 03:20:12 INFO - PROCESS | 23740 | _x_x_mozilla_cycle_collect,1109 03:20:12 INFO - PROCESS | 23740 | __end_cc_report 03:20:12 INFO - PROCESS | 23740 | __startTimestamp1474539612084__endTimestamp 03:20:12 INFO - PROCESS | 23740 | 03:20:12 INFO - PROCESS | 23740 | ------- Summary: start ------- 03:20:12 INFO - PROCESS | 23740 | Number of tests: 6 03:20:12 INFO - PROCESS | 23740 | 03:20:12 INFO - PROCESS | 23740 | [#0] dojo.html Cycles:165 Average:4607.07 Median:4741.93 stddev:487.66 (10.3%) stddev-sans-first:462.26 03:20:12 INFO - PROCESS | 23740 | Values: 2570.8 2609.2 2637.0 2638.6 2656.0 4501.9 4593.9 4693.7 4726.9 4741.9 4527.2 4612.4 4675.7 4701.3 4703.1 4125.9 4173.0 4196.5 4197.2 4294.4 3781.9 4271.0 4315.4 4317.4 4372.3 4167.6 4216.7 4312.9 4386.5 4402.6 4249.7 4292.3 4316.9 4327.0 4337.9 4296.4 4338.9 4342.2 4370.8 4398.5 4575.7 4693.4 4725.8 4730.2 4751.5 4935.9 4953.4 5005.1 5015.4 5079.8 4993.1 5003.1 5014.5 5014.9 5074.6 4682.1 4688.8 4692.6 4700.6 4746.1 4931.5 4983.8 5090.9 5100.5 5140.5 4869.8 4872.3 4876.5 4928.0 4980.6 5013.4 5015.5 5019.4 5029.5 5074.3 4830.4 4888.1 4906.3 4913.4 5028.9 4893.1 4905.0 4907.0 4949.1 4964.3 4137.8 4139.4 4143.9 4177.5 4190.2 3608.9 3615.0 3635.4 3650.3 3705.7 4315.5 4334.9 4387.0 4398.8 4413.6 5042.8 5044.6 5047.5 5048.2 5112.4 4365.6 4369.5 4375.9 4397.9 4403.8 4368.1 4387.1 4387.8 4441.4 4503.0 4702.6 4702.8 4703.0 4710.2 4712.4 4975.8 4977.0 4977.7 4982.0 5037.5 4635.1 4672.4 4683.0 4689.1 4754.9 4895.5 4922.2 4924.0 4975.4 4987.6 4984.1 4984.5 4998.0 4999.0 5022.9 4744.2 4791.3 4820.0 4861.5 4865.1 4815.3 4846.2 4857.0 4878.0 4891.2 4725.6 4766.7 4770.6 4772.6 4785.2 4812.7 4868.9 4872.3 4888.3 4953.8 4781.6 4819.6 4848.4 4895.3 4897.4 03:20:12 INFO - PROCESS | 23740 | 03:20:12 INFO - PROCESS | 23740 | [#1] ext.html Cycles:180 Average:46760.82 Median:200316.14 stddev:82250.56 (41.1%) stddev-sans-first:82408.14 03:20:12 INFO - PROCESS | 23740 | Values: 556.7 564.2 576.7 577.6 579.6 28136.7 39117.4 39857.4 39952.4 43675.6 39529.2 39911.6 39915.4 39954.8 39959.0 7709.0 7855.8 7861.4 7862.6 7862.8 7228.3 7440.3 9856.4 10098.4 10109.1 10076.5 10151.2 10151.9 10158.5 10158.6 9929.2 10001.9 10008.7 10013.5 10019.1 9882.4 9942.4 9952.2 9953.9 9955.9 37411.3 37568.2 37708.0 37744.2 37800.0 2858.8 2942.4 2972.5 3097.9 3177.0 28576.7 30519.2 31007.0 31312.7 31372.4 3536.9 3556.0 3557.0 3688.4 3774.9 245267.0 245640.0 247250.0 247463.0 247505.0 52783.2 53341.2 53408.0 53413.5 53476.5 29869.3 30280.5 30309.4 32551.0 56847.9 13533.3 13616.0 13617.7 13642.7 13657.5 9871.8 11259.0 11333.3 11347.8 11349.6 15292.5 17372.9 17958.2 18051.4 18275.6 6559.8 6787.8 6875.3 7041.3 7068.8 761.5 797.1 892.3 903.1 952.9 26672.0 27901.3 28435.6 28840.3 28993.6 921.1 930.4 969.5 1007.6 1039.6 14298.2 14865.2 14957.2 15245.8 15254.2 375752.0 379587.0 380733.0 380842.0 380847.0 48453.3 48851.3 49003.5 49024.0 49064.8 1054.9 1062.3 1123.8 1137.5 1138.2 27535.0 29294.3 29329.9 29606.0 30579.8 41340.6 41907.0 41969.6 42007.6 42044.8 278910.0 280925.0 282366.2 282900.0 364320.0 36068.6 38432.6 38644.2 38730.4 39029.8 41590.6 42015.8 42322.2 42372.8 42687.0 35901.0 36135.3 36206.8 36312.3 36736.6 36601.8 36938.4 37136.3 37928.2 38316.6 35592.0 35795.8 36241.3 36715.8 37166.0 31858.0 33810.2 34531.8 34539.0 37746.6 28107.2 28423.3 30958.2 31094.8 31707.0 03:20:12 INFO - PROCESS | 23740 | 03:20:12 INFO - PROCESS | 23740 | [#2] jquery.html Cycles:180 Average:25895.65 Median:6596.34 stddev:65714.39 (996.2%) stddev-sans-first:65870.72 03:20:12 INFO - PROCESS | 23740 | Values: 339.2 354.9 365.4 369.6 385.3 12129.6 15922.5 15929.8 17065.2 17204.7 16348.9 16621.0 16972.6 17074.6 17082.4 4927.8 5136.5 6573.2 6863.5 6904.0 4042.1 4238.2 6619.5 6800.7 6805.6 4245.9 4246.6 6863.7 6981.0 6981.2 6686.5 6917.3 6967.9 6978.4 6981.4 6729.6 6729.7 6733.6 6734.5 6737.3 21997.3 22499.2 22819.5 23285.9 23308.0 1874.9 1881.7 1918.9 1991.9 2006.2 13462.2 14145.6 14275.2 14995.6 15194.5 1640.8 1667.5 1716.7 1737.4 1792.0 81098.6 82417.6 82930.0 83586.0 85356.6 16396.8 16473.0 16719.2 16884.5 16999.0 28448.1 28476.0 28508.7 28520.7 28729.3 8392.9 8593.9 8758.8 8785.7 8950.1 7258.3 7327.5 7456.7 7480.4 7515.3 8138.8 8480.6 8502.5 8598.4 8648.0 3255.9 3323.3 3329.9 3411.9 3416.1 802.4 869.7 876.3 884.7 924.6 16375.0 16410.6 16729.8 17149.9 17701.9 839.5 845.6 864.5 867.2 924.8 8489.4 9642.0 9945.4 9964.1 10062.2 381711.7 389102.0 403584.0 405674.0 405995.0 57447.0 72165.6 78519.6 78891.2 80893.0 903.9 914.7 915.4 944.7 944.9 15734.5 16016.6 16152.7 16344.4 16651.2 39262.6 39774.4 40204.4 40277.4 40467.2 53613.0 53703.5 53708.2 54224.2 54258.0 6533.4 6940.3 7010.3 7031.9 7040.7 9244.5 11011.4 11146.8 11337.0 11465.3 9342.0 9467.1 9846.2 9850.6 10243.1 4967.8 8696.8 9207.5 9807.0 9823.8 9032.0 9053.4 9131.2 9618.1 9932.0 6919.4 6992.7 7108.8 7155.2 7337.6 6880.1 8836.9 8871.5 9082.8 9111.4 03:20:12 INFO - PROCESS | 23740 | 03:20:12 INFO - PROCESS | 23740 | [#3] mootools.html Cycles:180 Average:5146.12 Median:5401.78 stddev:2885.41 (53.4%) stddev-sans-first:2879.31 03:20:12 INFO - PROCESS | 23740 | Values: 1337.6 1375.9 1406.2 1639.2 1662.8 6874.9 7108.9 7433.6 8103.3 8115.5 7414.9 7660.2 7686.8 7879.9 7885.8 2153.4 2204.1 2207.7 2207.8 2209.5 1837.0 1886.5 2084.9 2116.6 2149.7 2114.1 2158.1 2172.9 2184.4 2188.7 2131.3 2139.5 2172.3 2177.5 2180.2 2097.1 2124.6 2128.9 2134.9 2135.5 7963.3 8019.6 8025.7 8027.2 8035.7 4493.8 4503.8 4555.2 4566.3 4626.6 2856.9 2988.1 2989.4 3042.7 3048.9 972.8 1007.3 1020.3 1028.1 1029.8 10825.9 10857.3 10874.5 10883.5 10894.9 4049.2 4172.3 4244.3 4291.8 4295.6 9137.9 9146.5 9152.6 9152.7 9192.5 4712.8 4721.2 4721.2 4722.0 4725.7 4160.4 4314.7 4318.1 4320.5 4321.3 3577.1 3613.4 3667.4 3697.6 3702.4 1085.5 1124.3 1150.4 1159.9 1173.3 749.8 750.5 809.3 819.0 838.1 5384.1 5409.7 5525.1 5558.4 5565.4 869.0 883.9 885.7 890.5 901.6 3713.9 3772.8 3813.5 3819.8 3958.7 9402.7 9593.4 9772.3 9773.0 9793.7 9746.4 9747.2 9750.1 9754.3 9765.7 6789.6 6973.1 7005.5 7139.8 7282.8 5548.3 5575.4 5608.7 5839.0 5863.4 8746.9 8819.7 8880.2 8940.2 8958.6 8839.2 9033.1 9123.9 9124.5 9132.5 6937.3 7040.2 7050.5 7055.1 7056.6 7333.9 7397.6 7449.2 7537.0 7639.8 5393.9 6619.1 6677.9 6784.4 6927.3 6389.4 6396.9 6423.4 6424.4 6429.9 5651.7 5724.7 5731.5 5739.9 5740.9 4487.6 4488.7 4493.4 4572.5 4621.7 4499.4 4577.3 4584.0 4654.2 4683.6 03:20:12 INFO - PROCESS | 23740 | 03:20:12 INFO - PROCESS | 23740 | [#4] prototype.html Cycles:180 Average:4202.31 Median:4865.43 stddev:1227.38 (25.2%) stddev-sans-first:1195.27 03:20:12 INFO - PROCESS | 23740 | Values: 294.8 296.7 302.9 304.2 307.9 4891.6 4891.9 4911.3 4926.4 4935.9 4810.4 4834.7 4850.9 4855.8 4857.1 3624.7 3717.7 3740.0 3786.3 3796.1 3817.9 3818.7 3818.8 3824.4 3833.4 3782.7 3784.2 3796.4 3798.3 3799.8 3587.7 3675.2 3700.9 3749.8 3807.6 3324.6 3333.0 3335.3 3341.2 3354.1 4658.1 4671.0 4691.8 4716.5 4732.0 4156.6 4318.7 4322.3 4330.1 4337.4 5006.9 5007.9 5028.9 5032.8 5035.2 3640.6 3655.3 3658.0 3659.3 3678.4 5121.4 5233.8 5251.8 5285.7 5288.8 3606.3 3628.4 3635.8 3637.7 3641.4 3702.8 3704.9 3705.5 3710.2 3727.0 4124.2 4255.6 4264.9 4276.0 4284.2 5012.2 5012.4 5036.9 5056.7 5063.2 1268.3 1274.4 1275.3 1287.8 1291.7 783.2 819.9 820.5 832.5 833.6 4314.4 4387.2 4447.6 4508.8 4516.3 5194.3 5202.6 5209.2 5222.5 5226.0 4474.1 4488.7 4518.7 4523.8 4527.6 2605.7 2769.2 2780.9 2789.8 2793.6 4942.8 4947.7 4959.0 4965.4 4989.4 5060.5 5343.1 5360.6 5363.7 5398.5 4882.3 4896.3 4897.5 4900.9 4952.5 5178.7 5188.7 5190.6 5234.7 5238.6 4929.3 5109.2 5114.2 5125.7 5131.6 4873.7 4879.8 4886.3 4905.7 4925.2 3583.2 3588.6 3594.6 3614.3 3646.9 4999.0 5225.3 5255.3 5278.6 5281.6 5029.6 5063.9 5067.9 5069.5 5069.5 5057.5 5071.7 5072.5 5100.6 5109.4 4737.5 4979.3 5001.6 5001.9 5009.6 4925.4 4997.6 5010.5 5129.6 5137.0 5000.1 5019.9 5029.5 5034.3 5034.6 03:20:12 INFO - PROCESS | 23740 | 03:20:12 INFO - PROCESS | 23740 | [#5] yui.html Cycles:180 Average:16474.02 Median:515.88 stddev:22647.79 (4390.1%) stddev-sans-first:22680.07 03:20:12 INFO - PROCESS | 23740 | Values: 630.3 636.6 643.4 647.4 715.8 12088.5 12517.1 12898.9 13082.1 13093.2 12248.8 12414.7 12460.0 12507.1 12509.1 600.4 734.3 755.6 759.0 759.3 618.4 623.4 623.5 623.7 737.7 801.1 806.9 809.4 809.5 810.1 801.3 801.8 801.8 802.2 803.2 460.6 467.0 589.8 590.3 590.4 10717.9 10751.2 10788.7 11015.8 11029.9 12753.8 13551.9 13984.2 14107.6 14184.6 10275.2 10666.9 10906.1 11136.8 11323.0 3294.8 3317.8 3320.3 3443.0 3454.4 69471.0 70833.0 72010.0 72796.6 72923.3 9787.0 10074.9 10210.3 10367.6 10440.1 18890.7 18909.1 19316.6 19334.3 19583.6 6632.2 6878.5 6905.3 6967.1 7051.9 3692.2 3692.4 3793.5 3803.2 3803.8 3116.7 3221.7 3238.1 3239.0 3247.1 496.4 512.9 518.9 566.2 593.5 470.7 482.0 530.1 598.4 600.5 7429.7 7783.4 8211.3 8280.0 8290.2 536.0 552.4 553.1 554.0 557.7 3754.7 3833.8 3966.4 3993.4 4102.5 58339.0 58505.7 58549.4 59457.4 67348.0 81989.6 82039.6 82335.6 88453.0 95638.5 44621.3 61761.4 69010.3 70452.3 70672.3 7242.6 8088.7 8149.5 8263.2 8294.6 42728.8 43976.0 44424.0 44446.0 46600.3 55377.0 59774.7 59793.0 61529.0 62098.7 10912.1 11011.7 11016.2 11169.8 11227.8 11899.3 12027.5 12333.3 12350.0 12424.5 10035.6 10224.4 10449.4 11210.2 11223.3 11017.8 11021.4 11062.9 11408.9 12024.5 10037.1 10521.6 10729.9 10802.2 10806.3 9266.5 9378.0 9518.2 9707.5 9717.1 8981.9 9251.1 9252.6 9264.1 9382.0 03:20:12 INFO - PROCESS | 23740 | -------- Summary: end -------- 03:20:12 INFO - PROCESS | 23740 | 03:20:13 INFO - TEST-INFO | 23740: exit 0 03:20:13 INFO - TEST-OK | dromaeo_css | took 1121084ms 03:20:13 INFO - TEST-START | kraken 03:20:13 INFO - operating with platform_type : linux_ 03:20:13 INFO - Initialising browser for kraken test... 03:20:13 INFO - TEST-INFO | started process 24051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpozg03i/profile http://localhost:44385/getInfo.html) 03:20:17 INFO - PROCESS | 24051 | __metrics Screen width/height:1600/1200 03:20:17 INFO - PROCESS | 24051 | colorDepth:24 03:20:17 INFO - PROCESS | 24051 | Browser inner width/height: 1024/697 03:20:17 INFO - PROCESS | 24051 | __metrics 03:20:18 INFO - PROCESS | 24051 | 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:18 INFO - PROCESS | 24051 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:20:18 INFO - PROCESS | 24051 | console.error: PushService: 03:20:18 INFO - PROCESS | 24051 | stateChangeProcessEnqueue: Error transitioning state 03:20:18 INFO - PROCESS | 24051 | UnknownError 03:20:19 INFO - TEST-INFO | 24051: exit 0 03:20:19 INFO - Browser initialized. 03:20:19 INFO - Running cycle 1/1 for kraken test... 03:20:19 INFO - TEST-INFO | started process 24136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpozg03i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:31 INFO - PROCESS | 24136 | RSS: Main: 174559232 03:20:31 INFO - PROCESS | 24136 | 03:20:34 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44385/tests/kraken/driver.html?testName=audio-beat-detection) 03:20:35 INFO - PROCESS | 24136 | RSS: Main: 242003968 03:20:35 INFO - PROCESS | 24136 | 03:20:38 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44385/tests/kraken/driver.html?testName=audio-dft) 03:20:38 INFO - PROCESS | 24136 | RSS: Main: 219230208 03:20:38 INFO - PROCESS | 24136 | 03:20:42 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44385/tests/kraken/driver.html?testName=audio-fft) 03:20:42 INFO - PROCESS | 24136 | RSS: Main: 300216320 03:20:42 INFO - PROCESS | 24136 | 03:20:44 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44385/tests/kraken/driver.html?testName=audio-oscillator) 03:20:45 INFO - PROCESS | 24136 | RSS: Main: 209432576 03:20:45 INFO - PROCESS | 24136 | 03:20:47 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44385/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:20:48 INFO - PROCESS | 24136 | RSS: Main: 214212608 03:20:48 INFO - PROCESS | 24136 | 03:20:51 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44385/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:52 INFO - PROCESS | 24136 | RSS: Main: 250310656 03:20:52 INFO - PROCESS | 24136 | 03:20:55 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44385/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:56 INFO - PROCESS | 24136 | RSS: Main: 244871168 03:20:56 INFO - PROCESS | 24136 | 03:20:59 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44385/tests/kraken/driver.html?testName=json-parse-financial) 03:20:59 INFO - PROCESS | 24136 | RSS: Main: 247390208 03:20:59 INFO - PROCESS | 24136 | 03:21:01 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44385/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:21:02 INFO - PROCESS | 24136 | RSS: Main: 210915328 03:21:02 INFO - PROCESS | 24136 | 03:21:04 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44385/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:21:04 INFO - PROCESS | 24136 | RSS: Main: 218370048 03:21:04 INFO - PROCESS | 24136 | 03:21:06 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44385/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:21:07 INFO - PROCESS | 24136 | RSS: Main: 222924800 03:21:07 INFO - PROCESS | 24136 | 03:21:10 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:21:11 INFO - PROCESS | 24136 | RSS: Main: 223707136 03:21:11 INFO - PROCESS | 24136 | 03:21:13 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:21:14 INFO - PROCESS | 24136 | RSS: Main: 220499968 03:21:14 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | Cycle 1(1): loaded http://localhost:44385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44385/tests/kraken/driver.html?testName=ai-astar) 03:21:16 INFO - PROCESS | 24136 | RSS: Main: 271900672 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | __start_tp_report 03:21:16 INFO - PROCESS | 24136 | _x_x_mozilla_page_load 03:21:16 INFO - PROCESS | 24136 | _x_x_mozilla_page_load_details 03:21:16 INFO - PROCESS | 24136 | |i|pagename|runs| 03:21:16 INFO - PROCESS | 24136 | |0;ai-astar;112;115;116;115;115;114;115;115;113;115 03:21:16 INFO - PROCESS | 24136 | |1;audio-beat-detection;160;123;123;175;125;124;122;122;162;123 03:21:16 INFO - PROCESS | 24136 | |2;audio-dft;162;162;161;162;161;161;162;162;162;162 03:21:16 INFO - PROCESS | 24136 | |3;audio-fft;76;76;77;100;77;77;77;75;106;75 03:21:16 INFO - PROCESS | 24136 | |4;audio-oscillator;83;84;132;84;84;84;111;83;83;122 03:21:16 INFO - PROCESS | 24136 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 03:21:16 INFO - PROCESS | 24136 | |6;imaging-darkroom;147;147;146;146;146;146;147;146;147;147 03:21:16 INFO - PROCESS | 24136 | |7;imaging-desaturate;95;96;96;95;95;95;95;96;95;95 03:21:16 INFO - PROCESS | 24136 | |8;json-parse-financial;65;63;64;65;65;66;66;65;64;65 03:21:16 INFO - PROCESS | 24136 | |9;json-stringify-tinderbox;66;67;66;66;67;66;66;67;65;65 03:21:16 INFO - PROCESS | 24136 | |10;stanford-crypto-aes;83;88;83;82;84;82;82;88;85;82 03:21:16 INFO - PROCESS | 24136 | |11;stanford-crypto-ccm;133;133;132;136;145;139;133;132;179;150 03:21:16 INFO - PROCESS | 24136 | |12;stanford-crypto-pbkdf2;177;180;177;175;177;172;175;170;175;173 03:21:16 INFO - PROCESS | 24136 | |13;stanford-crypto-sha256-iterative;70;74;71;70;70;69;69;71;69;69 03:21:16 INFO - PROCESS | 24136 | __end_tp_report 03:21:16 INFO - PROCESS | 24136 | __start_cc_report 03:21:16 INFO - PROCESS | 24136 | _x_x_mozilla_cycle_collect,1942 03:21:16 INFO - PROCESS | 24136 | __end_cc_report 03:21:16 INFO - PROCESS | 24136 | __startTimestamp1474539676611__endTimestamp 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | ------- Summary: start ------- 03:21:16 INFO - PROCESS | 24136 | Number of tests: 14 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:1.18 (1.0%) stddev-sans-first:0.83 03:21:16 INFO - PROCESS | 24136 | Values: 112.0 115.0 116.0 115.0 115.0 114.0 115.0 115.0 113.0 115.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:124.50 stddev:20.91 (16.8%) stddev-sans-first:20.28 03:21:16 INFO - PROCESS | 24136 | Values: 160.0 123.0 123.0 175.0 125.0 124.0 122.0 122.0 162.0 123.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:21:16 INFO - PROCESS | 24136 | Values: 162.0 162.0 161.0 162.0 161.0 161.0 162.0 162.0 162.0 162.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.50 stddev:11.39 (14.9%) stddev-sans-first:11.90 03:21:16 INFO - PROCESS | 24136 | Values: 76.0 76.0 77.0 100.0 77.0 77.0 77.0 75.0 106.0 75.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:83.50 stddev:19.06 (22.8%) stddev-sans-first:19.72 03:21:16 INFO - PROCESS | 24136 | Values: 83.0 84.0 132.0 84.0 84.0 84.0 111.0 83.0 83.0 122.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:21:16 INFO - PROCESS | 24136 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:21:16 INFO - PROCESS | 24136 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:21:16 INFO - PROCESS | 24136 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 03:21:16 INFO - PROCESS | 24136 | Values: 65.0 63.0 64.0 65.0 65.0 66.0 66.0 65.0 64.0 65.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 03:21:16 INFO - PROCESS | 24136 | Values: 66.0 67.0 66.0 66.0 67.0 66.0 66.0 67.0 65.0 65.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:2.38 (2.8%) stddev-sans-first:2.50 03:21:16 INFO - PROCESS | 24136 | Values: 83.0 88.0 83.0 82.0 84.0 82.0 82.0 88.0 85.0 82.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:137.50 stddev:14.62 (10.6%) stddev-sans-first:15.20 03:21:16 INFO - PROCESS | 24136 | Values: 133.0 133.0 132.0 136.0 145.0 139.0 133.0 132.0 179.0 150.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:176.00 stddev:2.88 (1.6%) stddev-sans-first:2.98 03:21:16 INFO - PROCESS | 24136 | Values: 177.0 180.0 177.0 175.0 177.0 172.0 175.0 170.0 175.0 173.0 03:21:16 INFO - PROCESS | 24136 | 03:21:16 INFO - PROCESS | 24136 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.55 (2.2%) stddev-sans-first:1.64 03:21:16 INFO - PROCESS | 24136 | Values: 70.0 74.0 71.0 70.0 70.0 69.0 69.0 71.0 69.0 69.0 03:21:16 INFO - PROCESS | 24136 | -------- Summary: end -------- 03:21:16 INFO - PROCESS | 24136 | 03:21:17 INFO - TEST-INFO | 24136: exit 0 03:21:17 INFO - TEST-OK | kraken | took 64928ms 03:21:17 INFO - SUITE-END | took 1186s 03:21:18 INFO - Completed test suite (00:19:46) 03:21:18 INFO - javascript benchmark 03:21:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2570.8200425970185, 2609.1781088956964, 2636.9868150659245, 2638.6174004769305, 2655.96016059759, 4501.90996180077, 4593.862184134473, 4693.671442998992, 4726.929096063557, 4741.928871066937, 4527.230370836965, 4612.377329060576, 4675.672702910789, 4701.27130294804, 4703.082898834728, 4125.938110928339, 4173.0, 4196.475440569929, 4197.202531519017, 4294.355846623016, 3781.9054523636855, 4271.0, 4315.395844581761, 4317.395564620955, 4372.344148377737, 4167.6457501112445, 4216.662666986634, 4312.878651550588, 4386.4736231652405, 4402.647788176954, 4249.702520823544, 4292.334688123346, 4316.935245971313, 4327.0, 4337.891552711208, 4296.419983302246, 4338.869833904988, 4342.174986752507, 4370.759608221547, 4398.494173170095, 4575.725456472589, 4693.366395536593, 4725.763711814396, 4730.2431610942085, 4751.548602882721, 4935.901281974377, 4953.356063711731, 5005.074061298671, 5015.423226328982, 5079.847604571869, 4993.126202914512, 5003.099442100421, 5014.498550144993, 5014.949850501484, 5074.568661663763, 4682.1103990241745, 4688.835890743808, 4692.6245900327895, 4700.600448961808, 4746.121967436035, 4931.50684931504, 4983.800647974041, 5090.898182036339, 5100.515451032146, 5140.511651393112, 4869.844691979128, 4872.269159626014, 4876.463589005207, 4928.0390323886495, 4980.576650984634, 5013.373328333958, 5015.523525265094, 5019.447860735316, 5029.497050295015, 5074.264231686385, 4830.420349558076, 4888.144574699413, 4906.31311616374, 4913.410390753133, 5028.874278143076, 4893.119238537026, 4905.0, 4906.975465122651, 4949.133901567211, 4964.329815474937, 4137.793110344471, 4139.4204811326435, 4143.875683729493, 4177.540470548237, 4190.161967606491, 3608.891733248007, 3615.023943535231, 3635.4001589737927, 3650.2699460108083, 3705.7220708446976, 4315.546867578922, 4334.869953901388, 4387.0, 4398.780060996937, 4413.602775750198, 5042.823501177441, 5044.646874718735, 5047.4952504749235, 5048.16705243638, 5112.437631860493, 4365.563443655673, 4369.541198174209, 4375.890602734893, 4397.934030989538, 4403.8238470461465, 4368.126374725068, 4387.100644367961, 4387.846425375096, 4441.444819397575, 4502.977485112619, 4702.576768090888, 4702.76486175683, 4703.012367402747, 4710.222813235846, 4712.387389639325, 4975.776090076028, 4976.950230497793, 4977.676451030671, 4981.975090124672, 5037.471065538066, 4635.142498637762, 4672.392588963549, 4682.953170468251, 4689.085628302449, 4754.857354279377, 4895.46149923501, 4922.237053256751, 4923.975380123076, 4975.402951645826, 4987.551120399182, 4984.102861484967, 4984.451710311935, 4998.025385050026, 4998.950010499849, 5022.924656130088, 4744.240921452551, 4791.281307803857, 4819.95180048195, 4861.51384861511, 4865.0756356292195, 4815.253635686474, 4846.17615005457, 4857.0, 4877.95122048775, 4891.217405215149, 4725.6219502439035, 4766.737829419415, 4770.5944994674455, 4772.642051846195, 4785.210440277316, 4812.735299558558, 4868.902621947612, 4872.269159626085, 4888.2911977762315, 4953.777080031336, 4781.593564547053, 4819.614430845594, 4848.418189817104, 4895.290182923527, 4897.41231052276], "value": 4575.968995400671, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.7327682712298, 564.2157401212313, 576.7433492096017, 577.5639392258846, 579.6319337220868, 28136.718632813667, 39117.413238801404, 39857.40213896794, 39952.400713989315, 43675.56324436763, 39529.20941581174, 39911.60088399115, 39915.40126898099, 39954.80022599883, 39959.0, 7709.0, 7855.8036049098655, 7861.371090312761, 7862.606869656494, 7862.842743145134, 7228.349448549629, 7440.330370266675, 9856.359336643096, 10098.394096354206, 10109.090181883628, 10076.496175191247, 10151.23865710071, 10151.934046925076, 10158.492075396238, 10158.59365625374, 9929.156021738161, 10001.949990250003, 10008.749781255454, 10013.549390277454, 10019.098281154658, 9882.35764675301, 9942.353747006422, 9952.203823694088, 9953.90046099537, 9955.850662240073, 37411.25177496462, 37568.24863502742, 37708.0, 37744.24511509755, 37800.0, 2858.771298296131, 2942.440936222111, 2972.509535926591, 3097.9241429902713, 3177.0, 28576.714232857612, 30519.237019074702, 31007.0, 31312.686873131206, 31372.372552548823, 3536.929261414783, 3555.982220088909, 3557.0, 3688.3729765939856, 3774.8867533974026, 245267.0, 245640.0, 247250.0, 247463.0, 247505.0, 52783.208251876255, 53341.1998820018, 53408.0, 53413.465865341626, 53476.465235347925, 29869.253268668457, 30280.54579181314, 30309.393812124075, 32551.0, 56847.863042738914, 13533.323333833268, 13616.046876718732, 13617.727645447234, 13642.658933526742, 13657.521986730417, 9871.802563948824, 11259.0, 11333.26333788301, 11347.829782553268, 11349.602763903224, 15292.464763733216, 17372.913135434494, 17958.19188136537, 18051.368202112862, 18275.63448731018, 6559.770408035792, 6787.762428314985, 6875.312468753084, 7041.260667629927, 7068.787936361918, 761.5354633673455, 797.1271457753751, 892.3396686451979, 903.1375036839802, 952.9475878826731, 26672.0, 27901.302467438476, 28435.573466398022, 28840.278993025342, 28993.56509652357, 921.1065266691298, 930.3627015494408, 969.539468752337, 1007.6221416968637, 1039.6361273554346, 14298.213598251989, 14865.182414967281, 14957.177355245565, 15245.771313430307, 15254.161021143944, 375752.0, 379587.0, 380733.0, 380842.0, 380847.0, 48453.27320090202, 48851.26723099085, 49003.50996490061, 49024.0, 49064.7546762271, 1054.8892366301427, 1062.3201151263197, 1123.7808627317759, 1137.4995002199005, 1138.2203190814319, 27535.0, 29294.26764330909, 29329.853350733963, 29606.0, 30579.847100764353, 41340.586594134875, 41907.0, 41969.580304197785, 42007.57992420159, 42044.78977605092, 278910.0, 280925.0, 282366.1752133544, 282900.0, 364320.0, 36068.63931360758, 38432.615673842905, 38644.227115458096, 38730.4190437138, 39029.80485097556, 41590.58409415867, 42015.7899210502, 42322.153556929305, 42372.78813606036, 42687.0, 35901.0, 36135.27729445449, 36206.818965905004, 36312.27375452529, 36736.63263367439, 36601.81699091594, 36938.44592331063, 37136.25727485489, 37928.24143517059, 38316.61683383131, 35592.0, 35795.82102089473, 36241.27517449584, 36715.81642091773, 37166.0, 31858.0, 33810.15474613154, 34531.827340863136, 34539.0, 37746.62253377431, 28107.156785296473, 28423.28941776472, 30958.22604434907, 31094.844525777225, 31707.0], "value": 17955.731313562985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.2056023634971, 354.9414346632804, 365.4481732583798, 369.55099554041834, 385.27183622952623, 12129.636110916676, 15922.522324330273, 15929.76105358419, 17065.232064557094, 17204.741928871077, 16348.918255408737, 16621.0, 16972.575685607866, 17074.573135671584, 17082.402115925946, 4927.778249978751, 5136.512031357015, 6573.211214654249, 6863.450923926099, 6903.998920156574, 4042.110735638155, 4238.152369526092, 6619.4704423646235, 6800.659967001655, 6805.557638753465, 4245.915081698364, 4246.554111818261, 6863.6568171591225, 6980.9650951745425, 6981.162260528744, 6686.465082793365, 6917.342852429011, 6967.860642787141, 6978.441724662015, 6981.371676549135, 6729.596224226562, 6729.697163627599, 6733.595984240912, 6734.494912881553, 6737.3262673732725, 21997.340079797472, 22499.212527561456, 22819.543609127726, 23285.88357058221, 23308.0, 1874.9250029998784, 1881.708335208045, 1918.9424317270505, 1991.890446025468, 2006.2376297007045, 13462.192268463923, 14145.646358841112, 14275.21486318252, 14995.550133495903, 15194.46819361328, 1640.8441198086164, 1667.4914151183884, 1716.7424886267036, 1737.4179649817327, 1792.0, 81098.59450702768, 82417.58791206006, 82930.0, 83586.0, 85356.57321713414, 16396.83603163977, 16473.0, 16719.247633856507, 16884.493465196065, 16999.0, 28448.146555603365, 28476.0, 28508.71491285102, 28520.714792851806, 28729.281767955967, 8392.873202562163, 8593.914060859437, 8758.824823503493, 8785.69250076257, 8950.104989501127, 7258.346748792634, 7327.45044121693, 7456.664450099758, 7480.401567874557, 7515.286047825448, 8138.755837324889, 8480.618372173267, 8502.532360720095, 8598.398112132216, 8648.0, 3255.934881302408, 3323.2854936188837, 3329.93340133196, 3411.880584179542, 3416.145963509123, 802.3621221129216, 869.7043005378075, 876.3383645347849, 884.6815146547237, 924.6162842420321, 16375.0, 16410.589735256715, 16729.83270167307, 17149.91425042892, 17701.911490442722, 839.5214727605329, 845.602566793606, 864.489950928955, 867.1588559097665, 924.8474001789764, 8489.4481858679, 9641.951790241004, 9945.403275803475, 9964.103230709126, 10062.19502439803, 381711.6518104859, 389102.0, 403584.0, 405674.0, 405995.0, 57447.0, 72165.6391718038, 78519.60740196262, 78891.21108788953, 80893.0, 903.9050899655441, 914.6981496106135, 915.4232833315102, 944.7213072143734, 944.9385789923633, 15734.527964161094, 16016.599585010003, 16152.67694646077, 16344.427945021867, 16651.16744162763, 39262.60737392589, 39774.403383949844, 40204.39693404543, 40277.39583906302, 40467.190656186125, 53613.0, 53703.46296536984, 53708.19437708516, 54224.18663720126, 54258.0, 6533.41199292066, 6940.340667636567, 7010.26392228829, 7031.859362812817, 7040.683169257293, 9244.463029615052, 11011.44942752843, 11146.777064458503, 11337.0, 11465.254758440675, 9342.0, 9467.147956683932, 9846.212303015885, 9850.60597576089, 10243.07812296897, 4967.776450059829, 8696.825928499824, 9207.539623018956, 9807.0, 9823.754406139618, 9031.954840225757, 9053.366264361432, 9131.223845973167, 9618.134367906921, 9932.0, 6919.37725604698, 6992.650367481708, 7108.822279443055, 7155.177154627285, 7337.59643219628, 6880.105586273752, 8836.91163088361, 8871.512066836127, 9082.818343632958, 9111.407758495676], "value": 9065.105466498475, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.6388375138713, 1375.910565813222, 1406.1984668738817, 1639.2049855819932, 1662.8337166283372, 6874.896876546856, 7108.85782284354, 7433.628318584077, 8103.270705636492, 8115.472494287875, 7414.888776668355, 7660.1573826879, 7686.807829804257, 7879.9212007879905, 7885.842283154333, 2153.3755210988834, 2204.1403852497538, 2207.7129973103474, 2207.7681843406453, 2209.491816882118, 1836.97244541332, 1886.4812176651394, 2084.9166033358647, 2116.5661039486945, 2149.656055031195, 2114.080375036864, 2158.136745301876, 2172.902219400131, 2184.377452426059, 2188.7482939461925, 2131.3499382688274, 2139.454439118023, 2172.283146561631, 2177.5318306564004, 2180.2151225558787, 2097.0982477534653, 2124.6281900667323, 2128.904199311019, 2134.893255337227, 2135.4661334666334, 7963.3231175350165, 8019.599020048974, 8025.6789728410795, 8027.197280271985, 8035.718749843786, 4493.820247190109, 4503.774811259424, 4555.2256116460285, 4566.269396896514, 4626.629869610423, 2856.9285767855763, 2988.148377712363, 2989.387175628991, 3042.741366983787, 3048.923776905573, 972.7748741726348, 1007.269729446153, 1020.2654089055868, 1028.1055481730866, 1029.8455231715227, 10825.945870270676, 10857.294275872044, 10874.45627718611, 10883.510242039127, 10894.891051089546, 4049.230646177217, 4172.308860784777, 4244.278472659656, 4291.849785257501, 4295.613394794421, 9137.908620913706, 9146.496942668216, 9152.633894644272, 9152.72541823733, 9192.494412807226, 4712.835050773207, 4721.197396442544, 4721.220998535272, 4721.95278047222, 4725.669203155746, 4160.417541544186, 4314.654827613784, 4318.093200427883, 4320.481542214954, 4321.286987647066, 3577.123604716809, 3613.446218126231, 3667.4132138857653, 3697.574778900407, 3702.444633304972, 1085.478970094359, 1124.3478782306242, 1150.424787606197, 1159.9014083802972, 1173.2901594535354, 749.7863109013905, 750.4896670264272, 809.287826712501, 818.9959050204711, 838.053000109872, 5384.0847056000575, 5409.675419474844, 5525.143602741581, 5558.44415558441, 5565.443455654483, 869.0, 883.9071897450804, 885.7060214045653, 890.519119675381, 901.6393442623004, 3713.9442908356395, 3772.830222639988, 3813.542374915028, 3819.789911554891, 3958.7228893977144, 9402.717918462457, 9593.376430531993, 9772.315937884421, 9772.951135244279, 9793.657221997197, 9746.415215087118, 9747.171490423252, 9750.073742994404, 9754.317197796228, 9765.707028789147, 6789.592624442549, 6973.093497845349, 7005.544639598512, 7139.785806425815, 7282.8179295516975, 5548.334199895877, 5575.414581469049, 5608.691521966331, 5838.970805145947, 5863.413658634103, 8746.868796967923, 8819.691310804092, 8880.2007819294, 8940.195382415613, 8958.641654333753, 8839.204471597586, 9033.051529589298, 9123.863142053007, 9124.49815260167, 9132.543372831466, 6937.340952609696, 7040.155181378267, 7050.541714788523, 7055.082839231072, 7056.576605403692, 7333.889991650023, 7397.556146631219, 7449.180590135189, 7537.0, 7639.809004774703, 5393.892122157614, 6619.106420633153, 6677.899831502435, 6784.423324017514, 6927.272636373108, 6389.424951754364, 6396.936030639634, 6423.357664233539, 6424.421802037652, 6429.935700643121, 5651.689157096234, 5724.656520608777, 5731.455511726379, 5739.942600573941, 5740.942590574041, 4487.6185524230805, 4488.730676159441, 4493.359923627918, 4572.474165471013, 4621.745803980813, 4499.437570303712, 4577.29051996941, 4584.0, 4654.185517534485, 4683.601893839062], "value": 4145.491055455211, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.79511739341166, 296.74479947245374, 302.9257831831201, 304.2075393599674, 307.8968545537245, 4891.584215341701, 4891.902161956758, 4911.2633105034265, 4926.4334601520795, 4935.925961110586, 4810.44679861816, 4834.685745426545, 4850.927236091453, 4855.805767769285, 4857.149998750214, 3624.691901188402, 3717.6839968602703, 3739.9626003739886, 3786.318462676717, 3796.114952635989, 3817.923641527168, 3818.694504439652, 3818.77087374757, 3824.388097904336, 3833.4249862520705, 3782.7162962777766, 3784.1674831537157, 3796.4495148203496, 3798.2593394287987, 3799.8290076946605, 3587.71298296137, 3675.191457879262, 3700.890492419322, 3749.7562658427114, 3807.562130355003, 3324.5511855899626, 3332.9833350833333, 3335.3329334133027, 3341.214814518586, 3354.0943945134923, 4658.138244424792, 4670.976645116787, 4691.812327506896, 4716.481187069419, 4731.976340118312, 4156.646685031776, 4318.654507639413, 4322.286822674255, 4330.133973205371, 4337.416842852368, 5006.922127317159, 5007.948330850526, 5028.899422011576, 5032.798688052473, 5035.219540971156, 3640.5631324240994, 3655.2689462107683, 3658.0, 3659.3350025738223, 3678.3746763050344, 5121.436641969418, 5233.816816411408, 5251.816186433456, 5285.705726097998, 5288.841334759925, 3606.314800187956, 3628.353504727732, 3635.7818530887703, 3637.727170462226, 3641.4145956370744, 3702.7593206441493, 3704.870329538453, 3705.4622331732567, 3710.2023065041144, 3726.9813650931574, 4124.184899291984, 4255.574322636067, 4264.869809500485, 4275.952391664062, 4284.157812140747, 5012.198048312325, 5012.448630650625, 5036.874078148002, 5056.6713163644245, 5063.240513922941, 1268.2834198677717, 1274.420138836827, 1275.298585777837, 1287.7810772168755, 1291.7351942851692, 783.2402569507568, 819.9057108432487, 820.5240960243045, 832.5046597274612, 833.6248688090262, 4314.382106709983, 4387.210302145644, 4447.599716025573, 4508.797104130322, 4516.299973504112, 5194.298769666122, 5202.569293444258, 5209.1925751507815, 5222.529972302511, 5225.961874868804, 4474.105178964221, 4488.663350248679, 4518.6503018430885, 4523.819047238139, 4527.637788976874, 2605.749240364598, 2769.2446016213994, 2780.874860631236, 2789.8465584392648, 2793.580962855588, 4942.838432968249, 4947.703137811743, 4958.9504104959215, 4965.4289756678445, 4989.426215985136, 5060.51925067118, 5343.145096784574, 5360.571154307646, 5363.678179309254, 5398.4871437213405, 4882.292067650171, 4896.338994235875, 4897.4857639948, 4900.92648610264, 4952.479989601112, 5178.689278643143, 5188.714620695898, 5190.636655434235, 5234.738263086754, 5238.5547228486, 4929.285253638131, 5109.208072748581, 5114.15616423286, 5125.666831655931, 5131.615128865275, 4873.707577545359, 4879.80480780779, 4886.315915771724, 4905.664148379136, 4925.21196608541, 3583.1758695500703, 3588.623194564533, 3594.604593494661, 3614.331348700499, 3646.872359467406, 4998.950010499849, 5225.346831646044, 5255.264263003259, 5278.60410469224, 5281.570477580356, 5029.616855364804, 5063.898722025465, 5067.949320506896, 5069.493050695049, 5069.493050695049, 5057.468965758542, 5071.670341427795, 5072.4673909239, 5100.617453690914, 5109.386873575195, 4737.526247375235, 4979.29456663464, 5001.574866136273, 5001.924971125509, 5009.574186194214, 4925.408950925912, 4997.625178111729, 5010.473900240568, 5129.563987061141, 5136.9743151284, 5000.14997450427, 5019.945811379651, 5029.497050294941, 5034.320366750589, 5034.622403319839], "value": 3809.1249921092467, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.294070640882, 636.6212103798239, 643.3952085040065, 647.4076220258464, 715.7852644206738, 12088.456019479123, 12517.12380133391, 12898.871011289884, 13082.084254102218, 13093.214407135567, 12248.81626775599, 12414.689632759186, 12460.0, 12507.124501284914, 12509.124361294713, 600.3936024615148, 734.3097488360951, 755.6486233901235, 758.9715934908203, 759.3431681595408, 618.4217756397783, 623.4326762645993, 623.466935769917, 623.6975067092457, 737.7159793479523, 801.1227705662291, 806.9354451643854, 809.4212637963855, 809.5021561739546, 810.1210186947169, 801.3268854162474, 801.7915342011061, 801.7915342011119, 802.2218448105328, 803.1687203744096, 460.5555638808566, 466.9813207471697, 589.7640943622542, 590.2621722846442, 590.4243362721355, 10717.892821071768, 10751.247412681116, 10788.676339709742, 11015.779684406267, 11029.944850275777, 12753.808692869614, 13551.932240338736, 13984.160950343012, 14107.576772696835, 14184.574462766133, 10275.177985761122, 10666.893331066745, 10906.072983796386, 11136.777264454746, 11323.0, 3294.802311861296, 3317.817520036397, 3320.3027364253535, 3443.018739659185, 3454.3954807908767, 69471.0, 70833.0, 72009.99999999948, 72796.6360168201, 72923.27076729218, 9787.0, 10074.949625251827, 10210.285280030475, 10367.585296588051, 10440.112590429746, 18890.716639250422, 18909.14908829106, 19316.613667726848, 19334.323298684478, 19583.608327833364, 6632.1709786276715, 6878.518503704692, 6905.343992320722, 6967.09427774386, 7051.894221586577, 3692.1877187018813, 3692.390755525362, 3793.5447746270625, 3803.1823158021157, 3803.8478460861256, 3116.735077518391, 3221.7261532769508, 3238.0933338665213, 3238.9838050809594, 3247.1395080303737, 496.3820044045187, 512.8769095417073, 518.8910328830913, 566.1507738392411, 593.519249407981, 470.7081609402193, 481.98313059043466, 530.1471357605194, 598.4165438697236, 600.5495878091432, 7429.665665044978, 7783.377329813715, 8211.254635506182, 8279.958600207081, 8290.212429819157, 535.986600334987, 552.3592632546228, 553.0846449126702, 553.9695316757617, 557.743438018508, 3754.7371683982406, 3833.769973801581, 3966.3852102924093, 3993.4009898515455, 4102.487189101363, 58339.0, 58505.70747146237, 58549.414505855246, 59457.40542594605, 67348.0, 81989.59005205055, 82039.58980205061, 82335.58832205921, 88453.0, 95638.52180739191, 44621.33068003983, 61761.382386175566, 69010.30989690039, 70452.29547704458, 70672.29327706656, 7242.637868106679, 8088.71689490865, 8149.511029338259, 8263.214994575506, 8294.58527073656, 42728.78635606802, 43975.96384578452, 44424.0, 44446.0, 46600.30099548577, 55377.0, 59774.70112649409, 59793.0, 61529.0, 62098.689506552175, 10912.071535022355, 11011.669649910515, 11016.228863979444, 11169.776604467703, 11227.775444491228, 11899.345535995604, 12027.518899243933, 12333.321667308384, 12350.0, 12424.503019879103, 10035.648752293926, 10224.386536807815, 10449.373037617766, 11210.215284929976, 11223.270487418291, 11017.83473247918, 11021.393823339473, 11062.889371106186, 11408.942955285502, 12024.458899349374, 10037.146842518468, 10521.631742888962, 10729.9463502682, 10802.243842930919, 10806.297590656583, 9266.490343031199, 9377.953110234404, 9518.23854091685, 9707.466089365153, 9717.076877696607, 8981.865272020794, 9251.121143491358, 9252.629894804133, 9264.11990860867, 9382.0], "value": 6291.652247372401, "unit": "score"}], "name": "dromaeo_css", "value": 6479.571177528497, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 116.0, 115.0, 115.0, 114.0, 115.0, 115.0, 113.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 123.0, 123.0, 175.0, 125.0, 124.0, 122.0, 122.0, 162.0, 123.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 100.0, 77.0, 77.0, 77.0, 75.0, 106.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 132.0, 84.0, 84.0, 84.0, 111.0, 83.0, 83.0, 122.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 65.0, 65.0, 66.0, 66.0, 65.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 65.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 83.0, 82.0, 84.0, 82.0, 82.0, 88.0, 85.0, 82.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 132.0, 136.0, 145.0, 139.0, 133.0, 132.0, 179.0, 150.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 180.0, 177.0, 175.0, 177.0, 172.0, 175.0, 170.0, 175.0, 173.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 71.0, 70.0, 70.0, 69.0, 69.0, 71.0, 69.0, 69.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1548.9, "alertThreshold": 2.0}]} 03:21:18 INFO - Return code: 0 03:21:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:21:18 INFO - # TBPL SUCCESS # 03:21:18 INFO - Running post-action listener: _resource_record_post_action 03:21:18 INFO - [mozharness: 2016-09-22 10:21:18.396429Z] Finished run-tests step (success) 03:21:18 INFO - Running post-run listener: _resource_record_post_run 03:21:18 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 401604608; Read time: 168; Write time: 356744 03:21:18 INFO - TinderboxPrint: CPU usage
13.0% 03:21:18 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 168 03:21:18 INFO - TinderboxPrint: I/O write bytes / time
401,604,608 / 356,744 03:21:18 INFO - TinderboxPrint: CPU idle
8,346.0 (86.9%) 03:21:18 INFO - TinderboxPrint: CPU user
1,202.4 (12.5%) 03:21:18 INFO - TinderboxPrint: Swap in / out
0 / 0 03:21:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99844096; Read time: 0; Write time: 143736 03:21:18 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290381824; Read time: 148; Write time: 211276 03:21:19 INFO - Running post-run listener: _upload_blobber_files 03:21:19 INFO - Blob upload gear active. 03:21:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:21:19 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:21:19 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:21:19 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:21:19 INFO - (blobuploader) - INFO - Open directory for files ... 03:21:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:21:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:21:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:23 INFO - (blobuploader) - INFO - Done attempting. 03:21:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:21:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:21:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:24 INFO - (blobuploader) - INFO - Done attempting. 03:21:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:21:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:21:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:25 INFO - (blobuploader) - INFO - Done attempting. 03:21:25 INFO - (blobuploader) - INFO - Iteration through files over. 03:21:25 INFO - Return code: 0 03:21:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:21:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:21:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/116b856a0c43be610f516f3768253e27829b7c41691d8b533e34aa186143dfdd25de75d8b510b0152fbb4abeefb69a6524a94b51e71b199a5a68cd8392a5cbd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7edc712cfde2fadd9054bc49d693e6a9a62951563264e949c14bf32d5c1dc1aa988a97accd809bf51e633a602e4b0f8443fa030ac22b8242ccfd8c3a33096def", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/26ed485aee6d1b3204c8f4a6af6970909955d59456bb0704a2bad2464046c3038912a18b3542446f85003c293847d5183d4d20e666b77b4c3b3e125bb09c04d9"} 03:21:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:21:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:21:25 INFO - Contents: 03:21:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/116b856a0c43be610f516f3768253e27829b7c41691d8b533e34aa186143dfdd25de75d8b510b0152fbb4abeefb69a6524a94b51e71b199a5a68cd8392a5cbd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7edc712cfde2fadd9054bc49d693e6a9a62951563264e949c14bf32d5c1dc1aa988a97accd809bf51e633a602e4b0f8443fa030ac22b8242ccfd8c3a33096def", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/26ed485aee6d1b3204c8f4a6af6970909955d59456bb0704a2bad2464046c3038912a18b3542446f85003c293847d5183d4d20e666b77b4c3b3e125bb09c04d9"} 03:21:25 INFO - Running post-run listener: copy_logs_to_upload_dir 03:21:25 INFO - Copying logs to upload dir... 03:21:25 INFO - mkdir: /builds/slave/test/build/upload/logs 03:21:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.576986 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-22 03:21:24.929728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 03:21:24.933539) ========= 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=5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563 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-Non-PGO/sha512/116b856a0c43be610f516f3768253e27829b7c41691d8b533e34aa186143dfdd25de75d8b510b0152fbb4abeefb69a6524a94b51e71b199a5a68cd8392a5cbd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7edc712cfde2fadd9054bc49d693e6a9a62951563264e949c14bf32d5c1dc1aa988a97accd809bf51e633a602e4b0f8443fa030ac22b8242ccfd8c3a33096def", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/26ed485aee6d1b3204c8f4a6af6970909955d59456bb0704a2bad2464046c3038912a18b3542446f85003c293847d5183d4d20e666b77b4c3b3e125bb09c04d9"} build_url:https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/FAzHMMPiRsis5gOeQVBg-g/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-Non-PGO/sha512/116b856a0c43be610f516f3768253e27829b7c41691d8b533e34aa186143dfdd25de75d8b510b0152fbb4abeefb69a6524a94b51e71b199a5a68cd8392a5cbd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7edc712cfde2fadd9054bc49d693e6a9a62951563264e949c14bf32d5c1dc1aa988a97accd809bf51e633a602e4b0f8443fa030ac22b8242ccfd8c3a33096def", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/26ed485aee6d1b3204c8f4a6af6970909955d59456bb0704a2bad2464046c3038912a18b3542446f85003c293847d5183d4d20e666b77b4c3b3e125bb09c04d9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 03:21:24.958532) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:21:24.958839) ========= 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=5bd038846534b2fdfa68eeae000001e2-1474536990.212899-529674563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:21:25.043509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 03:21:25.043999) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 03:21:25.044468) ========= ========= Total master_lag: 0.19 =========