builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1475014570.21 results: success (0) buildid: 20160927133127 builduid: 59f1a1262064464aa2e22e8877cf7b21 revision: a14b893971a6b4bdaa5d8283a1afac5ad8a846be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 15:16:10.212322) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 15:16:10.212683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 15:16:10.212948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 15:16:10.241067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:16:10.241400) ========= 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=fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 15:16:11-- 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% 222M=0s 2016-09-27 15:16:11 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:16:10.347284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:16:10.347554) ========= 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=fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020682 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:16:10.397272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 15:16:10.397566) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a14b893971a6b4bdaa5d8283a1afac5ad8a846be --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 a14b893971a6b4bdaa5d8283a1afac5ad8a846be --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=fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 15:16:11,963 truncating revision to first 12 chars 2016-09-27 15:16:11,963 Setting DEBUG logging. 2016-09-27 15:16:11,964 attempt 1/10 2016-09-27 15:16:11,964 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a14b893971a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 15:16:13,347 unpacking tar archive at: autoland-a14b893971a6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.725774 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 15:16:12.184509) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 15:16:12.184848) ========= script_repo_revision: a14b893971a6b4bdaa5d8283a1afac5ad8a846be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 15:16:12.185222) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 15:16:12.185480) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 15:16:12.202314) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-27 15:16:12.202622) ========= /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=fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:16:13 INFO - MultiFileLogger online at 20160927 15:16:13 in /builds/slave/test 15:16:13 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 15:16:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:16:13 INFO - {'append_to_log': False, 15:16:13 INFO - 'base_work_dir': '/builds/slave/test', 15:16:13 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:16:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:16:13 INFO - 'branch': 'Autoland-Non-PGO', 15:16:13 INFO - 'buildbot_json_path': 'buildprops.json', 15:16:13 INFO - 'config_files': ('talos/linux_config.py',), 15:16:13 INFO - 'default_actions': ('clobber', 15:16:13 INFO - 'read-buildbot-config', 15:16:13 INFO - 'download-and-extract', 15:16:13 INFO - 'populate-webroot', 15:16:13 INFO - 'create-virtualenv', 15:16:13 INFO - 'install', 15:16:13 INFO - 'run-tests'), 15:16:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:16:13 INFO - 'download_minidump_stackwalk': True, 15:16:13 INFO - 'download_symbols': 'ondemand', 15:16:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:16:13 INFO - 'tooltool.py': '/tools/tooltool.py', 15:16:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:16:13 INFO - '/tools/misc-python/virtualenv.py')}, 15:16:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:16:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:16:13 INFO - 'installer_path': 'installer.exe', 15:16:13 INFO - 'log_level': 'info', 15:16:13 INFO - 'log_name': 'talos', 15:16:13 INFO - 'log_to_console': True, 15:16:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:16:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:16:13 INFO - 'opt_config_files': (), 15:16:13 INFO - 'pip_index': False, 15:16:13 INFO - 'sps_profile': False, 15:16:13 INFO - 'sps_profile_interval': 0, 15:16:13 INFO - 'suite': 'dromaeojs', 15:16:13 INFO - 'system_bits': '32', 15:16:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:16:13 INFO - 'title': 'talos-linux64-ix-048', 15:16:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:16:13 INFO - 'use_talos_json': True, 15:16:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:16:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:16:13 INFO - 'work_dir': 'build'} 15:16:13 INFO - [mozharness: 2016-09-27 22:16:13.865371Z] Running clobber step. 15:16:13 INFO - Running pre-action listener: _resource_record_pre_action 15:16:13 INFO - Running main action method: clobber 15:16:13 INFO - rmtree: /builds/slave/test/build 15:16:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:16:14 INFO - Running post-action listener: _resource_record_post_action 15:16:14 INFO - [mozharness: 2016-09-27 22:16:14.333572Z] Finished clobber step (success) 15:16:14 INFO - [mozharness: 2016-09-27 22:16:14.333674Z] Running read-buildbot-config step. 15:16:14 INFO - Running pre-action listener: _resource_record_pre_action 15:16:14 INFO - Running main action method: read_buildbot_config 15:16:14 INFO - Using buildbot properties: 15:16:14 INFO - { 15:16:14 INFO - "project": "", 15:16:14 INFO - "product": "firefox", 15:16:14 INFO - "script_repo_revision": "production", 15:16:14 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:16:14 INFO - "repository": "", 15:16:14 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 15:16:14 INFO - "buildid": "20160927133127", 15:16:14 INFO - "pgo_build": "False", 15:16:14 INFO - "basedir": "/builds/slave/test", 15:16:14 INFO - "buildnumber": 655, 15:16:14 INFO - "slavename": "talos-linux64-ix-048", 15:16:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:16:14 INFO - "platform": "ubuntu64_hw", 15:16:14 INFO - "scheduler": "tests-autoland-linux64-talos", 15:16:14 INFO - "branch": "autoland", 15:16:14 INFO - "repo_path": "integration/autoland", 15:16:14 INFO - "revision": "a14b893971a6b4bdaa5d8283a1afac5ad8a846be", 15:16:14 INFO - "stage_platform": "linux64", 15:16:14 INFO - "builduid": "59f1a1262064464aa2e22e8877cf7b21", 15:16:14 INFO - "slavebuilddir": "test" 15:16:14 INFO - } 15:16:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:16:14 INFO - Running post-action listener: _resource_record_post_action 15:16:14 INFO - [mozharness: 2016-09-27 22:16:14.336118Z] Finished read-buildbot-config step (success) 15:16:14 INFO - [mozharness: 2016-09-27 22:16:14.336207Z] Running download-and-extract step. 15:16:14 INFO - Running pre-action listener: _resource_record_pre_action 15:16:14 INFO - Running main action method: download_and_extract 15:16:14 INFO - mkdir: /builds/slave/test/build/tests 15:16: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')]} 15:16:14 INFO - trying https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:16:14 INFO - Downloading https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/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 15:16:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/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 15:16:14 INFO - Downloaded 1201 bytes. 15:16:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:16:14 INFO - Using the following test package requirements: 15:16:14 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:16:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:16:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:16:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:14 INFO - u'jsshell-linux-x86_64.zip'], 15:16:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:16:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:16:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:16:14 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:16:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:16:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:16:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:16:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:16:14 INFO - Fetch https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:16:15 INFO - Expected file size: 20413666 15:16:15 INFO - Content-Encoding None 15:16:15 INFO - Content-Type application/zip 15:16:15 INFO - Http code 200 15:16:19 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 15:16:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:16:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:16:19 INFO - Fetch https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:16:20 INFO - Expected file size: 20413666 15:16:20 INFO - Content-Encoding None 15:16:20 INFO - Content-Type application/zip 15:16:20 INFO - Http code 200 15:16:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:16:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:16:25 INFO - Fetch https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:16:25 INFO - Expected file size: 14414057 15:16:25 INFO - Content-Encoding None 15:16:25 INFO - Content-Type application/zip 15:16:25 INFO - Http code 200 15:16:26 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')]} 15:16:26 INFO - trying https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:16:26 INFO - Downloading https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/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 15:16:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/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 15:16:27 INFO - Downloaded 55737587 bytes. 15:16:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:16:27 INFO - mkdir: /builds/slave/test/properties 15:16:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:16:27 INFO - Writing to file /builds/slave/test/properties/build_url 15:16:27 INFO - Contents: 15:16:27 INFO - build_url:https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:16:27 INFO - Running post-action listener: _resource_record_post_action 15:16:27 INFO - Running post-action listener: set_extra_try_arguments 15:16:27 INFO - [mozharness: 2016-09-27 22:16:27.870757Z] Finished download-and-extract step (success) 15:16:27 INFO - [mozharness: 2016-09-27 22:16:27.870984Z] Running populate-webroot step. 15:16:27 INFO - Running pre-action listener: _resource_record_pre_action 15:16:27 INFO - Running main action method: populate_webroot 15:16:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:16:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:16:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:16:27 INFO - '--tppagecycles', 15:16:27 INFO - '7'], 15:16:27 INFO - 'tests': ['tsvgm']}}, 15:16:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:16:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:16:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:16:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:16:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:16:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:16:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:27 INFO - 'talos_options': ['--disable-e10s'], 15:16:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:27 INFO - 'talos_options': ['--disable-e10s'], 15:16:27 INFO - 'tests': ['damp', 'tps']}, 15:16:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:27 INFO - 'tests': ['damp', 'tps']}, 15:16:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:16:27 INFO - 'tests': ['dromaeo_dom']}, 15:16:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:16:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:16:27 INFO - 'tests': ['basic_compositor_video']}, 15:16:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:16:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:16:27 INFO - 'tests': ['a11yr', 15:16:27 INFO - 'ts_paint', 15:16:27 INFO - 'tpaint', 15:16:27 INFO - 'sessionrestore', 15:16:27 INFO - 'sessionrestore_no_auto_restore', 15:16:27 INFO - 'tabpaint']}, 15:16:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:16:27 INFO - 'ts_paint', 15:16:27 INFO - 'tpaint', 15:16:27 INFO - 'sessionrestore', 15:16:27 INFO - 'sessionrestore_no_auto_restore', 15:16:27 INFO - 'tabpaint']}, 15:16:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:16:27 INFO - 'ts_paint', 15:16:27 INFO - 'tpaint', 15:16:27 INFO - 'sessionrestore', 15:16:27 INFO - 'sessionrestore_no_auto_restore', 15:16:27 INFO - 'tabpaint']}, 15:16:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:16:27 INFO - 'ts_paint', 15:16:27 INFO - 'tpaint', 15:16:27 INFO - 'sessionrestore', 15:16:27 INFO - 'sessionrestore_no_auto_restore', 15:16:27 INFO - 'tabpaint']}, 15:16:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:16:27 INFO - 'tests': ['a11yr', 15:16:27 INFO - 'ts_paint', 15:16:27 INFO - 'tpaint', 15:16:27 INFO - 'sessionrestore', 15:16:27 INFO - 'sessionrestore_no_auto_restore', 15:16:27 INFO - 'tabpaint']}, 15:16:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:16:27 INFO - 'tests': ['a11yr', 15:16:27 INFO - 'ts_paint', 15:16:27 INFO - 'tpaint', 15:16:27 INFO - 'sessionrestore', 15:16:27 INFO - 'sessionrestore_no_auto_restore', 15:16:27 INFO - 'tabpaint']}, 15:16:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:16:27 INFO - 'tests': ['tsvgx', 15:16:27 INFO - 'tsvgr_opacity', 15:16:27 INFO - 'tart', 15:16:27 INFO - 'tscrollx', 15:16:27 INFO - 'cart']}, 15:16:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:16:27 INFO - 'tsvgr_opacity', 15:16:27 INFO - 'tart', 15:16:27 INFO - 'tscrollx', 15:16:27 INFO - 'cart']}, 15:16:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:27 INFO - 'talos_options': ['--disable-e10s'], 15:16:27 INFO - 'tests': ['tp5o']}, 15:16:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:27 INFO - 'tests': ['tp5o']}, 15:16:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:27 INFO - 'talos_options': ['--disable-e10s', 15:16:27 INFO - '--xperf_path', 15:16:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:27 INFO - 'tests': ['tp5n']}, 15:16:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:27 INFO - 'talos_options': ['--xperf_path', 15:16:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:27 INFO - 'tests': ['tp5n']}}, 15:16:27 INFO - 'talos.zip': {'path': '', 15:16:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:16:27 INFO - Running post-action listener: _resource_record_post_action 15:16:27 INFO - [mozharness: 2016-09-27 22:16:27.888213Z] Finished populate-webroot step (success) 15:16:27 INFO - [mozharness: 2016-09-27 22:16:27.888302Z] Running create-virtualenv step. 15:16:27 INFO - Running pre-action listener: _resource_record_pre_action 15:16:27 INFO - Running main action method: create_virtualenv 15:16:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:16:27 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 15:16:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:16:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:16:27 INFO - Using real prefix '/usr' 15:16:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:16:28 INFO - Installing distribute.............................................................................................................................................................................................done. 15:16:30 INFO - Installing pip.................done. 15:16:30 INFO - Return code: 0 15:16:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:16:30 INFO - Reading from file tmpfile_stdout 15:16:30 INFO - Output received: 15:16:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:16:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f32e9634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c3f60>, '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 0x25c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c51d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', '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 15:16:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:16:30 INFO - Using env: {'DISPLAY': ':0', 15:16:30 INFO - 'HOME': '/home/cltbld', 15:16:30 INFO - 'LANG': 'en_US.UTF-8', 15:16:30 INFO - 'LANGUAGE': 'en_US:en', 15:16:30 INFO - 'LOGNAME': 'cltbld', 15:16:30 INFO - 'MAIL': '/var/mail/cltbld', 15:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:30 INFO - 'MOZ_NO_REMOTE': '1', 15:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:30 INFO - 'NO_EM_RESTART': '1', 15:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:30 INFO - 'PWD': '/builds/slave/test', 15:16:30 INFO - 'SHELL': '/bin/bash', 15:16:30 INFO - 'SHLVL': '1', 15:16:30 INFO - 'TERM': 'linux', 15:16:30 INFO - 'TMOUT': '86400', 15:16:30 INFO - 'USER': 'cltbld', 15:16:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', 15:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:30 INFO - '_': '/tools/buildbot/bin/python'} 15:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:30 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 15:16:30 INFO - Cleaning up... 15:16:30 INFO - Return code: 0 15:16:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f32e9634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c3f60>, '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 0x25c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c51d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', '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 15:16:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:16:30 INFO - Using env: {'DISPLAY': ':0', 15:16:30 INFO - 'HOME': '/home/cltbld', 15:16:30 INFO - 'LANG': 'en_US.UTF-8', 15:16:30 INFO - 'LANGUAGE': 'en_US:en', 15:16:30 INFO - 'LOGNAME': 'cltbld', 15:16:30 INFO - 'MAIL': '/var/mail/cltbld', 15:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:30 INFO - 'MOZ_NO_REMOTE': '1', 15:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:30 INFO - 'NO_EM_RESTART': '1', 15:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:30 INFO - 'PWD': '/builds/slave/test', 15:16:30 INFO - 'SHELL': '/bin/bash', 15:16:30 INFO - 'SHLVL': '1', 15:16:30 INFO - 'TERM': 'linux', 15:16:30 INFO - 'TMOUT': '86400', 15:16:30 INFO - 'USER': 'cltbld', 15:16:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', 15:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:30 INFO - '_': '/tools/buildbot/bin/python'} 15:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:31 INFO - Downloading/unpacking psutil>=3.1.1 15:16:31 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 15:16:31 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 15:16:31 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 15:16:31 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 15:16:31 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 15:16:31 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 15:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:16:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:33 INFO - Installing collected packages: psutil 15:16:33 INFO - Running setup.py install for psutil 15:16:33 INFO - building 'psutil._psutil_linux' extension 15:16:33 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 15:16:33 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 15:16:33 INFO - building 'psutil._psutil_posix' extension 15:16:33 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 15:16:33 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 15:16:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:33 INFO - Successfully installed psutil 15:16:33 INFO - Cleaning up... 15:16:33 INFO - Return code: 0 15:16:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:33 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 0x7f32e9634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c3f60>, '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 0x25c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c51d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', '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 15:16:33 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 15:16:33 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 15:16:33 INFO - Using env: {'DISPLAY': ':0', 15:16:33 INFO - 'HOME': '/home/cltbld', 15:16:33 INFO - 'LANG': 'en_US.UTF-8', 15:16:33 INFO - 'LANGUAGE': 'en_US:en', 15:16:33 INFO - 'LOGNAME': 'cltbld', 15:16:33 INFO - 'MAIL': '/var/mail/cltbld', 15:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:33 INFO - 'MOZ_NO_REMOTE': '1', 15:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:33 INFO - 'NO_EM_RESTART': '1', 15:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:33 INFO - 'PWD': '/builds/slave/test', 15:16:33 INFO - 'SHELL': '/bin/bash', 15:16:33 INFO - 'SHLVL': '1', 15:16:33 INFO - 'TERM': 'linux', 15:16:33 INFO - 'TMOUT': '86400', 15:16:33 INFO - 'USER': 'cltbld', 15:16:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', 15:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:33 INFO - '_': '/tools/buildbot/bin/python'} 15:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:16:35 INFO - Installing collected packages: mozsystemmonitor 15:16:35 INFO - Running setup.py install for mozsystemmonitor 15:16:35 INFO - Successfully installed mozsystemmonitor 15:16:35 INFO - Cleaning up... 15:16:35 INFO - Return code: 0 15:16:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f32e9634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c3f60>, '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 0x25c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c51d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', '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 15:16:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:16:35 INFO - Using env: {'DISPLAY': ':0', 15:16:35 INFO - 'HOME': '/home/cltbld', 15:16:35 INFO - 'LANG': 'en_US.UTF-8', 15:16:35 INFO - 'LANGUAGE': 'en_US:en', 15:16:35 INFO - 'LOGNAME': 'cltbld', 15:16:35 INFO - 'MAIL': '/var/mail/cltbld', 15:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:35 INFO - 'MOZ_NO_REMOTE': '1', 15:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:35 INFO - 'NO_EM_RESTART': '1', 15:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:35 INFO - 'PWD': '/builds/slave/test', 15:16:35 INFO - 'SHELL': '/bin/bash', 15:16:35 INFO - 'SHLVL': '1', 15:16:35 INFO - 'TERM': 'linux', 15:16:35 INFO - 'TMOUT': '86400', 15:16:35 INFO - 'USER': 'cltbld', 15:16:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', 15:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:35 INFO - '_': '/tools/buildbot/bin/python'} 15:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:36 INFO - Downloading/unpacking jsonschema==2.5.1 15:16:36 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 15:16:36 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 15:16:36 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 15:16:36 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 15:16:36 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 15:16:36 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 15:16:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:16:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:38 INFO - Downloading functools32-3.2.3-2.tar.gz 15:16:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:16:38 INFO - warning: no files found matching '*.txt' 15:16:38 INFO - no previously-included directories found matching 'build' 15:16:38 INFO - no previously-included directories found matching 'dist' 15:16:38 INFO - no previously-included directories found matching '.git*' 15:16:38 INFO - Installing collected packages: jsonschema, functools32 15:16:38 INFO - Running setup.py install for functools32 15:16:38 INFO - warning: no files found matching '*.txt' 15:16:38 INFO - no previously-included directories found matching 'build' 15:16:38 INFO - no previously-included directories found matching 'dist' 15:16:38 INFO - no previously-included directories found matching '.git*' 15:16:38 INFO - Successfully installed jsonschema functools32 15:16:38 INFO - Cleaning up... 15:16:38 INFO - Return code: 0 15:16:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:16:38 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')]} 15:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:38 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')]} 15:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:38 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 0x7f32e9634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c3f60>, '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 0x25c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c51d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', '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 15:16:38 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 15:16:38 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 15:16:38 INFO - Using env: {'DISPLAY': ':0', 15:16:38 INFO - 'HOME': '/home/cltbld', 15:16:38 INFO - 'LANG': 'en_US.UTF-8', 15:16:38 INFO - 'LANGUAGE': 'en_US:en', 15:16:38 INFO - 'LOGNAME': 'cltbld', 15:16:38 INFO - 'MAIL': '/var/mail/cltbld', 15:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:38 INFO - 'MOZ_NO_REMOTE': '1', 15:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:38 INFO - 'NO_EM_RESTART': '1', 15:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:38 INFO - 'PWD': '/builds/slave/test', 15:16:38 INFO - 'SHELL': '/bin/bash', 15:16:38 INFO - 'SHLVL': '1', 15:16:38 INFO - 'TERM': 'linux', 15:16:38 INFO - 'TMOUT': '86400', 15:16:38 INFO - 'USER': 'cltbld', 15:16:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', 15:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:38 INFO - '_': '/tools/buildbot/bin/python'} 15:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:16:38 INFO - Cleaning up... 15:16:38 INFO - Return code: 0 15:16:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:16:38 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')]} 15:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:38 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')]} 15:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:38 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 0x7f32e9634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c3f60>, '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 0x25c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c51d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', '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 15:16:38 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 15:16:38 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 15:16:38 INFO - Using env: {'DISPLAY': ':0', 15:16:38 INFO - 'HOME': '/home/cltbld', 15:16:38 INFO - 'LANG': 'en_US.UTF-8', 15:16:38 INFO - 'LANGUAGE': 'en_US:en', 15:16:38 INFO - 'LOGNAME': 'cltbld', 15:16:38 INFO - 'MAIL': '/var/mail/cltbld', 15:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:38 INFO - 'MOZ_NO_REMOTE': '1', 15:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:38 INFO - 'NO_EM_RESTART': '1', 15:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:38 INFO - 'PWD': '/builds/slave/test', 15:16:38 INFO - 'SHELL': '/bin/bash', 15:16:38 INFO - 'SHLVL': '1', 15:16:38 INFO - 'TERM': 'linux', 15:16:38 INFO - 'TMOUT': '86400', 15:16:38 INFO - 'USER': 'cltbld', 15:16:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', 15:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:38 INFO - '_': '/tools/buildbot/bin/python'} 15:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:38 INFO - Downloading/unpacking blobuploader==1.2.4 15:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:40 INFO - Downloading blobuploader-1.2.4.tar.gz 15:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:16:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:16:40 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 15:16:40 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 15:16:40 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 15:16:40 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 15:16:40 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 15:16:40 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 15:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:16:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:16:41 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 15:16:41 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 15:16:41 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 15:16:41 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 15:16:41 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 15:16:41 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 15:16:41 INFO - Downloading docopt-0.6.1.tar.gz 15:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:16:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:16:41 INFO - Running setup.py install for blobuploader 15:16:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:16:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:16:41 INFO - Running setup.py install for requests 15:16:42 INFO - Running setup.py install for docopt 15:16:42 INFO - Successfully installed blobuploader requests docopt 15:16:42 INFO - Cleaning up... 15:16:42 INFO - Return code: 0 15:16:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:42 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 0x7f32e9634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c3f60>, '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 0x25c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c51d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', '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 15:16:42 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 15:16:42 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 15:16:42 INFO - Using env: {'DISPLAY': ':0', 15:16:42 INFO - 'HOME': '/home/cltbld', 15:16:42 INFO - 'LANG': 'en_US.UTF-8', 15:16:42 INFO - 'LANGUAGE': 'en_US:en', 15:16:42 INFO - 'LOGNAME': 'cltbld', 15:16:42 INFO - 'MAIL': '/var/mail/cltbld', 15:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:42 INFO - 'MOZ_NO_REMOTE': '1', 15:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:42 INFO - 'NO_EM_RESTART': '1', 15:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:42 INFO - 'PWD': '/builds/slave/test', 15:16:42 INFO - 'SHELL': '/bin/bash', 15:16:42 INFO - 'SHLVL': '1', 15:16:42 INFO - 'TERM': 'linux', 15:16:42 INFO - 'TMOUT': '86400', 15:16:42 INFO - 'USER': 'cltbld', 15:16:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', 15:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:42 INFO - '_': '/tools/buildbot/bin/python'} 15:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:42 INFO - Running setup.py (path:/tmp/pip-1IbGUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:42 INFO - Running setup.py (path:/tmp/pip-DCLz1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:42 INFO - Running setup.py (path:/tmp/pip-1n4oxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:42 INFO - Running setup.py (path:/tmp/pip-5v_jx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:42 INFO - Running setup.py (path:/tmp/pip-Cweqdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:42 INFO - Running setup.py (path:/tmp/pip-uOKghG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:42 INFO - Running setup.py (path:/tmp/pip-ZDI65d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:42 INFO - Running setup.py (path:/tmp/pip-tz6MZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:43 INFO - Running setup.py (path:/tmp/pip-aO9r2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:43 INFO - Running setup.py (path:/tmp/pip-b3kOOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:43 INFO - Running setup.py (path:/tmp/pip-mt0Yf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:43 INFO - Running setup.py (path:/tmp/pip-UIsnGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:43 INFO - Running setup.py (path:/tmp/pip-ZJSh8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:43 INFO - Running setup.py (path:/tmp/pip-Cpjzeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:43 INFO - Running setup.py (path:/tmp/pip-AEXqOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:43 INFO - Running setup.py (path:/tmp/pip-mFeysO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:43 INFO - Running setup.py (path:/tmp/pip-OCIvia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:16:43 INFO - Running setup.py install for manifestparser 15:16:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:16:43 INFO - Running setup.py install for mozcrash 15:16:43 INFO - Running setup.py install for mozdebug 15:16:43 INFO - Running setup.py install for mozdevice 15:16:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:16:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:16:44 INFO - Running setup.py install for mozfile 15:16:44 INFO - Running setup.py install for mozhttpd 15:16:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:16:44 INFO - Running setup.py install for mozinfo 15:16:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:16:44 INFO - Running setup.py install for mozInstall 15:16:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:16:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:16:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:16:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:16:44 INFO - Running setup.py install for mozleak 15:16:44 INFO - Running setup.py install for mozlog 15:16:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:16:44 INFO - Running setup.py install for moznetwork 15:16:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:16:44 INFO - Running setup.py install for mozprocess 15:16:44 INFO - Running setup.py install for mozprofile 15:16:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:16:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:16:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:16:45 INFO - Running setup.py install for mozrunner 15:16:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:16:45 INFO - Running setup.py install for mozscreenshot 15:16:45 INFO - Running setup.py install for moztest 15:16:45 INFO - Running setup.py install for mozversion 15:16:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:16:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:16:45 INFO - Cleaning up... 15:16:45 INFO - Return code: 0 15:16:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:45 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 0x7f32e9634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c3f60>, '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 0x25c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c51d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', '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 15:16:45 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 15:16:45 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 15:16:45 INFO - Using env: {'DISPLAY': ':0', 15:16:45 INFO - 'HOME': '/home/cltbld', 15:16:45 INFO - 'LANG': 'en_US.UTF-8', 15:16:45 INFO - 'LANGUAGE': 'en_US:en', 15:16:45 INFO - 'LOGNAME': 'cltbld', 15:16:45 INFO - 'MAIL': '/var/mail/cltbld', 15:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:45 INFO - 'MOZ_NO_REMOTE': '1', 15:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:45 INFO - 'NO_EM_RESTART': '1', 15:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:45 INFO - 'PWD': '/builds/slave/test', 15:16:45 INFO - 'SHELL': '/bin/bash', 15:16:45 INFO - 'SHLVL': '1', 15:16:45 INFO - 'TERM': 'linux', 15:16:45 INFO - 'TMOUT': '86400', 15:16:45 INFO - 'USER': 'cltbld', 15:16:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', 15:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:45 INFO - '_': '/tools/buildbot/bin/python'} 15:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:45 INFO - Running setup.py (path:/tmp/pip-XQoJKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:45 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)) 15:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:45 INFO - Running setup.py (path:/tmp/pip-JfKnjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:45 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)) 15:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:45 INFO - Running setup.py (path:/tmp/pip-ouHe2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:45 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)) 15:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:45 INFO - Running setup.py (path:/tmp/pip-nvgGFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:45 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)) 15:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:45 INFO - Running setup.py (path:/tmp/pip-2Ny3Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:46 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)) 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:46 INFO - Running setup.py (path:/tmp/pip-Tc4Ko7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:46 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)) 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:46 INFO - Running setup.py (path:/tmp/pip-6z_mTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:46 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)) 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:46 INFO - Running setup.py (path:/tmp/pip-I9uTyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:46 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)) 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:46 INFO - Running setup.py (path:/tmp/pip-GS2Fn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:46 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)) 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:46 INFO - Running setup.py (path:/tmp/pip-qcjkM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:46 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)) 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:46 INFO - Running setup.py (path:/tmp/pip-u5f0jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:46 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)) 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:46 INFO - Running setup.py (path:/tmp/pip-VxP7l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:46 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)) 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:46 INFO - Running setup.py (path:/tmp/pip-5hR_DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:46 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)) 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:46 INFO - Running setup.py (path:/tmp/pip-7WkDyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:46 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)) 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:46 INFO - Running setup.py (path:/tmp/pip-zjeJxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:46 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)) 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:46 INFO - Running setup.py (path:/tmp/pip-5QfeLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:46 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)) 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:46 INFO - Running setup.py (path:/tmp/pip-UQGY03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:46 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)) 15:16:46 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)) 15:16:46 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)) 15:16:46 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)) 15:16:46 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)) 15:16:46 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)) 15:16:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:16:46 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 15:16:46 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 15:16:46 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 15:16:46 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 15:16:46 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 15:16:46 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 15:16:48 INFO - Downloading blessings-1.6.tar.gz 15:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:16:48 INFO - Installing collected packages: blessings 15:16:48 INFO - Running setup.py install for blessings 15:16:49 INFO - Successfully installed blessings 15:16:49 INFO - Cleaning up... 15:16:49 INFO - Return code: 0 15:16:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:16:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:49 INFO - Reading from file tmpfile_stdout 15:16:49 INFO - Current package versions: 15:16:49 INFO - argparse == 1.2.1 15:16:49 INFO - blessings == 1.6 15:16:49 INFO - blobuploader == 1.2.4 15:16:49 INFO - docopt == 0.6.1 15:16:49 INFO - functools32 == 3.2.3-2 15:16:49 INFO - jsonschema == 2.5.1 15:16:49 INFO - manifestparser == 1.1 15:16:49 INFO - mozInstall == 1.12 15:16:49 INFO - mozcrash == 0.17 15:16:49 INFO - mozdebug == 0.1 15:16:49 INFO - mozdevice == 0.48 15:16:49 INFO - mozfile == 1.2 15:16:49 INFO - mozhttpd == 0.7 15:16:49 INFO - mozinfo == 0.9 15:16:49 INFO - mozleak == 0.1 15:16:49 INFO - mozlog == 3.4 15:16:49 INFO - moznetwork == 0.27 15:16:49 INFO - mozprocess == 0.23 15:16:49 INFO - mozprofile == 0.28 15:16:49 INFO - mozrunner == 6.12 15:16:49 INFO - mozscreenshot == 0.1 15:16:49 INFO - mozsystemmonitor == 0.3 15:16:49 INFO - moztest == 0.7 15:16:49 INFO - mozversion == 1.4 15:16:49 INFO - psutil == 3.1.1 15:16:49 INFO - requests == 1.2.3 15:16:49 INFO - wsgiref == 0.1.2 15:16:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:49 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 0x7f32e9634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c3f60>, '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 0x25c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c51d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', '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 15:16:49 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 15:16:49 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 15:16:49 INFO - Using env: {'DISPLAY': ':0', 15:16:49 INFO - 'HOME': '/home/cltbld', 15:16:49 INFO - 'LANG': 'en_US.UTF-8', 15:16:49 INFO - 'LANGUAGE': 'en_US:en', 15:16:49 INFO - 'LOGNAME': 'cltbld', 15:16:49 INFO - 'MAIL': '/var/mail/cltbld', 15:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:49 INFO - 'MOZ_NO_REMOTE': '1', 15:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:49 INFO - 'NO_EM_RESTART': '1', 15:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:49 INFO - 'PWD': '/builds/slave/test', 15:16:49 INFO - 'SHELL': '/bin/bash', 15:16:49 INFO - 'SHLVL': '1', 15:16:49 INFO - 'TERM': 'linux', 15:16:49 INFO - 'TMOUT': '86400', 15:16:49 INFO - 'USER': 'cltbld', 15:16:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', 15:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:49 INFO - '_': '/tools/buildbot/bin/python'} 15:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:49 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)) 15:16:49 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)) 15:16:49 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)) 15:16:49 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)) 15:16:49 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)) 15:16:49 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)) 15:16:49 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)) 15:16:49 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)) 15:16:49 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)) 15:16:49 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)) 15:16:49 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)) 15:16:49 INFO - Cleaning up... 15:16:49 INFO - Return code: 0 15:16:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f32e9634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c3f60>, '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 0x25c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c51d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', '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 15:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:16:49 INFO - Using env: {'DISPLAY': ':0', 15:16:49 INFO - 'HOME': '/home/cltbld', 15:16:49 INFO - 'LANG': 'en_US.UTF-8', 15:16:49 INFO - 'LANGUAGE': 'en_US:en', 15:16:49 INFO - 'LOGNAME': 'cltbld', 15:16:49 INFO - 'MAIL': '/var/mail/cltbld', 15:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:49 INFO - 'MOZ_NO_REMOTE': '1', 15:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:49 INFO - 'NO_EM_RESTART': '1', 15:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:49 INFO - 'PWD': '/builds/slave/test', 15:16:49 INFO - 'SHELL': '/bin/bash', 15:16:49 INFO - 'SHLVL': '1', 15:16:49 INFO - 'TERM': 'linux', 15:16:49 INFO - 'TMOUT': '86400', 15:16:49 INFO - 'USER': 'cltbld', 15:16:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', 15:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:49 INFO - '_': '/tools/buildbot/bin/python'} 15:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:16:49 INFO - Cleaning up... 15:16:49 INFO - Return code: 0 15:16:49 INFO - Running post-action listener: _resource_record_post_action 15:16:49 INFO - Running post-action listener: _start_resource_monitoring 15:16:49 INFO - Starting resource monitoring. 15:16:49 INFO - [mozharness: 2016-09-27 22:16:49.755879Z] Finished create-virtualenv step (success) 15:16:49 INFO - [mozharness: 2016-09-27 22:16:49.756349Z] Running install step. 15:16:49 INFO - Running pre-action listener: _resource_record_pre_action 15:16:49 INFO - Running main action method: install 15:16:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:49 INFO - Reading from file tmpfile_stdout 15:16:49 INFO - Detecting whether we're running mozinstall >=1.0... 15:16:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:16:50 INFO - Reading from file tmpfile_stdout 15:16:50 INFO - Output received: 15:16:50 INFO - Usage: mozinstall [options] installer 15:16:50 INFO - Options: 15:16:50 INFO - -h, --help show this help message and exit 15:16:50 INFO - -d DEST, --destination=DEST 15:16:50 INFO - Directory to install application into. [default: 15:16:50 INFO - "/builds/slave/test"] 15:16:50 INFO - --app=APP Application being installed. [default: firefox] 15:16:50 INFO - mkdir: /builds/slave/test/build/application 15:16:50 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'] 15:16:50 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 15:17:06 INFO - Reading from file tmpfile_stdout 15:17:06 INFO - Output received: 15:17:06 INFO - /builds/slave/test/build/application/firefox/firefox 15:17:06 INFO - Running post-action listener: _resource_record_post_action 15:17:06 INFO - [mozharness: 2016-09-27 22:17:06.155897Z] Finished install step (success) 15:17:06 INFO - [mozharness: 2016-09-27 22:17:06.156145Z] Running run-tests step. 15:17:06 INFO - Running pre-action listener: _resource_record_pre_action 15:17:06 INFO - Running main action method: run_tests 15:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:17:06 INFO - Python 2.7.3 15:17:06 INFO - Return code: 0 15:17:06 INFO - grabbing minidump binary from tooltool 15:17: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')]} 15:17:06 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 0x25c3f60>, '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 0x25c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:17:06 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 15:17:06 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 15:17:06 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 15:17:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:17:06 INFO - Return code: 0 15:17:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:17:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:17:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:17:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:17:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:17:06 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/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 15:17:06 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/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 15:17:06 INFO - Using env: {'DISPLAY': ':0', 15:17:06 INFO - 'HOME': '/home/cltbld', 15:17:06 INFO - 'LANG': 'en_US.UTF-8', 15:17:06 INFO - 'LANGUAGE': 'en_US:en', 15:17:06 INFO - 'LOGNAME': 'cltbld', 15:17:06 INFO - 'MAIL': '/var/mail/cltbld', 15:17:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:17:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:06 INFO - 'MOZ_NO_REMOTE': '1', 15:17:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:06 INFO - 'NO_EM_RESTART': '1', 15:17:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:06 INFO - 'PWD': '/builds/slave/test', 15:17:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:17:06 INFO - 'SHELL': '/bin/bash', 15:17:06 INFO - 'SHLVL': '1', 15:17:06 INFO - 'TERM': 'linux', 15:17:06 INFO - 'TMOUT': '86400', 15:17:06 INFO - 'USER': 'cltbld', 15:17:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179', 15:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:06 INFO - '_': '/tools/buildbot/bin/python'} 15:17:06 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/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 15:17:06 INFO - mozversion application_buildid: 20160927133127 15:17:06 INFO - mozversion application_changeset: a14b893971a6b4bdaa5d8283a1afac5ad8a846be 15:17:06 INFO - mozversion application_display_name: Nightly 15:17:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:17:06 INFO - mozversion application_name: Firefox 15:17:06 INFO - mozversion application_remotingname: firefox 15:17:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:17:06 INFO - mozversion application_vendor: Mozilla 15:17:06 INFO - mozversion application_version: 52.0a1 15:17:06 INFO - mozversion platform_buildid: 20160927133127 15:17:06 INFO - mozversion platform_changeset: a14b893971a6b4bdaa5d8283a1afac5ad8a846be 15:17:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:17:06 INFO - mozversion platform_version: 52.0a1 15:17:06 INFO - using testdate: 1475014626 15:17:06 INFO - actual date: 1475014626 15:17:06 INFO - starting webserver on 'localhost:35028' 15:17:06 INFO - SUITE-START | Running 2 tests 15:17:06 INFO - TEST-START | dromaeo_css 15:17:06 INFO - operating with platform_type : linux_ 15:17:06 INFO - Initialising browser for dromaeo_css test... 15:17:06 INFO - TEST-INFO | started process 8445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGCCofc/profile http://localhost:35028/getInfo.html) 15:17:11 INFO - PROCESS | 8445 | __metrics Screen width/height:1600/1200 15:17:11 INFO - PROCESS | 8445 | colorDepth:24 15:17:11 INFO - PROCESS | 8445 | Browser inner width/height: 1024/697 15:17:11 INFO - PROCESS | 8445 | __metrics 15:17:11 INFO - PROCESS | 8445 | 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" 15:17:11 INFO - PROCESS | 8445 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:17:12 INFO - PROCESS | 8445 | console.error: PushService: 15:17:12 INFO - PROCESS | 8445 | stateChangeProcessEnqueue: Error transitioning state 15:17:12 INFO - PROCESS | 8445 | UnknownError 15:17:13 INFO - TEST-INFO | 8445: exit 0 15:17:13 INFO - Browser initialized. 15:17:13 INFO - Running cycle 1/1 for dromaeo_css test... 15:17:13 INFO - TEST-INFO | started process 8528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGCCofc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:25 INFO - PROCESS | 8528 | RSS: Main: 175534080 15:17:25 INFO - PROCESS | 8528 | 15:18:17 INFO - PROCESS | 8528 | 1475014697177 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] 15:20:29 INFO - PROCESS | 8528 | Cycle 1(1): loaded http://localhost:35028/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35028/tests/dromaeo/cssquery-ext.html) 15:20:30 INFO - PROCESS | 8528 | RSS: Main: 321011712 15:20:30 INFO - PROCESS | 8528 | 15:23:33 INFO - PROCESS | 8528 | Cycle 1(1): loaded http://localhost:35028/tests/dromaeo/cssquery-ext.html (next: http://localhost:35028/tests/dromaeo/cssquery-jquery.html) 15:23:34 INFO - PROCESS | 8528 | RSS: Main: 278396928 15:23:34 INFO - PROCESS | 8528 | 15:26:36 INFO - PROCESS | 8528 | Cycle 1(1): loaded http://localhost:35028/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35028/tests/dromaeo/cssquery-mootools.html) 15:26:36 INFO - PROCESS | 8528 | RSS: Main: 252530688 15:26:36 INFO - PROCESS | 8528 | 15:29:39 INFO - PROCESS | 8528 | Cycle 1(1): loaded http://localhost:35028/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35028/tests/dromaeo/cssquery-prototype.html) 15:29:39 INFO - PROCESS | 8528 | RSS: Main: 220270592 15:29:39 INFO - PROCESS | 8528 | 15:32:43 INFO - PROCESS | 8528 | Cycle 1(1): loaded http://localhost:35028/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35028/tests/dromaeo/cssquery-yui.html) 15:32:43 INFO - PROCESS | 8528 | RSS: Main: 218767360 15:32:43 INFO - PROCESS | 8528 | 15:35:46 INFO - PROCESS | 8528 | Cycle 1(1): loaded http://localhost:35028/tests/dromaeo/cssquery-yui.html (next: http://localhost:35028/tests/dromaeo/cssquery-dojo.html) 15:35:46 INFO - PROCESS | 8528 | RSS: Main: 312492032 15:35:46 INFO - PROCESS | 8528 | 15:35:46 INFO - PROCESS | 8528 | __start_tp_report 15:35:46 INFO - PROCESS | 8528 | _x_x_mozilla_page_load 15:35:46 INFO - PROCESS | 8528 | _x_x_mozilla_page_load_details 15:35:46 INFO - PROCESS | 8528 | |i|pagename|runs| 15:35:46 INFO - PROCESS | 8528 | |0;dojo.html;2544.796416286697;2573.5753600655894;2620.7117217106115;2626.8161228713993;2632.131396639108;4591.908161836761;4698.718076915383;4720.858374248769;4784.760761961906;4797.784099715513;4680.953190468094;4711.528847115295;4726.645501587377;4726.7400292983875;4798.904021919559;4340.7395556266565;4351.673624478169;4361.760103194323;4368.803403846819;4435.223835828717;4449.777511124447;4465.843695470659;4469.44131983502;4476.574725401082;4480.686351955364;4438.134563760068;4448;4461.598456138947;4471.9776401118115;4517.435320584927;4272.957270427287;4279.272523670983;4324.891877703051;4326.221280169569;4410.184115938561;4301.225779359714;4303.978480107579;4317.589828966243;4379.693421460499;4387.42963414754;4667.113248482778;4718.386609740712;4750.097481478508;4750.382450281441;4796.8081276749235;4927.088488629615;4997.525235102659;5047;5049.065922804256;5053.4946505349535;4944.851654450372;4992.775325110379;5011.523905228997;5020.59835213182;5071.3407257056715;4652.069586082729;4652.883677908012;4684.250519916831;4687.179743544934;4710;4998.375203099613;5084.237364395371;5088.618353623493;5088.898222035538;5151.304573882553;4894.241392584155;4957.7769000395065;5005.374328208974;5011.022850544109;5092.796288148433;5095.286659867622;5101.69389836611;5107.106256405114;5115.8721031973755;5165;5043.243513472935;5050.520200580939;5061.316722242524;5062;5116.411612664517;4931.778069986859;4948.777305021283;4969.0807200668;4994.925076123861;4999.75001249936;4184.2050010498515;4210.789460526961;4283.293256612624;4292.5707429257445;4292.635126014261;3689.262147570497;3744.3634582121103;3758.361078616642;3775.301569209705;3786.9775160706454;4256.2764330063965;4259.105587826529;4260.297050986553;4307.956920430755;4311.073119279307;4949.950500495021;4994;4999.900002000012;5008.17365134756;5058.721770302595;4225.317122372209;4262.914741705211;4295.677824163137;4300.913981720348;4349.782510874444;4529.818807247739;4537.795799189044;4538.954610453853;4541.296099104644;4600.907981840344;4691.5308469152815;4701.459332176843;4704.29435584665;4705;4715.81136754526;4961.900761984813;4980.452150263396;4994.425641051325;5007.273945277841;5008.449070602158;4694.530546945278;4702.435707714959;4731.313959475926;4751.904961900674;4764.404449443819;4968.27959945813;4970.229614409773;4974.403071631283;4976.328195693535;5041.495850414929;4884.096442158212;4986.326845875906;5030.974845125751;5044.445111037856;5106.540411362995;4908.410990681141;4960.23116416956;4976.452590215146;4981.2030075187795;5033.395992480926;4970.552650261494;4976.950230497649;4978.377702787152;4982.302477653204;5039.496050394931;4727.125481785881;4798.808047678193;4909.140900342497;4916.557509824133;4917.754112294299;4909.705417674951;4920.950790492049;4938.43208031081;4940.258961155711;5011.724355160355;4706.8117275308605;4818.638602104927;4825.927611085766;4891.192953162688;4909.558139767438 15:35:46 INFO - PROCESS | 8528 | |1;ext.html;542.2814770429183;556.0630337880674;562.6905202138823;567.4977644784365;570.3754388944108;28233.15300540982;38047.23905521892;39140.60859391402;39268.607313926856;43022.56977430225;40099.19801603966;40418.59581404185;40423.19153616926;40483.987900302505;40497.797511012475;7611.923880761205;7763.689452421896;7773.367592805517;7779.7666070017995;7785.1436342002335;7628.160902300742;7700.229977002311;7713.5757533335645;7714.884276735854;7717.807054823618;7701.152873183945;7742.303192712655;7743.18696536864;7743.767686969371;7745.612719364038;7677.462577619569;7724.806879828049;7736.303732664087;7741;7743;7667.463277570572;7705;7725.188855170239;7732.574708391093;7734;37955;38069;38225;38257.426138607945;38266.55600995896;3183.984080079608;3235.9838200808845;3258.283177700902;3497.440409534462;3751.7936513491745;27524.44951100987;28063.438731225262;28118.859405702842;28127.29681757952;28217.435651287065;3305.7024867762016;3314.2045908981913;3367.64997030292;3373;3405.8126803025825;242277;243198;243338;243567;243603;51358;52053.47946520562;52063;52088;52130.21804672933;55628.44371556314;55668;55717;55724.72137639286;55754.72122639361;12196.207246529124;12313.938430307791;12350.197237179555;12367.257964521978;12370.81443778344;9209.033051529626;9220.677276295297;9221.354505184572;9262.95368523153;9282.303827212985;13899.65250868716;15853.762193567105;15947.920260398856;15964.840351596567;15983.961042532199;6050.598514375243;6070.392960703983;6145.66198859067;6237.625742455467;6344.460720838781;765.8430021845509;852.6504133305315;884.9867251991225;909.2998391238841;909.6077316657296;27988.72011279902;28164.29589260244;28312;28591.14226573206;28795.56806647902;900.4687234531658;934.5327336331834;938.9765255868658;951.5004622573205;964;14322.212278324792;14865.925670371578;14900.776488352683;15088.622784430258;15115.244237788067;350185;351552;352693;353436;354548;49623.50376496261;49977.25034124418;49984.500154998714;50035.4982250886;50050.24924626134;1051.9053285204368;1089.0470838016736;1093.6172339681207;1143.3768596115137;1177.0289511153333;26900.59649105226;28940.710592894644;30023;31128.377432451678;32345.19137021499;46516.30225546687;47015.76492117518;47270;47332;47469.762651186524;336293;340846;341380;341462;342537;35716;36898;36966.815165923996;36976;37039.81480092582;41338.061348475494;41410.89514650873;43093.35359969666;44615.55384446114;45975.54024459713;35263;35519;35666.46500302446;35709.928702137935;35894.28211435809;35945.820270898475;36171.819140904125;36224.27551449009;36971.44542831806;37090.44364334591;28455.573166402108;30826.229344266572;31590.997710434945;35987;37890.810545948196;30180.54729179108;32931.50602741009;33312.50031249485;33500.49749253812;33558.328833423686;24733.381665458506;25227;25276.49447011086;25314.367140821625;25495.36261593475 15:35:46 INFO - PROCESS | 8528 | |2;jquery.html;358.51600339541625;369.5879094809288;369.91122130688626;378.16803033326653;387.1753165756937;15592.84407155928;16225.83774162258;16670.41653542128;16691.248893799777;16725;15725.84274157258;16156;16437.67124657506;16441.506754797345;16503.09232992185;4951.207806750929;5208.244804503363;5209.82778874754;5210.921836172461;5214.504622060898;3664.5602527696715;3846.8845934622004;3862.8454861805494;3866.2460820140086;5068.949310506903;3918.784466854322;3935.134270460494;3969.789030375047;6109.389061093877;6124.724387402578;5846.1523079153285;6093.512518998469;6100.145979562887;6100.938990610126;6103.847403814896;5272.683638981635;5278.551323137538;5285.0709491035495;5286.762095705664;5289;19936.601267974704;20383.49041273965;20518.38444846657;20535.691964620542;20565.4858628534;1903.0960293860444;1954.2476146683487;1959.7452331196996;2133.541288622938;2508.3854455658297;12525.373731313397;12673.176243544232;12764.80852787209;13084.607461776162;13621.25083120428;1684.941027064047;1772.787265528132;1795.2280519376664;1850.5466160790559;1853.3142737187327;68251.65874170647;68494.65752671254;68559.31440685579;68911;70400;9590.712278631652;9849.113579777855;9903.61349411083;9941.900580994243;10071;13578.388972496261;13610.63893610631;13642.590722278348;13680.042397032312;13697;6435.549511534241;6511.511636627272;6601.801945941629;6623.602583844985;6673.933260667428;6110.083487476825;6153.446189842935;6185.876282474325;6289.937100629027;6303.905441418382;4189.198644582859;4244.745315281093;4254.638355739735;4282.250606143913;4349.217140914602;1785.1252886085724;1800.189914538463;1836.4674244469222;1852.9166187521594;1901.1349835824667;383.059588709717;692.8521583092473;739.209046320432;822.5311572403673;824.3199360527589;10019.549120289605;10593.470326483644;10637.62768303121;10787;11037.83443248352;394.28240602104466;395.6617092386026;408.6179422240215;412.42878613120445;427.0540752233755;5643.351014633287;5715.914261286084;5735.971320143372;5746.712664366765;5872.588918775645;134095;327160;402914;403316;403928;74418.25581744222;74567.25432745712;76518.61740691372;77789;79439;411.2802595457949;418.08022350828907;420.2435615891444;422.0545977011472;422.4128461438603;9692.563834627317;9781.119699227103;9900.158486528439;9919.851202232117;9956.402615843073;32920.83539582287;33716;34465.48301775425;35144.47283290701;35653.28693426065;47337;47553;50804;51832;52133.7393313031;6923.134608173978;6960.9303906962305;6965.825854353681;7023.543469674455;7072.3634872861685;10618.964793378467;10869.456527173768;10907.563697452331;10972.506237219184;11074.114070874472;9183.357164998386;9483.288753343664;9491.85762213581;9698.70903872885;9787.314887957775;9493.477858717837;9526.809463810823;9661.951690241503;9711.708648740549;9825.263105266991;9584.520773961414;9769.902300976899;9895.158911492605;9983.450910200008;10280.569097602169;7107;7216;7297.416206703345;7370;7551.244875512405;8636.229572937658;9280.443173409618;9347;9732.124108829956;9755.268354873555 15:35:46 INFO - PROCESS | 8528 | |3;mootools.html;1338.8326459192601;1349.2376807103985;1415.7734762438013;1587.8174009988854;1654.9917250413753;6765.221999470063;7027.789166325006;7102.715891364346;7689.269519395655;7689.500182488135;7101.5739055656695;7446.739364122257;7448.329650331469;7587.20334364892;7589.696412143508;2137;2166.794154555315;2169.1648715244587;2174.7281589801273;2175.8041776240134;1823.0975667044831;1898.8670793044491;2025.8987050647481;2110.873347599149;2136.038782547852;2105.515731381783;2148.5380643161716;2149.602323570137;2150.7849215078522;2153.3755210988875;2083.7707852136327;2096.968545471819;2111.092230340953;2111.2505060703384;2113.9471513212293;2050.2311633137574;2058.9485262868398;2066.6486697261503;2067.576146889884;2111.3349294972036;7667.504836556874;7728.072631284282;7731.45879788415;7739.380849532024;7742.53544787309;4355.5644435556505;4455.398521199661;4483.932741008887;4509.977450112761;4510.819567217307;2798.5242508773354;2868.4836729388703;2888;2931.589577459157;2946.911592652224;931.7065124485765;933.5472295936465;945.3429866242964;956.067833861986;975.2490582251697;10328.741781455448;10393.584256629725;10397.84403233952;10410.739731506697;10420.270581059329;3978.104926391539;3983.661388781928;4186.748795072244;4201.873943781691;4228.4080228768;8130.308923741548;8183.263506284344;8203.015638123463;8205.425620206648;8211.137830527829;4461.330800379904;4465.776711164429;4465.799039043251;4467.061916997402;4468.396766436555;4009.67922566194;4065.593440655911;4138.8344466221015;4144.44050053245;4144.854930077433;3112.4708799504137;3159.842007899596;3218.6781321868093;3229.54786329914;3243.918902027421;907.609727817045;923.930705197113;938.8075444533854;946.3895787217207;948.6347756113946;811.3955103447969;819.8032472206628;827.7640872351351;828.225609055535;848.9430658829673;5115.5396014358885;5149.124648809711;5195.818146364859;5207.765650545659;5421.770463163338;850.7362717557577;870.1863757386864;871.4161511786991;871.877937088808;877.8419884420865;3441.7074548663145;3534.929301414009;3548.91127721809;3559.359315323215;3640.21735326906;9034.45793252407;9135.360524763335;9285;9295.907040929504;9297.628094876129;9239.538023098952;9255.68607848038;9259.814803703888;9270.397424167542;9273.953630231807;6722.260551339349;6958.443324534025;7017.754378596826;7063.223045464994;7150;5445.26488924006;5491.258680078298;5521.503064724034;5736.139579063174;5817.592768506164;8513.276371508491;8535.146485351415;8571.485710857369;8571.657133714582;8577.656893724181;8536;8722.694705685271;8769.91230087691;8847.336449766422;8925.955370223108;6460.12788273577;6626.105475760711;6627.105340779126;6631.801045968628;6637.568558043712;7245.166805817398;7272.600006999666;7274.818129546804;7276.672549735169;7279.1265048194555;6292.3078461368295;6570.901436478553;6701.966490167518;6752.122224110834;6759.2564817869015;6557.540972132096;6652.634105124071;6652.90020649681;6675.132232809704;6678.599284042973;5857.414258574279;5888.911666325094;5916.763329466773;5923.259592550931;5974.1934838796205;4511.819527218874;4516.638668906546;4597.448306203277;4633.72197668141;4725.1967165581245;4608.930866037079;4672.883177920579;4675.298705194248;4676.392069031141;4687.695299805502 15:35:46 INFO - PROCESS | 8528 | |4;prototype.html;286.16582661541605;290.45974487453344;290.8240514488735;298.418084734767;301.36111443739276;4770.403699537558;4799.4480634727015;4800.351952486413;4804.5435683610085;4814.759262036897;4737.313089602006;4738.739369334685;4739.360186374847;4741.810327586901;4764.952350476494;3504.6495350464943;3632.400653892105;3677.1542545214616;3749.2501499700033;3760.172761992357;3767.6232376762377;3767.773933563995;3769.453429252757;3770.9811450942707;3773.584905660389;3738.719596030295;3741.3078580462566;3742.719296052793;3752.287065457568;3753.831077601501;3522.383582872987;3611.693006094485;3636.5999740028574;3682.39240525313;3751.6248375162404;3305.685959833836;3308.470644696861;3312.9171770705684;3317.618473875487;3329.1344250495044;4602.631789456836;4610.585047345755;4612.347899957538;4625.213713668684;4628.699134556243;4117.938230926538;4202.789860506993;4250.723702959298;4252.255855225323;4254.234237837188;4890.682105663121;4923.350677523034;4923.975380123113;4925.187344088257;4930.950690493085;3596.352656521825;3599.226166374242;3600.963990360115;3601.819909004539;3608.657177568127;5172.844814655567;5179.006082658166;5181.740912954375;5192.766325515361;5200.765965531522;3374.2407958209697;3573.8034408107283;3578.731595130376;3581.803000834927;3592.9281414371567;3619.6199399063244;3620.5112309837837;3621.6378362163573;3625.093726568358;3629.6733294003666;4115.42384066225;4120.795374474642;4145.647619952338;4147.191297696981;4159.251334759772;4733.9763301183275;4960.404751429852;4962.727050012212;4979.676321039121;4988.750562471934;1201.2612243470203;1224.577520755338;1227.1900545640012;1228.2507670321097;1228.975420491585;768.7271018788362;793.0008189680929;799.2087833045359;803.4255507312183;804.3565147881671;4162.895927601834;4241.618254357123;4296.634786043159;4404.977975110104;4410.580994805488;5140.151874940593;5142.948570514247;5148.124818780741;5150.356205474316;5157.690538567623;4393.1872603568445;4394.538573449806;4396.450443694538;4398.428204333416;4406.1187762447;2618.489394568079;2693.8518381488816;2720.2519307190287;2721.319670082479;2725.4737347085697;4804.903901922012;4810.879728006757;4812.470628230892;4815.3258543803895;4826.565609095128;5234.842954711365;5249.060526105393;5262.079136151158;5266.709656134195;5274;4588.472325682523;4830.8309209178215;4860.878478038077;4861.44093429246;4872.293517439952;5142.151544995034;5151.716655583829;5165.225216217597;5175.81884634036;5186.766595503136;4869.732164730832;5083.2883396323805;5096.46487118862;5097.133487307241;5131.409887862944;4835.927461088017;4862.3922009748785;4866.489018653132;4867.80528778859;4881.194602890483;3594.5686517618055;3611.602723700338;3614;3615.728820338538;3616.855325786939;5159.303494028258;5163.68326076848;5180.7409629519125;5184.637075404837;5194.584433245256;4834.5890599299455;4990.226514890198;5007.5993920487;5018.799248030038;5026.170681837456;5007.624428167829;5008.6243531734535;5015.598752099896;5022.121128802518;5032.169692000779;4943.283223932582;4957.975210123926;4964.851054468371;4972.627052971114;4978.60171186297;4796.448408433075;4806.759662016815;4926.827561035347;5039.21892106724;5058.027369325892;4787.4494433140635;4926.926096108489;4929.97535012337;4930.2604609307455;4932.482089380707 15:35:46 INFO - PROCESS | 8528 | |5;yui.html;624.6751689121656;639.0254861336458;669.8492839111203;707.1478867964104;720.2941117704651;12495.187812792163;13315.80026299605;13365.866341336583;13372.465101395945;13513.662158446044;12954;12985.870141298608;12993.61019169424;13003.414846331914;13039.413226404811;616.1681729664962;636.3286732497213;735.5182355557118;743.650484272391;761.7486229544265;759.2028370211284;759.5594555158023;763.9236076392372;764.4190415284396;764.6291548598953;805.118395357086;806.2944923192207;806.3065763443434;807.1524898856178;807.1968391450515;638.7604648256927;656.2617055812211;659.0180630860032;660.2934859700123;802.0335495727634;571.3572231239855;588.5027152056548;590.1442907783688;590.799128296377;591.7485068845723;12704.364781760874;12711.872881271254;12725.490980360866;12725.872741272655;12741.745165096647;11785.764284714343;12327.876721232762;12439.564615238423;13171.275579843104;13551.39018744159;11877.406129693481;11966.22219555726;12054.638360849189;12112.454939527743;12446.377681115908;4219.2827219372475;4225.873223803291;4228.851990180359;4424.181526417623;4445.288753799409;64326;65107.67446162786;65363.63001605945;66233;66309.66845165743;10207.489625518694;10333.94833025845;10400;10419.94790026045;10422.270441069053;16804.327826886787;17667.73498397525;17812.020338881226;18545.53636159107;18620.813791861907;6866.279040700754;7105.396041336544;7282.868366602412;7356.96321518389;7426.517276377018;3620.7465477416854;3734.3838266685693;3744.382176940774;3746.119661879456;3811.3330167220624;2878.3667593129476;2980.940381192364;2992.551117332374;3030.772692048105;3032.529957856536;506.5365190850331;515.317204703769;521.723486552128;530.9522143007148;559.6250512156864;558.9692566908777;587.7208326045094;595.961262517935;603.4538742438101;608.1880689279861;7760.767176984699;8047.356211503065;8165.755027349189;8465.867628977318;8606.31149508038;460.4267686729976;475.7407213068886;503.4638110412399;580.2717589425245;587.9029960056542;3876.8449262029767;3970.1265721541213;4021.155557332993;4173.791310434466;4184.2468355695655;93266;98039;101050.4947475258;105705.47147264215;106410.46794766131;85571.89656374209;87179;89350;90688.54655726811;91394.54302728576;76400.61799691078;76421.23578764252;77262.61368693232;77622;78466.6076669613;7232.962155894642;7504.399648028254;7633.69465221385;7634.961825190839;7649.273319034683;41702;42747.5725242756;43503;43637.34543981779;44497.55502445064;59036.40963590309;59480.702596488474;65733.34266657272;68599.31400686128;68743.65628171827;9915.553800079158;10147.84778228342;10349.068583827491;10382.650255467042;10431.321964072311;11233.269837460539;11490.77018459643;11611.825822612836;12320.199187052813;12345.321007344683;10406.687799366031;10424.68725938223;10704.464776760975;11038.668839934493;11521.654350369503;10037.899621003697;10228.744281393025;10280.556013735482;10680.946595266974;10773.084287835622;9922.206223502248;10233.84649230277;10272.435016074187;10410.739731506774;11375.374354410587;8645.178708022728;8747.125287471203;8880.955595221982;9057.275417966679;9200.539973001189;8704.651813927372;9169.449833010041;9250.907490925005;9417;9495.715128546155 15:35:46 INFO - PROCESS | 8528 | __end_tp_report 15:35:46 INFO - PROCESS | 8528 | __start_cc_report 15:35:46 INFO - PROCESS | 8528 | _x_x_mozilla_cycle_collect,1228 15:35:46 INFO - PROCESS | 8528 | __end_cc_report 15:35:46 INFO - PROCESS | 8528 | __startTimestamp1475015746965__endTimestamp 15:35:46 INFO - PROCESS | 8528 | 15:35:46 INFO - PROCESS | 8528 | ------- Summary: start ------- 15:35:46 INFO - PROCESS | 8528 | Number of tests: 6 15:35:46 INFO - PROCESS | 8528 | 15:35:46 INFO - PROCESS | 8528 | [#0] dojo.html Cycles:165 Average:4660.93 Median:4764.40 stddev:487.72 (10.2%) stddev-sans-first:460.10 15:35:46 INFO - PROCESS | 8528 | Values: 2544.8 2573.6 2620.7 2626.8 2632.1 4591.9 4698.7 4720.9 4784.8 4797.8 4681.0 4711.5 4726.6 4726.7 4798.9 4340.7 4351.7 4361.8 4368.8 4435.2 4449.8 4465.8 4469.4 4476.6 4480.7 4438.1 4448.0 4461.6 4472.0 4517.4 4273.0 4279.3 4324.9 4326.2 4410.2 4301.2 4304.0 4317.6 4379.7 4387.4 4667.1 4718.4 4750.1 4750.4 4796.8 4927.1 4997.5 5047.0 5049.1 5053.5 4944.9 4992.8 5011.5 5020.6 5071.3 4652.1 4652.9 4684.3 4687.2 4710.0 4998.4 5084.2 5088.6 5088.9 5151.3 4894.2 4957.8 5005.4 5011.0 5092.8 5095.3 5101.7 5107.1 5115.9 5165.0 5043.2 5050.5 5061.3 5062.0 5116.4 4931.8 4948.8 4969.1 4994.9 4999.8 4184.2 4210.8 4283.3 4292.6 4292.6 3689.3 3744.4 3758.4 3775.3 3787.0 4256.3 4259.1 4260.3 4308.0 4311.1 4950.0 4994.0 4999.9 5008.2 5058.7 4225.3 4262.9 4295.7 4300.9 4349.8 4529.8 4537.8 4539.0 4541.3 4600.9 4691.5 4701.5 4704.3 4705.0 4715.8 4961.9 4980.5 4994.4 5007.3 5008.4 4694.5 4702.4 4731.3 4751.9 4764.4 4968.3 4970.2 4974.4 4976.3 5041.5 4884.1 4986.3 5031.0 5044.4 5106.5 4908.4 4960.2 4976.5 4981.2 5033.4 4970.6 4977.0 4978.4 4982.3 5039.5 4727.1 4798.8 4909.1 4916.6 4917.8 4909.7 4921.0 4938.4 4940.3 5011.7 4706.8 4818.6 4825.9 4891.2 4909.6 15:35:46 INFO - PROCESS | 8528 | 15:35:46 INFO - PROCESS | 8528 | [#1] ext.html Cycles:180 Average:47030.49 Median:37922.91 stddev:83049.76 (219.0%) stddev-sans-first:83209.39 15:35:46 INFO - PROCESS | 8528 | Values: 542.3 556.1 562.7 567.5 570.4 28233.2 38047.2 39140.6 39268.6 43022.6 40099.2 40418.6 40423.2 40484.0 40497.8 7611.9 7763.7 7773.4 7779.8 7785.1 7628.2 7700.2 7713.6 7714.9 7717.8 7701.2 7742.3 7743.2 7743.8 7745.6 7677.5 7724.8 7736.3 7741.0 7743.0 7667.5 7705.0 7725.2 7732.6 7734.0 37955.0 38069.0 38225.0 38257.4 38266.6 3184.0 3236.0 3258.3 3497.4 3751.8 27524.4 28063.4 28118.9 28127.3 28217.4 3305.7 3314.2 3367.6 3373.0 3405.8 242277.0 243198.0 243338.0 243567.0 243603.0 51358.0 52053.5 52063.0 52088.0 52130.2 55628.4 55668.0 55717.0 55724.7 55754.7 12196.2 12313.9 12350.2 12367.3 12370.8 9209.0 9220.7 9221.4 9263.0 9282.3 13899.7 15853.8 15947.9 15964.8 15984.0 6050.6 6070.4 6145.7 6237.6 6344.5 765.8 852.7 885.0 909.3 909.6 27988.7 28164.3 28312.0 28591.1 28795.6 900.5 934.5 939.0 951.5 964.0 14322.2 14865.9 14900.8 15088.6 15115.2 350185.0 351552.0 352693.0 353436.0 354548.0 49623.5 49977.3 49984.5 50035.5 50050.2 1051.9 1089.0 1093.6 1143.4 1177.0 26900.6 28940.7 30023.0 31128.4 32345.2 46516.3 47015.8 47270.0 47332.0 47469.8 336293.0 340846.0 341380.0 341462.0 342537.0 35716.0 36898.0 36966.8 36976.0 37039.8 41338.1 41410.9 43093.4 44615.6 45975.5 35263.0 35519.0 35666.5 35709.9 35894.3 35945.8 36171.8 36224.3 36971.4 37090.4 28455.6 30826.2 31591.0 35987.0 37890.8 30180.5 32931.5 33312.5 33500.5 33558.3 24733.4 25227.0 25276.5 25314.4 25495.4 15:35:46 INFO - PROCESS | 8528 | 15:35:46 INFO - PROCESS | 8528 | [#2] jquery.html Cycles:180 Average:22038.01 Median:47445.00 stddev:58357.97 (123.0%) stddev-sans-first:58498.97 15:35:46 INFO - PROCESS | 8528 | Values: 358.5 369.6 369.9 378.2 387.2 15592.8 16225.8 16670.4 16691.2 16725.0 15725.8 16156.0 16437.7 16441.5 16503.1 4951.2 5208.2 5209.8 5210.9 5214.5 3664.6 3846.9 3862.8 3866.2 5068.9 3918.8 3935.1 3969.8 6109.4 6124.7 5846.2 6093.5 6100.1 6100.9 6103.8 5272.7 5278.6 5285.1 5286.8 5289.0 19936.6 20383.5 20518.4 20535.7 20565.5 1903.1 1954.2 1959.7 2133.5 2508.4 12525.4 12673.2 12764.8 13084.6 13621.3 1684.9 1772.8 1795.2 1850.5 1853.3 68251.7 68494.7 68559.3 68911.0 70400.0 9590.7 9849.1 9903.6 9941.9 10071.0 13578.4 13610.6 13642.6 13680.0 13697.0 6435.5 6511.5 6601.8 6623.6 6673.9 6110.1 6153.4 6185.9 6289.9 6303.9 4189.2 4244.7 4254.6 4282.3 4349.2 1785.1 1800.2 1836.5 1852.9 1901.1 383.1 692.9 739.2 822.5 824.3 10019.5 10593.5 10637.6 10787.0 11037.8 394.3 395.7 408.6 412.4 427.1 5643.4 5715.9 5736.0 5746.7 5872.6 134095.0 327160.0 402914.0 403316.0 403928.0 74418.3 74567.3 76518.6 77789.0 79439.0 411.3 418.1 420.2 422.1 422.4 9692.6 9781.1 9900.2 9919.9 9956.4 32920.8 33716.0 34465.5 35144.5 35653.3 47337.0 47553.0 50804.0 51832.0 52133.7 6923.1 6960.9 6965.8 7023.5 7072.4 10619.0 10869.5 10907.6 10972.5 11074.1 9183.4 9483.3 9491.9 9698.7 9787.3 9493.5 9526.8 9662.0 9711.7 9825.3 9584.5 9769.9 9895.2 9983.5 10280.6 7107.0 7216.0 7297.4 7370.0 7551.2 8636.2 9280.4 9347.0 9732.1 9755.3 15:35:46 INFO - PROCESS | 8528 | 15:35:46 INFO - PROCESS | 8528 | [#3] mootools.html Cycles:180 Average:4976.91 Median:5873.16 stddev:2762.33 (47.0%) stddev-sans-first:2756.55 15:35:46 INFO - PROCESS | 8528 | Values: 1338.8 1349.2 1415.8 1587.8 1655.0 6765.2 7027.8 7102.7 7689.3 7689.5 7101.6 7446.7 7448.3 7587.2 7589.7 2137.0 2166.8 2169.2 2174.7 2175.8 1823.1 1898.9 2025.9 2110.9 2136.0 2105.5 2148.5 2149.6 2150.8 2153.4 2083.8 2097.0 2111.1 2111.3 2113.9 2050.2 2058.9 2066.6 2067.6 2111.3 7667.5 7728.1 7731.5 7739.4 7742.5 4355.6 4455.4 4483.9 4510.0 4510.8 2798.5 2868.5 2888.0 2931.6 2946.9 931.7 933.5 945.3 956.1 975.2 10328.7 10393.6 10397.8 10410.7 10420.3 3978.1 3983.7 4186.7 4201.9 4228.4 8130.3 8183.3 8203.0 8205.4 8211.1 4461.3 4465.8 4465.8 4467.1 4468.4 4009.7 4065.6 4138.8 4144.4 4144.9 3112.5 3159.8 3218.7 3229.5 3243.9 907.6 923.9 938.8 946.4 948.6 811.4 819.8 827.8 828.2 848.9 5115.5 5149.1 5195.8 5207.8 5421.8 850.7 870.2 871.4 871.9 877.8 3441.7 3534.9 3548.9 3559.4 3640.2 9034.5 9135.4 9285.0 9295.9 9297.6 9239.5 9255.7 9259.8 9270.4 9274.0 6722.3 6958.4 7017.8 7063.2 7150.0 5445.3 5491.3 5521.5 5736.1 5817.6 8513.3 8535.1 8571.5 8571.7 8577.7 8536.0 8722.7 8769.9 8847.3 8926.0 6460.1 6626.1 6627.1 6631.8 6637.6 7245.2 7272.6 7274.8 7276.7 7279.1 6292.3 6570.9 6702.0 6752.1 6759.3 6557.5 6652.6 6652.9 6675.1 6678.6 5857.4 5888.9 5916.8 5923.3 5974.2 4511.8 4516.6 4597.4 4633.7 4725.2 4608.9 4672.9 4675.3 4676.4 4687.7 15:35:46 INFO - PROCESS | 8528 | 15:35:46 INFO - PROCESS | 8528 | [#4] prototype.html Cycles:180 Average:4133.97 Median:4753.38 stddev:1213.86 (25.5%) stddev-sans-first:1182.40 15:35:46 INFO - PROCESS | 8528 | Values: 286.2 290.5 290.8 298.4 301.4 4770.4 4799.4 4800.4 4804.5 4814.8 4737.3 4738.7 4739.4 4741.8 4765.0 3504.6 3632.4 3677.2 3749.3 3760.2 3767.6 3767.8 3769.5 3771.0 3773.6 3738.7 3741.3 3742.7 3752.3 3753.8 3522.4 3611.7 3636.6 3682.4 3751.6 3305.7 3308.5 3312.9 3317.6 3329.1 4602.6 4610.6 4612.3 4625.2 4628.7 4117.9 4202.8 4250.7 4252.3 4254.2 4890.7 4923.4 4924.0 4925.2 4931.0 3596.4 3599.2 3601.0 3601.8 3608.7 5172.8 5179.0 5181.7 5192.8 5200.8 3374.2 3573.8 3578.7 3581.8 3592.9 3619.6 3620.5 3621.6 3625.1 3629.7 4115.4 4120.8 4145.6 4147.2 4159.3 4734.0 4960.4 4962.7 4979.7 4988.8 1201.3 1224.6 1227.2 1228.3 1229.0 768.7 793.0 799.2 803.4 804.4 4162.9 4241.6 4296.6 4405.0 4410.6 5140.2 5142.9 5148.1 5150.4 5157.7 4393.2 4394.5 4396.5 4398.4 4406.1 2618.5 2693.9 2720.3 2721.3 2725.5 4804.9 4810.9 4812.5 4815.3 4826.6 5234.8 5249.1 5262.1 5266.7 5274.0 4588.5 4830.8 4860.9 4861.4 4872.3 5142.2 5151.7 5165.2 5175.8 5186.8 4869.7 5083.3 5096.5 5097.1 5131.4 4835.9 4862.4 4866.5 4867.8 4881.2 3594.6 3611.6 3614.0 3615.7 3616.9 5159.3 5163.7 5180.7 5184.6 5194.6 4834.6 4990.2 5007.6 5018.8 5026.2 5007.6 5008.6 5015.6 5022.1 5032.2 4943.3 4958.0 4964.9 4972.6 4978.6 4796.4 4806.8 4926.8 5039.2 5058.0 4787.4 4926.9 4930.0 4930.3 4932.5 15:35:46 INFO - PROCESS | 8528 | 15:35:46 INFO - PROCESS | 8528 | [#5] yui.html Cycles:180 Average:17988.32 Median:518.52 stddev:26398.83 (5091.2%) stddev-sans-first:26440.69 15:35:46 INFO - PROCESS | 8528 | Values: 624.7 639.0 669.8 707.1 720.3 12495.2 13315.8 13365.9 13372.5 13513.7 12954.0 12985.9 12993.6 13003.4 13039.4 616.2 636.3 735.5 743.7 761.7 759.2 759.6 763.9 764.4 764.6 805.1 806.3 806.3 807.2 807.2 638.8 656.3 659.0 660.3 802.0 571.4 588.5 590.1 590.8 591.7 12704.4 12711.9 12725.5 12725.9 12741.7 11785.8 12327.9 12439.6 13171.3 13551.4 11877.4 11966.2 12054.6 12112.5 12446.4 4219.3 4225.9 4228.9 4424.2 4445.3 64326.0 65107.7 65363.6 66233.0 66309.7 10207.5 10333.9 10400.0 10419.9 10422.3 16804.3 17667.7 17812.0 18545.5 18620.8 6866.3 7105.4 7282.9 7357.0 7426.5 3620.7 3734.4 3744.4 3746.1 3811.3 2878.4 2980.9 2992.6 3030.8 3032.5 506.5 515.3 521.7 531.0 559.6 559.0 587.7 596.0 603.5 608.2 7760.8 8047.4 8165.8 8465.9 8606.3 460.4 475.7 503.5 580.3 587.9 3876.8 3970.1 4021.2 4173.8 4184.2 93266.0 98039.0 101050.5 105705.5 106410.5 85571.9 87179.0 89350.0 90688.5 91394.5 76400.6 76421.2 77262.6 77622.0 78466.6 7233.0 7504.4 7633.7 7635.0 7649.3 41702.0 42747.6 43503.0 43637.3 44497.6 59036.4 59480.7 65733.3 68599.3 68743.7 9915.6 10147.8 10349.1 10382.7 10431.3 11233.3 11490.8 11611.8 12320.2 12345.3 10406.7 10424.7 10704.5 11038.7 11521.7 10037.9 10228.7 10280.6 10680.9 10773.1 9922.2 10233.8 10272.4 10410.7 11375.4 8645.2 8747.1 8881.0 9057.3 9200.5 8704.7 9169.4 9250.9 9417.0 9495.7 15:35:46 INFO - PROCESS | 8528 | -------- Summary: end -------- 15:35:46 INFO - PROCESS | 8528 | 15:35:47 INFO - TEST-INFO | 8528: exit 0 15:35:47 INFO - TEST-OK | dromaeo_css | took 1121528ms 15:35:47 INFO - TEST-START | kraken 15:35:47 INFO - operating with platform_type : linux_ 15:35:47 INFO - Initialising browser for kraken test... 15:35:47 INFO - TEST-INFO | started process 8833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDoi0UF/profile http://localhost:35028/getInfo.html) 15:35:53 INFO - PROCESS | 8833 | __metrics Screen width/height:1600/1200 15:35:53 INFO - PROCESS | 8833 | colorDepth:24 15:35:53 INFO - PROCESS | 8833 | Browser inner width/height: 1024/697 15:35:53 INFO - PROCESS | 8833 | __metrics 15:35:53 INFO - PROCESS | 8833 | 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" 15:35:53 INFO - PROCESS | 8833 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:35:54 INFO - PROCESS | 8833 | console.error: PushService: 15:35:54 INFO - PROCESS | 8833 | stateChangeProcessEnqueue: Error transitioning state 15:35:54 INFO - PROCESS | 8833 | UnknownError 15:35:54 INFO - TEST-INFO | 8833: exit 0 15:35:54 INFO - Browser initialized. 15:35:54 INFO - Running cycle 1/1 for kraken test... 15:35:54 INFO - TEST-INFO | started process 8913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDoi0UF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:36:07 INFO - PROCESS | 8913 | RSS: Main: 174473216 15:36:07 INFO - PROCESS | 8913 | 15:36:09 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35028/tests/kraken/driver.html?testName=audio-beat-detection) 15:36:10 INFO - PROCESS | 8913 | RSS: Main: 238190592 15:36:10 INFO - PROCESS | 8913 | 15:36:13 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35028/tests/kraken/driver.html?testName=audio-dft) 15:36:14 INFO - PROCESS | 8913 | RSS: Main: 218324992 15:36:14 INFO - PROCESS | 8913 | 15:36:17 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35028/tests/kraken/driver.html?testName=audio-fft) 15:36:18 INFO - PROCESS | 8913 | RSS: Main: 300077056 15:36:18 INFO - PROCESS | 8913 | 15:36:20 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35028/tests/kraken/driver.html?testName=audio-oscillator) 15:36:20 INFO - PROCESS | 8913 | RSS: Main: 210001920 15:36:20 INFO - PROCESS | 8913 | 15:36:23 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35028/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:36:23 INFO - PROCESS | 8913 | RSS: Main: 214228992 15:36:23 INFO - PROCESS | 8913 | 15:36:26 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35028/tests/kraken/driver.html?testName=imaging-darkroom) 15:36:27 INFO - PROCESS | 8913 | RSS: Main: 250363904 15:36:27 INFO - PROCESS | 8913 | 15:36:30 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35028/tests/kraken/driver.html?testName=imaging-desaturate) 15:36:31 INFO - PROCESS | 8913 | RSS: Main: 243642368 15:36:31 INFO - PROCESS | 8913 | 15:36:34 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35028/tests/kraken/driver.html?testName=json-parse-financial) 15:36:35 INFO - PROCESS | 8913 | RSS: Main: 246583296 15:36:35 INFO - PROCESS | 8913 | 15:36:36 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35028/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:36:37 INFO - PROCESS | 8913 | RSS: Main: 211001344 15:36:37 INFO - PROCESS | 8913 | 15:36:39 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35028/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:36:39 INFO - PROCESS | 8913 | RSS: Main: 218820608 15:36:39 INFO - PROCESS | 8913 | 15:36:42 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35028/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:36:42 INFO - PROCESS | 8913 | RSS: Main: 223502336 15:36:42 INFO - PROCESS | 8913 | 15:36:45 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:36:46 INFO - PROCESS | 8913 | RSS: Main: 223457280 15:36:46 INFO - PROCESS | 8913 | 15:36:49 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:36:49 INFO - PROCESS | 8913 | RSS: Main: 221442048 15:36:49 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | Cycle 1(1): loaded http://localhost:35028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35028/tests/kraken/driver.html?testName=ai-astar) 15:36:51 INFO - PROCESS | 8913 | RSS: Main: 273027072 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | __start_tp_report 15:36:51 INFO - PROCESS | 8913 | _x_x_mozilla_page_load 15:36:51 INFO - PROCESS | 8913 | _x_x_mozilla_page_load_details 15:36:51 INFO - PROCESS | 8913 | |i|pagename|runs| 15:36:51 INFO - PROCESS | 8913 | |0;ai-astar;112;115;116;113;113;115;114;115;113;112 15:36:51 INFO - PROCESS | 8913 | |1;audio-beat-detection;160;122;124;159;124;126;126;123;165;123 15:36:51 INFO - PROCESS | 8913 | |2;audio-dft;161;169;160;163;162;162;163;162;162;162 15:36:51 INFO - PROCESS | 8913 | |3;audio-fft;76;79;79;110;79;78;77;80;100;77 15:36:51 INFO - PROCESS | 8913 | |4;audio-oscillator;86;84;113;83;84;83;115;82;83;114 15:36:51 INFO - PROCESS | 8913 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 15:36:51 INFO - PROCESS | 8913 | |6;imaging-darkroom;150;150;150;150;150;150;150;150;149;147 15:36:51 INFO - PROCESS | 8913 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;95 15:36:51 INFO - PROCESS | 8913 | |8;json-parse-financial;63;63;63;62;64;64;64;65;63;64 15:36:51 INFO - PROCESS | 8913 | |9;json-stringify-tinderbox;66;67;65;66;65;66;67;65;66;66 15:36:51 INFO - PROCESS | 8913 | |10;stanford-crypto-aes;83;83;83;92;83;92;82;85;89;82 15:36:51 INFO - PROCESS | 8913 | |11;stanford-crypto-ccm;135;135;135;140;133;136;133;132;172;133 15:36:51 INFO - PROCESS | 8913 | |12;stanford-crypto-pbkdf2;177;174;176;175;180;181;184;177;177;176 15:36:51 INFO - PROCESS | 8913 | |13;stanford-crypto-sha256-iterative;69;70;70;70;71;70;70;71;67;68 15:36:51 INFO - PROCESS | 8913 | __end_tp_report 15:36:51 INFO - PROCESS | 8913 | __start_cc_report 15:36:51 INFO - PROCESS | 8913 | _x_x_mozilla_cycle_collect,1982 15:36:51 INFO - PROCESS | 8913 | __end_cc_report 15:36:51 INFO - PROCESS | 8913 | __startTimestamp1475015811919__endTimestamp 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | ------- Summary: start ------- 15:36:51 INFO - PROCESS | 8913 | Number of tests: 14 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.50 stddev:1.40 (1.2%) stddev-sans-first:1.32 15:36:51 INFO - PROCESS | 8913 | Values: 112.0 115.0 116.0 113.0 113.0 115.0 114.0 115.0 113.0 112.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:126.00 stddev:18.14 (14.4%) stddev-sans-first:16.88 15:36:51 INFO - PROCESS | 8913 | Values: 160.0 122.0 124.0 159.0 124.0 126.0 126.0 123.0 165.0 123.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:2.41 (1.5%) stddev-sans-first:2.49 15:36:51 INFO - PROCESS | 8913 | Values: 161.0 169.0 160.0 163.0 162.0 162.0 163.0 162.0 162.0 162.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#3] audio-fft Cycles:10 Average:83.50 Median:78.50 stddev:11.64 (14.8%) stddev-sans-first:12.02 15:36:51 INFO - PROCESS | 8913 | Values: 76.0 79.0 79.0 110.0 79.0 78.0 77.0 80.0 100.0 77.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:83.00 stddev:14.74 (17.8%) stddev-sans-first:15.44 15:36:51 INFO - PROCESS | 8913 | Values: 86.0 84.0 113.0 83.0 84.0 83.0 115.0 82.0 83.0 114.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:36:51 INFO - PROCESS | 8913 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 15:36:51 INFO - PROCESS | 8913 | Values: 150.0 150.0 150.0 150.0 150.0 150.0 150.0 150.0 149.0 147.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:36:51 INFO - PROCESS | 8913 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:64.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 15:36:51 INFO - PROCESS | 8913 | Values: 63.0 63.0 63.0 62.0 64.0 64.0 64.0 65.0 63.0 64.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 15:36:51 INFO - PROCESS | 8913 | Values: 66.0 67.0 65.0 66.0 65.0 66.0 67.0 65.0 66.0 66.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.00 stddev:4.03 (4.8%) stddev-sans-first:4.18 15:36:51 INFO - PROCESS | 8913 | Values: 83.0 83.0 83.0 92.0 83.0 92.0 82.0 85.0 89.0 82.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:135.00 stddev:12.02 (8.9%) stddev-sans-first:12.69 15:36:51 INFO - PROCESS | 8913 | Values: 135.0 135.0 135.0 140.0 133.0 136.0 133.0 132.0 172.0 133.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:177.00 stddev:3.06 (1.7%) stddev-sans-first:3.23 15:36:51 INFO - PROCESS | 8913 | Values: 177.0 174.0 176.0 175.0 180.0 181.0 184.0 177.0 177.0 176.0 15:36:51 INFO - PROCESS | 8913 | 15:36:51 INFO - PROCESS | 8913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.26 (1.8%) stddev-sans-first:1.32 15:36:51 INFO - PROCESS | 8913 | Values: 69.0 70.0 70.0 70.0 71.0 70.0 70.0 71.0 67.0 68.0 15:36:51 INFO - PROCESS | 8913 | -------- Summary: end -------- 15:36:51 INFO - PROCESS | 8913 | 15:36:53 INFO - TEST-INFO | 8913: exit 0 15:36:53 INFO - TEST-OK | kraken | took 65226ms 15:36:53 INFO - SUITE-END | took 1186s 15:36:53 INFO - Completed test suite (00:19:47) 15:36:53 INFO - javascript benchmark 15:36:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2544.796416286697, 2573.5753600655894, 2620.7117217106115, 2626.8161228713993, 2632.131396639108, 4591.908161836761, 4698.718076915383, 4720.858374248769, 4784.760761961906, 4797.784099715513, 4680.953190468094, 4711.528847115295, 4726.645501587377, 4726.7400292983875, 4798.904021919559, 4340.7395556266565, 4351.673624478169, 4361.760103194323, 4368.803403846819, 4435.223835828717, 4449.777511124447, 4465.843695470659, 4469.44131983502, 4476.574725401082, 4480.686351955364, 4438.134563760068, 4448.0, 4461.598456138947, 4471.9776401118115, 4517.435320584927, 4272.957270427287, 4279.272523670983, 4324.891877703051, 4326.221280169569, 4410.184115938561, 4301.225779359714, 4303.978480107579, 4317.589828966243, 4379.693421460499, 4387.42963414754, 4667.113248482778, 4718.386609740712, 4750.097481478508, 4750.382450281441, 4796.8081276749235, 4927.088488629615, 4997.525235102659, 5047.0, 5049.065922804256, 5053.4946505349535, 4944.851654450372, 4992.775325110379, 5011.523905228997, 5020.59835213182, 5071.3407257056715, 4652.069586082729, 4652.883677908012, 4684.250519916831, 4687.179743544934, 4710.0, 4998.375203099613, 5084.237364395371, 5088.618353623493, 5088.898222035538, 5151.304573882553, 4894.241392584155, 4957.7769000395065, 5005.374328208974, 5011.022850544109, 5092.796288148433, 5095.286659867622, 5101.69389836611, 5107.106256405114, 5115.8721031973755, 5165.0, 5043.243513472935, 5050.520200580939, 5061.316722242524, 5062.0, 5116.411612664517, 4931.778069986859, 4948.777305021283, 4969.0807200668, 4994.925076123861, 4999.75001249936, 4184.2050010498515, 4210.789460526961, 4283.293256612624, 4292.5707429257445, 4292.635126014261, 3689.262147570497, 3744.3634582121103, 3758.361078616642, 3775.301569209705, 3786.9775160706454, 4256.2764330063965, 4259.105587826529, 4260.297050986553, 4307.956920430755, 4311.073119279307, 4949.950500495021, 4994.0, 4999.900002000012, 5008.17365134756, 5058.721770302595, 4225.317122372209, 4262.914741705211, 4295.677824163137, 4300.913981720348, 4349.782510874444, 4529.818807247739, 4537.795799189044, 4538.954610453853, 4541.296099104644, 4600.907981840344, 4691.5308469152815, 4701.459332176843, 4704.29435584665, 4705.0, 4715.81136754526, 4961.900761984813, 4980.452150263396, 4994.425641051325, 5007.273945277841, 5008.449070602158, 4694.530546945278, 4702.435707714959, 4731.313959475926, 4751.904961900674, 4764.404449443819, 4968.27959945813, 4970.229614409773, 4974.403071631283, 4976.328195693535, 5041.495850414929, 4884.096442158212, 4986.326845875906, 5030.974845125751, 5044.445111037856, 5106.540411362995, 4908.410990681141, 4960.23116416956, 4976.452590215146, 4981.2030075187795, 5033.395992480926, 4970.552650261494, 4976.950230497649, 4978.377702787152, 4982.302477653204, 5039.496050394931, 4727.125481785881, 4798.808047678193, 4909.140900342497, 4916.557509824133, 4917.754112294299, 4909.705417674951, 4920.950790492049, 4938.43208031081, 4940.258961155711, 5011.724355160355, 4706.8117275308605, 4818.638602104927, 4825.927611085766, 4891.192953162688, 4909.558139767438], "value": 4629.409293388199, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.2814770429183, 556.0630337880674, 562.6905202138823, 567.4977644784365, 570.3754388944108, 28233.15300540982, 38047.23905521892, 39140.60859391402, 39268.607313926856, 43022.56977430225, 40099.19801603966, 40418.59581404185, 40423.19153616926, 40483.987900302505, 40497.797511012475, 7611.923880761205, 7763.689452421896, 7773.367592805517, 7779.7666070017995, 7785.1436342002335, 7628.160902300742, 7700.229977002311, 7713.5757533335645, 7714.884276735854, 7717.807054823618, 7701.152873183945, 7742.303192712655, 7743.18696536864, 7743.767686969371, 7745.612719364038, 7677.462577619569, 7724.806879828049, 7736.303732664087, 7741.0, 7743.0, 7667.463277570572, 7705.0, 7725.188855170239, 7732.574708391093, 7734.0, 37955.0, 38069.0, 38225.0, 38257.426138607945, 38266.55600995896, 3183.984080079608, 3235.9838200808845, 3258.283177700902, 3497.440409534462, 3751.7936513491745, 27524.44951100987, 28063.438731225262, 28118.859405702842, 28127.29681757952, 28217.435651287065, 3305.7024867762016, 3314.2045908981913, 3367.64997030292, 3373.0, 3405.8126803025825, 242277.0, 243198.0, 243338.0, 243567.0, 243603.0, 51358.0, 52053.47946520562, 52063.0, 52088.0, 52130.21804672933, 55628.44371556314, 55668.0, 55717.0, 55724.72137639286, 55754.72122639361, 12196.207246529124, 12313.938430307791, 12350.197237179555, 12367.257964521978, 12370.81443778344, 9209.033051529626, 9220.677276295297, 9221.354505184572, 9262.95368523153, 9282.303827212985, 13899.65250868716, 15853.762193567105, 15947.920260398856, 15964.840351596567, 15983.961042532199, 6050.598514375243, 6070.392960703983, 6145.66198859067, 6237.625742455467, 6344.460720838781, 765.8430021845509, 852.6504133305315, 884.9867251991225, 909.2998391238841, 909.6077316657296, 27988.72011279902, 28164.29589260244, 28312.0, 28591.14226573206, 28795.56806647902, 900.4687234531658, 934.5327336331834, 938.9765255868658, 951.5004622573205, 964.0, 14322.212278324792, 14865.925670371578, 14900.776488352683, 15088.622784430258, 15115.244237788067, 350185.0, 351552.0, 352693.0, 353436.0, 354548.0, 49623.50376496261, 49977.25034124418, 49984.500154998714, 50035.4982250886, 50050.24924626134, 1051.9053285204368, 1089.0470838016736, 1093.6172339681207, 1143.3768596115137, 1177.0289511153333, 26900.59649105226, 28940.710592894644, 30023.0, 31128.377432451678, 32345.19137021499, 46516.30225546687, 47015.76492117518, 47270.0, 47332.0, 47469.762651186524, 336293.0, 340846.0, 341380.0, 341462.0, 342537.0, 35716.0, 36898.0, 36966.815165923996, 36976.0, 37039.81480092582, 41338.061348475494, 41410.89514650873, 43093.35359969666, 44615.55384446114, 45975.54024459713, 35263.0, 35519.0, 35666.46500302446, 35709.928702137935, 35894.28211435809, 35945.820270898475, 36171.819140904125, 36224.27551449009, 36971.44542831806, 37090.44364334591, 28455.573166402108, 30826.229344266572, 31590.997710434945, 35987.0, 37890.810545948196, 30180.54729179108, 32931.50602741009, 33312.50031249485, 33500.49749253812, 33558.328833423686, 24733.381665458506, 25227.0, 25276.49447011086, 25314.367140821625, 25495.36261593475], "value": 17325.70020021558, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.51600339541625, 369.5879094809288, 369.91122130688626, 378.16803033326653, 387.1753165756937, 15592.84407155928, 16225.83774162258, 16670.41653542128, 16691.248893799777, 16725.0, 15725.84274157258, 16156.0, 16437.67124657506, 16441.506754797345, 16503.09232992185, 4951.207806750929, 5208.244804503363, 5209.82778874754, 5210.921836172461, 5214.504622060898, 3664.5602527696715, 3846.8845934622004, 3862.8454861805494, 3866.2460820140086, 5068.949310506903, 3918.784466854322, 3935.134270460494, 3969.789030375047, 6109.389061093877, 6124.724387402578, 5846.1523079153285, 6093.512518998469, 6100.145979562887, 6100.938990610126, 6103.847403814896, 5272.683638981635, 5278.551323137538, 5285.0709491035495, 5286.762095705664, 5289.0, 19936.601267974704, 20383.49041273965, 20518.38444846657, 20535.691964620542, 20565.4858628534, 1903.0960293860444, 1954.2476146683487, 1959.7452331196996, 2133.541288622938, 2508.3854455658297, 12525.373731313397, 12673.176243544232, 12764.80852787209, 13084.607461776162, 13621.25083120428, 1684.941027064047, 1772.787265528132, 1795.2280519376664, 1850.5466160790559, 1853.3142737187327, 68251.65874170647, 68494.65752671254, 68559.31440685579, 68911.0, 70400.0, 9590.712278631652, 9849.113579777855, 9903.61349411083, 9941.900580994243, 10071.0, 13578.388972496261, 13610.63893610631, 13642.590722278348, 13680.042397032312, 13697.0, 6435.549511534241, 6511.511636627272, 6601.801945941629, 6623.602583844985, 6673.933260667428, 6110.083487476825, 6153.446189842935, 6185.876282474325, 6289.937100629027, 6303.905441418382, 4189.198644582859, 4244.745315281093, 4254.638355739735, 4282.250606143913, 4349.217140914602, 1785.1252886085724, 1800.189914538463, 1836.4674244469222, 1852.9166187521594, 1901.1349835824667, 383.059588709717, 692.8521583092473, 739.209046320432, 822.5311572403673, 824.3199360527589, 10019.549120289605, 10593.470326483644, 10637.62768303121, 10787.0, 11037.83443248352, 394.28240602104466, 395.6617092386026, 408.6179422240215, 412.42878613120445, 427.0540752233755, 5643.351014633287, 5715.914261286084, 5735.971320143372, 5746.712664366765, 5872.588918775645, 134095.0, 327160.0, 402914.0, 403316.0, 403928.0, 74418.25581744222, 74567.25432745712, 76518.61740691372, 77789.0, 79439.0, 411.2802595457949, 418.08022350828907, 420.2435615891444, 422.0545977011472, 422.4128461438603, 9692.563834627317, 9781.119699227103, 9900.158486528439, 9919.851202232117, 9956.402615843073, 32920.83539582287, 33716.0, 34465.48301775425, 35144.47283290701, 35653.28693426065, 47337.0, 47553.0, 50804.0, 51832.0, 52133.7393313031, 6923.134608173978, 6960.9303906962305, 6965.825854353681, 7023.543469674455, 7072.3634872861685, 10618.964793378467, 10869.456527173768, 10907.563697452331, 10972.506237219184, 11074.114070874472, 9183.357164998386, 9483.288753343664, 9491.85762213581, 9698.70903872885, 9787.314887957775, 9493.477858717837, 9526.809463810823, 9661.951690241503, 9711.708648740549, 9825.263105266991, 9584.520773961414, 9769.902300976899, 9895.158911492605, 9983.450910200008, 10280.569097602169, 7107.0, 7216.0, 7297.416206703345, 7370.0, 7551.244875512405, 8636.229572937658, 9280.443173409618, 9347.0, 9732.124108829956, 9755.268354873555], "value": 7330.055361461244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.8326459192601, 1349.2376807103985, 1415.7734762438013, 1587.8174009988854, 1654.9917250413753, 6765.221999470063, 7027.789166325006, 7102.715891364346, 7689.269519395655, 7689.500182488135, 7101.5739055656695, 7446.739364122257, 7448.329650331469, 7587.20334364892, 7589.696412143508, 2137.0, 2166.794154555315, 2169.1648715244587, 2174.7281589801273, 2175.8041776240134, 1823.0975667044831, 1898.8670793044491, 2025.8987050647481, 2110.873347599149, 2136.038782547852, 2105.515731381783, 2148.5380643161716, 2149.602323570137, 2150.7849215078522, 2153.3755210988875, 2083.7707852136327, 2096.968545471819, 2111.092230340953, 2111.2505060703384, 2113.9471513212293, 2050.2311633137574, 2058.9485262868398, 2066.6486697261503, 2067.576146889884, 2111.3349294972036, 7667.504836556874, 7728.072631284282, 7731.45879788415, 7739.380849532024, 7742.53544787309, 4355.5644435556505, 4455.398521199661, 4483.932741008887, 4509.977450112761, 4510.819567217307, 2798.5242508773354, 2868.4836729388703, 2888.0, 2931.589577459157, 2946.911592652224, 931.7065124485765, 933.5472295936465, 945.3429866242964, 956.067833861986, 975.2490582251697, 10328.741781455448, 10393.584256629725, 10397.84403233952, 10410.739731506697, 10420.270581059329, 3978.104926391539, 3983.661388781928, 4186.748795072244, 4201.873943781691, 4228.4080228768, 8130.308923741548, 8183.263506284344, 8203.015638123463, 8205.425620206648, 8211.137830527829, 4461.330800379904, 4465.776711164429, 4465.799039043251, 4467.061916997402, 4468.396766436555, 4009.67922566194, 4065.593440655911, 4138.8344466221015, 4144.44050053245, 4144.854930077433, 3112.4708799504137, 3159.842007899596, 3218.6781321868093, 3229.54786329914, 3243.918902027421, 907.609727817045, 923.930705197113, 938.8075444533854, 946.3895787217207, 948.6347756113946, 811.3955103447969, 819.8032472206628, 827.7640872351351, 828.225609055535, 848.9430658829673, 5115.5396014358885, 5149.124648809711, 5195.818146364859, 5207.765650545659, 5421.770463163338, 850.7362717557577, 870.1863757386864, 871.4161511786991, 871.877937088808, 877.8419884420865, 3441.7074548663145, 3534.929301414009, 3548.91127721809, 3559.359315323215, 3640.21735326906, 9034.45793252407, 9135.360524763335, 9285.0, 9295.907040929504, 9297.628094876129, 9239.538023098952, 9255.68607848038, 9259.814803703888, 9270.397424167542, 9273.953630231807, 6722.260551339349, 6958.443324534025, 7017.754378596826, 7063.223045464994, 7150.0, 5445.26488924006, 5491.258680078298, 5521.503064724034, 5736.139579063174, 5817.592768506164, 8513.276371508491, 8535.146485351415, 8571.485710857369, 8571.657133714582, 8577.656893724181, 8536.0, 8722.694705685271, 8769.91230087691, 8847.336449766422, 8925.955370223108, 6460.12788273577, 6626.105475760711, 6627.105340779126, 6631.801045968628, 6637.568558043712, 7245.166805817398, 7272.600006999666, 7274.818129546804, 7276.672549735169, 7279.1265048194555, 6292.3078461368295, 6570.901436478553, 6701.966490167518, 6752.122224110834, 6759.2564817869015, 6557.540972132096, 6652.634105124071, 6652.90020649681, 6675.132232809704, 6678.599284042973, 5857.414258574279, 5888.911666325094, 5916.763329466773, 5923.259592550931, 5974.1934838796205, 4511.819527218874, 4516.638668906546, 4597.448306203277, 4633.72197668141, 4725.1967165581245, 4608.930866037079, 4672.883177920579, 4675.298705194248, 4676.392069031141, 4687.695299805502], "value": 4009.26931021541, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.16582661541605, 290.45974487453344, 290.8240514488735, 298.418084734767, 301.36111443739276, 4770.403699537558, 4799.4480634727015, 4800.351952486413, 4804.5435683610085, 4814.759262036897, 4737.313089602006, 4738.739369334685, 4739.360186374847, 4741.810327586901, 4764.952350476494, 3504.6495350464943, 3632.400653892105, 3677.1542545214616, 3749.2501499700033, 3760.172761992357, 3767.6232376762377, 3767.773933563995, 3769.453429252757, 3770.9811450942707, 3773.584905660389, 3738.719596030295, 3741.3078580462566, 3742.719296052793, 3752.287065457568, 3753.831077601501, 3522.383582872987, 3611.693006094485, 3636.5999740028574, 3682.39240525313, 3751.6248375162404, 3305.685959833836, 3308.470644696861, 3312.9171770705684, 3317.618473875487, 3329.1344250495044, 4602.631789456836, 4610.585047345755, 4612.347899957538, 4625.213713668684, 4628.699134556243, 4117.938230926538, 4202.789860506993, 4250.723702959298, 4252.255855225323, 4254.234237837188, 4890.682105663121, 4923.350677523034, 4923.975380123113, 4925.187344088257, 4930.950690493085, 3596.352656521825, 3599.226166374242, 3600.963990360115, 3601.819909004539, 3608.657177568127, 5172.844814655567, 5179.006082658166, 5181.740912954375, 5192.766325515361, 5200.765965531522, 3374.2407958209697, 3573.8034408107283, 3578.731595130376, 3581.803000834927, 3592.9281414371567, 3619.6199399063244, 3620.5112309837837, 3621.6378362163573, 3625.093726568358, 3629.6733294003666, 4115.42384066225, 4120.795374474642, 4145.647619952338, 4147.191297696981, 4159.251334759772, 4733.9763301183275, 4960.404751429852, 4962.727050012212, 4979.676321039121, 4988.750562471934, 1201.2612243470203, 1224.577520755338, 1227.1900545640012, 1228.2507670321097, 1228.975420491585, 768.7271018788362, 793.0008189680929, 799.2087833045359, 803.4255507312183, 804.3565147881671, 4162.895927601834, 4241.618254357123, 4296.634786043159, 4404.977975110104, 4410.580994805488, 5140.151874940593, 5142.948570514247, 5148.124818780741, 5150.356205474316, 5157.690538567623, 4393.1872603568445, 4394.538573449806, 4396.450443694538, 4398.428204333416, 4406.1187762447, 2618.489394568079, 2693.8518381488816, 2720.2519307190287, 2721.319670082479, 2725.4737347085697, 4804.903901922012, 4810.879728006757, 4812.470628230892, 4815.3258543803895, 4826.565609095128, 5234.842954711365, 5249.060526105393, 5262.079136151158, 5266.709656134195, 5274.0, 4588.472325682523, 4830.8309209178215, 4860.878478038077, 4861.44093429246, 4872.293517439952, 5142.151544995034, 5151.716655583829, 5165.225216217597, 5175.81884634036, 5186.766595503136, 4869.732164730832, 5083.2883396323805, 5096.46487118862, 5097.133487307241, 5131.409887862944, 4835.927461088017, 4862.3922009748785, 4866.489018653132, 4867.80528778859, 4881.194602890483, 3594.5686517618055, 3611.602723700338, 3614.0, 3615.728820338538, 3616.855325786939, 5159.303494028258, 5163.68326076848, 5180.7409629519125, 5184.637075404837, 5194.584433245256, 4834.5890599299455, 4990.226514890198, 5007.5993920487, 5018.799248030038, 5026.170681837456, 5007.624428167829, 5008.6243531734535, 5015.598752099896, 5022.121128802518, 5032.169692000779, 4943.283223932582, 4957.975210123926, 4964.851054468371, 4972.627052971114, 4978.60171186297, 4796.448408433075, 4806.759662016815, 4926.827561035347, 5039.21892106724, 5058.027369325892, 4787.4494433140635, 4926.926096108489, 4929.97535012337, 4930.2604609307455, 4932.482089380707], "value": 3742.4096349256156, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.6751689121656, 639.0254861336458, 669.8492839111203, 707.1478867964104, 720.2941117704651, 12495.187812792163, 13315.80026299605, 13365.866341336583, 13372.465101395945, 13513.662158446044, 12954.0, 12985.870141298608, 12993.61019169424, 13003.414846331914, 13039.413226404811, 616.1681729664962, 636.3286732497213, 735.5182355557118, 743.650484272391, 761.7486229544265, 759.2028370211284, 759.5594555158023, 763.9236076392372, 764.4190415284396, 764.6291548598953, 805.118395357086, 806.2944923192207, 806.3065763443434, 807.1524898856178, 807.1968391450515, 638.7604648256927, 656.2617055812211, 659.0180630860032, 660.2934859700123, 802.0335495727634, 571.3572231239855, 588.5027152056548, 590.1442907783688, 590.799128296377, 591.7485068845723, 12704.364781760874, 12711.872881271254, 12725.490980360866, 12725.872741272655, 12741.745165096647, 11785.764284714343, 12327.876721232762, 12439.564615238423, 13171.275579843104, 13551.39018744159, 11877.406129693481, 11966.22219555726, 12054.638360849189, 12112.454939527743, 12446.377681115908, 4219.2827219372475, 4225.873223803291, 4228.851990180359, 4424.181526417623, 4445.288753799409, 64326.0, 65107.67446162786, 65363.63001605945, 66233.0, 66309.66845165743, 10207.489625518694, 10333.94833025845, 10400.0, 10419.94790026045, 10422.270441069053, 16804.327826886787, 17667.73498397525, 17812.020338881226, 18545.53636159107, 18620.813791861907, 6866.279040700754, 7105.396041336544, 7282.868366602412, 7356.96321518389, 7426.517276377018, 3620.7465477416854, 3734.3838266685693, 3744.382176940774, 3746.119661879456, 3811.3330167220624, 2878.3667593129476, 2980.940381192364, 2992.551117332374, 3030.772692048105, 3032.529957856536, 506.5365190850331, 515.317204703769, 521.723486552128, 530.9522143007148, 559.6250512156864, 558.9692566908777, 587.7208326045094, 595.961262517935, 603.4538742438101, 608.1880689279861, 7760.767176984699, 8047.356211503065, 8165.755027349189, 8465.867628977318, 8606.31149508038, 460.4267686729976, 475.7407213068886, 503.4638110412399, 580.2717589425245, 587.9029960056542, 3876.8449262029767, 3970.1265721541213, 4021.155557332993, 4173.791310434466, 4184.2468355695655, 93266.0, 98039.0, 101050.4947475258, 105705.47147264215, 106410.46794766131, 85571.89656374209, 87179.0, 89350.0, 90688.54655726811, 91394.54302728576, 76400.61799691078, 76421.23578764252, 77262.61368693232, 77622.0, 78466.6076669613, 7232.962155894642, 7504.399648028254, 7633.69465221385, 7634.961825190839, 7649.273319034683, 41702.0, 42747.5725242756, 43503.0, 43637.34543981779, 44497.55502445064, 59036.40963590309, 59480.702596488474, 65733.34266657272, 68599.31400686128, 68743.65628171827, 9915.553800079158, 10147.84778228342, 10349.068583827491, 10382.650255467042, 10431.321964072311, 11233.269837460539, 11490.77018459643, 11611.825822612836, 12320.199187052813, 12345.321007344683, 10406.687799366031, 10424.68725938223, 10704.464776760975, 11038.668839934493, 11521.654350369503, 10037.899621003697, 10228.744281393025, 10280.556013735482, 10680.946595266974, 10773.084287835622, 9922.206223502248, 10233.84649230277, 10272.435016074187, 10410.739731506774, 11375.374354410587, 8645.178708022728, 8747.125287471203, 8880.955595221982, 9057.275417966679, 9200.539973001189, 8704.651813927372, 9169.449833010041, 9250.907490925005, 9417.0, 9495.715128546155], "value": 6462.341728324114, "unit": "score"}], "name": "dromaeo_css", "value": 6203.878645599694, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 116.0, 113.0, 113.0, 115.0, 114.0, 115.0, 113.0, 112.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 122.0, 124.0, 159.0, 124.0, 126.0, 126.0, 123.0, 165.0, 123.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 169.0, 160.0, 163.0, 162.0, 162.0, 163.0, 162.0, 162.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 79.0, 110.0, 79.0, 78.0, 77.0, 80.0, 100.0, 77.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 113.0, 83.0, 84.0, 83.0, 115.0, 82.0, 83.0, 114.0], "value": 92.7, "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, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 149.0, 147.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 64.0, 64.0, 64.0, 65.0, 63.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 65.0, 66.0, 67.0, 65.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 92.0, 83.0, 92.0, 82.0, 85.0, 89.0, 82.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 135.0, 140.0, 133.0, 136.0, 133.0, 132.0, 172.0, 133.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 176.0, 175.0, 180.0, 181.0, 184.0, 177.0, 177.0, 176.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 70.0, 71.0, 70.0, 70.0, 71.0, 67.0, 68.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1549.8000000000002, "alertThreshold": 2.0}]} 15:36:53 INFO - Return code: 0 15:36:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:36:53 INFO - # TBPL SUCCESS # 15:36:53 INFO - Running post-action listener: _resource_record_post_action 15:36:53 INFO - [mozharness: 2016-09-27 22:36:53.704814Z] Finished run-tests step (success) 15:36:53 INFO - Running post-run listener: _resource_record_post_run 15:36:53 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 400920576; Read time: 0; Write time: 437356 15:36:53 INFO - TinderboxPrint: CPU usage
13.0% 15:36:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:36:53 INFO - TinderboxPrint: I/O write bytes / time
400,920,576 / 437,356 15:36:53 INFO - TinderboxPrint: CPU idle
8,350.3 (87.0%) 15:36:53 INFO - TinderboxPrint: CPU user
1,197.4 (12.5%) 15:36:53 INFO - TinderboxPrint: Swap in / out
0 / 0 15:36:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101163008; Read time: 0; Write time: 145816 15:36:53 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 289497088; Read time: 0; Write time: 290276 15:36:54 INFO - Running post-run listener: _upload_blobber_files 15:36:54 INFO - Blob upload gear active. 15:36:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:36:54 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 15:36:54 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'] 15:36:54 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 15:36:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:36:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:36:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:36:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:58 INFO - (blobuploader) - INFO - Done attempting. 15:36:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:36:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:36:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:59 INFO - (blobuploader) - INFO - Done attempting. 15:36:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:36:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:37:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:00 INFO - (blobuploader) - INFO - Done attempting. 15:37:00 INFO - (blobuploader) - INFO - Iteration through files over. 15:37:00 INFO - Return code: 0 15:37:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:37:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:37:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/16d8943f9eee9c85652b154c73b3eec41756e484cb3dbed543c86ba9789f489f7871e045594515373a20a7d4fb0aac78f67c0ce5d2ddb986fe45a8898b9a6f3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7aa44907847ce18dfa019aeb52590707bb78ff729514dc46b9a4df774043d884595a3d20a6f68c3bf8c8d2ca0d1ca9fc3857a061d3de235566d2f9dd8021eeb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a123214dd84d24e0316b0e28f65ccd01a6201605b60079ebaa13edfa7c2d9fc0fd6725b00e4b88743db49d15378e529d2b324a3fd924f482e950441715f36603"} 15:37:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:37:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:37:00 INFO - Contents: 15:37:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/16d8943f9eee9c85652b154c73b3eec41756e484cb3dbed543c86ba9789f489f7871e045594515373a20a7d4fb0aac78f67c0ce5d2ddb986fe45a8898b9a6f3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7aa44907847ce18dfa019aeb52590707bb78ff729514dc46b9a4df774043d884595a3d20a6f68c3bf8c8d2ca0d1ca9fc3857a061d3de235566d2f9dd8021eeb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a123214dd84d24e0316b0e28f65ccd01a6201605b60079ebaa13edfa7c2d9fc0fd6725b00e4b88743db49d15378e529d2b324a3fd924f482e950441715f36603"} 15:37:00 INFO - Running post-run listener: copy_logs_to_upload_dir 15:37:00 INFO - Copying logs to upload dir... 15:37:00 INFO - mkdir: /builds/slave/test/build/upload/logs 15:37:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.076099 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-27 15:36:59.292042) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 15:36:59.296115) ========= 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=fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179 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/16d8943f9eee9c85652b154c73b3eec41756e484cb3dbed543c86ba9789f489f7871e045594515373a20a7d4fb0aac78f67c0ce5d2ddb986fe45a8898b9a6f3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7aa44907847ce18dfa019aeb52590707bb78ff729514dc46b9a4df774043d884595a3d20a6f68c3bf8c8d2ca0d1ca9fc3857a061d3de235566d2f9dd8021eeb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a123214dd84d24e0316b0e28f65ccd01a6201605b60079ebaa13edfa7c2d9fc0fd6725b00e4b88743db49d15378e529d2b324a3fd924f482e950441715f36603"} build_url:https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://queue.taskcluster.net/v1/task/YZ060YXBS3yzK8eJk3-tvg/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/16d8943f9eee9c85652b154c73b3eec41756e484cb3dbed543c86ba9789f489f7871e045594515373a20a7d4fb0aac78f67c0ce5d2ddb986fe45a8898b9a6f3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7aa44907847ce18dfa019aeb52590707bb78ff729514dc46b9a4df774043d884595a3d20a6f68c3bf8c8d2ca0d1ca9fc3857a061d3de235566d2f9dd8021eeb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a123214dd84d24e0316b0e28f65ccd01a6201605b60079ebaa13edfa7c2d9fc0fd6725b00e4b88743db49d15378e529d2b324a3fd924f482e950441715f36603"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 15:36:59.325926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:36:59.326669) ========= 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=fa44defc139c4ba8574fe040000001db-1475014568.167273-850430179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:36:59.405728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 15:36:59.406082) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 15:36:59.406404) ========= ========= Total master_lag: 0.21 =========