builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1471879587.5 results: success (0) buildid: 20160822070534 builduid: 7c588736683844c48a840b9abe20a466 revision: a2deef3b5ce0bbddfc66d60c88ef7dab1bad9b4d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 08:26:27.504310) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 08:26:27.504783) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 08:26:27.505082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 08:26:27.520170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:26:27.520562) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 08:26:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-08-22 08:26:29 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091511 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:26:27.626465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:26:27.626947) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020722 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:26:27.677597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 08:26:27.678127) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a2deef3b5ce0bbddfc66d60c88ef7dab1bad9b4d --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 a2deef3b5ce0bbddfc66d60c88ef7dab1bad9b4d --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=516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 08:26:29,527 truncating revision to first 12 chars 2016-08-22 08:26:29,527 Setting DEBUG logging. 2016-08-22 08:26:29,527 attempt 1/10 2016-08-22 08:26:29,527 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a2deef3b5ce0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 08:26:30,316 unpacking tar archive at: autoland-a2deef3b5ce0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.088575 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 08:26:28.783040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 08:26:28.783375) ========= script_repo_revision: a2deef3b5ce0bbddfc66d60c88ef7dab1bad9b4d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 08:26:28.783771) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 08:26:28.784052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 08:26:28.793897) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-08-22 08:26:28.794308) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:26:30 INFO - MultiFileLogger online at 20160822 08:26:30 in /builds/slave/test 08:26:30 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 08:26:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:26:30 INFO - {'append_to_log': False, 08:26:30 INFO - 'base_work_dir': '/builds/slave/test', 08:26:30 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 08:26:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:26:30 INFO - 'branch': 'Autoland-Non-PGO', 08:26:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:26:30 INFO - 'config_files': ('talos/linux_config.py',), 08:26:30 INFO - 'default_actions': ('clobber', 08:26:30 INFO - 'read-buildbot-config', 08:26:30 INFO - 'download-and-extract', 08:26:30 INFO - 'populate-webroot', 08:26:30 INFO - 'create-virtualenv', 08:26:30 INFO - 'install', 08:26:30 INFO - 'run-tests'), 08:26:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:26:30 INFO - 'download_minidump_stackwalk': True, 08:26:30 INFO - 'download_symbols': 'ondemand', 08:26:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:26:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:26:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:26:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:26:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:26:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:26:30 INFO - 'installer_path': 'installer.exe', 08:26:30 INFO - 'log_level': 'info', 08:26:30 INFO - 'log_name': 'talos', 08:26:30 INFO - 'log_to_console': True, 08:26:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:26:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:26:30 INFO - 'opt_config_files': (), 08:26:30 INFO - 'pip_index': False, 08:26:30 INFO - 'sps_profile': False, 08:26:30 INFO - 'sps_profile_interval': 0, 08:26:30 INFO - 'suite': 'dromaeojs', 08:26:30 INFO - 'system_bits': '32', 08:26:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:26:30 INFO - 'title': 'talos-linux64-ix-061', 08:26:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:26:30 INFO - 'use_talos_json': True, 08:26:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:26:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:26:30 INFO - 'work_dir': 'build'} 08:26:30 INFO - [mozharness: 2016-08-22 15:26:30.736508Z] Running clobber step. 08:26:30 INFO - Running pre-action listener: _resource_record_pre_action 08:26:30 INFO - Running main action method: clobber 08:26:30 INFO - rmtree: /builds/slave/test/build 08:26:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:26:31 INFO - Running post-action listener: _resource_record_post_action 08:26:31 INFO - [mozharness: 2016-08-22 15:26:31.725314Z] Finished clobber step (success) 08:26:31 INFO - [mozharness: 2016-08-22 15:26:31.725414Z] Running read-buildbot-config step. 08:26:31 INFO - Running pre-action listener: _resource_record_pre_action 08:26:31 INFO - Running main action method: read_buildbot_config 08:26:31 INFO - Using buildbot properties: 08:26:31 INFO - { 08:26:31 INFO - "project": "", 08:26:31 INFO - "product": "firefox", 08:26:31 INFO - "script_repo_revision": "production", 08:26:31 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 08:26:31 INFO - "repository": "", 08:26:31 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 08:26:31 INFO - "buildid": "20160822070534", 08:26:31 INFO - "pgo_build": "False", 08:26:31 INFO - "basedir": "/builds/slave/test", 08:26:31 INFO - "buildnumber": 450, 08:26:31 INFO - "slavename": "talos-linux64-ix-061", 08:26:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:26:31 INFO - "platform": "ubuntu64_hw", 08:26:31 INFO - "scheduler": "tests-autoland-linux64-talos", 08:26:31 INFO - "branch": "autoland", 08:26:31 INFO - "repo_path": "integration/autoland", 08:26:31 INFO - "revision": "a2deef3b5ce0bbddfc66d60c88ef7dab1bad9b4d", 08:26:31 INFO - "stage_platform": "linux64", 08:26:31 INFO - "builduid": "7c588736683844c48a840b9abe20a466", 08:26:31 INFO - "slavebuilddir": "test" 08:26:31 INFO - } 08:26:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:26:31 INFO - Running post-action listener: _resource_record_post_action 08:26:31 INFO - [mozharness: 2016-08-22 15:26:31.727842Z] Finished read-buildbot-config step (success) 08:26:31 INFO - [mozharness: 2016-08-22 15:26:31.727931Z] Running download-and-extract step. 08:26:31 INFO - Running pre-action listener: _resource_record_pre_action 08:26:31 INFO - Running main action method: download_and_extract 08:26:31 INFO - mkdir: /builds/slave/test/build/tests 08:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:31 INFO - trying https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:26:31 INFO - Downloading https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:26:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:26:32 INFO - Downloaded 1361 bytes. 08:26:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:26:32 INFO - Using the following test package requirements: 08:26:32 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:26:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:26:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:26:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:32 INFO - u'jsshell-linux-x86_64.zip'], 08:26:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:26:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:26:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:26:32 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:26:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:26:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:26:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:32 INFO - trying https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:26:32 INFO - Downloading https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:26:33 INFO - Downloaded 20331071 bytes. 08:26:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:26:37 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:37 INFO - trying https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:26:37 INFO - Downloading https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:26:38 INFO - Downloaded 20331071 bytes. 08:26:38 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:26: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')]} 08:26:42 INFO - trying https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:26:42 INFO - Downloading https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:26:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:26:43 INFO - Downloaded 14413981 bytes. 08:26:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:26:44 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')]} 08:26:44 INFO - trying https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:26:44 INFO - Downloading https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:26:45 INFO - Downloaded 55761193 bytes. 08:26:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:26:45 INFO - mkdir: /builds/slave/test/properties 08:26:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:26:45 INFO - Writing to file /builds/slave/test/properties/build_url 08:26:45 INFO - Contents: 08:26:45 INFO - build_url:https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:26:45 INFO - Running post-action listener: _resource_record_post_action 08:26:45 INFO - Running post-action listener: set_extra_try_arguments 08:26:45 INFO - [mozharness: 2016-08-22 15:26:45.784176Z] Finished download-and-extract step (success) 08:26:45 INFO - [mozharness: 2016-08-22 15:26:45.784472Z] Running populate-webroot step. 08:26:45 INFO - Running pre-action listener: _resource_record_pre_action 08:26:45 INFO - Running main action method: populate_webroot 08:26:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:26:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:26:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:26:45 INFO - '--tppagecycles', 08:26:45 INFO - '7'], 08:26:45 INFO - 'tests': ['tsvgm']}}, 08:26:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:26:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:26:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:26:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:26:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:26:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:26:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:45 INFO - 'talos_options': ['--disable-e10s'], 08:26:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:45 INFO - 'talos_options': ['--disable-e10s'], 08:26:45 INFO - 'tests': ['damp', 'tps']}, 08:26:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:45 INFO - 'tests': ['damp', 'tps']}, 08:26:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:26:45 INFO - 'tests': ['dromaeo_dom']}, 08:26:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:26:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:26:45 INFO - 'tests': ['basic_compositor_video']}, 08:26:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:26:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:26:45 INFO - 'tests': ['a11yr', 08:26:45 INFO - 'ts_paint', 08:26:45 INFO - 'tpaint', 08:26:45 INFO - 'sessionrestore', 08:26:45 INFO - 'sessionrestore_no_auto_restore', 08:26:45 INFO - 'tabpaint']}, 08:26:45 INFO - 'other-e10s': {'tests': ['a11yr', 08:26:45 INFO - 'ts_paint', 08:26:45 INFO - 'tpaint', 08:26:45 INFO - 'sessionrestore', 08:26:45 INFO - 'sessionrestore_no_auto_restore', 08:26:45 INFO - 'tabpaint']}, 08:26:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:26:45 INFO - 'ts_paint', 08:26:45 INFO - 'tpaint', 08:26:45 INFO - 'sessionrestore', 08:26:45 INFO - 'sessionrestore_no_auto_restore', 08:26:45 INFO - 'tabpaint']}, 08:26:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:26:45 INFO - 'ts_paint', 08:26:45 INFO - 'tpaint', 08:26:45 INFO - 'sessionrestore', 08:26:45 INFO - 'sessionrestore_no_auto_restore', 08:26:45 INFO - 'tabpaint']}, 08:26:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:26:45 INFO - 'tests': ['a11yr', 08:26:45 INFO - 'ts_paint', 08:26:45 INFO - 'tpaint', 08:26:45 INFO - 'sessionrestore', 08:26:45 INFO - 'sessionrestore_no_auto_restore', 08:26:45 INFO - 'tabpaint']}, 08:26:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:26:45 INFO - 'tests': ['a11yr', 08:26:45 INFO - 'ts_paint', 08:26:45 INFO - 'tpaint', 08:26:45 INFO - 'sessionrestore', 08:26:45 INFO - 'sessionrestore_no_auto_restore', 08:26:45 INFO - 'tabpaint']}, 08:26:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:26:45 INFO - 'tests': ['tsvgx', 08:26:45 INFO - 'tsvgr_opacity', 08:26:45 INFO - 'tart', 08:26:45 INFO - 'tscrollx', 08:26:45 INFO - 'cart']}, 08:26:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:26:45 INFO - 'tsvgr_opacity', 08:26:45 INFO - 'tart', 08:26:45 INFO - 'tscrollx', 08:26:45 INFO - 'cart']}, 08:26:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:45 INFO - 'talos_options': ['--disable-e10s'], 08:26:45 INFO - 'tests': ['tp5o']}, 08:26:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:45 INFO - 'tests': ['tp5o']}, 08:26:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:45 INFO - 'talos_options': ['--disable-e10s', 08:26:45 INFO - '--xperf_path', 08:26:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:45 INFO - 'tests': ['tp5n']}, 08:26:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:45 INFO - 'talos_options': ['--xperf_path', 08:26:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:45 INFO - 'tests': ['tp5n']}}, 08:26:45 INFO - 'talos.zip': {'path': '', 08:26:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:26:45 INFO - Running post-action listener: _resource_record_post_action 08:26:45 INFO - [mozharness: 2016-08-22 15:26:45.805764Z] Finished populate-webroot step (success) 08:26:45 INFO - [mozharness: 2016-08-22 15:26:45.805859Z] Running create-virtualenv step. 08:26:45 INFO - Running pre-action listener: _resource_record_pre_action 08:26:45 INFO - Running main action method: create_virtualenv 08:26:45 INFO - Creating virtualenv /builds/slave/test/build/venv 08:26:45 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 08:26:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:26:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:26:45 INFO - Using real prefix '/usr' 08:26:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:26:46 INFO - Installing distribute.............................................................................................................................................................................................done. 08:26:48 INFO - Installing pip.................done. 08:26:48 INFO - Return code: 0 08:26:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:26:48 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')]} 08:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:48 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')]} 08:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:48 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 0x7fee6ccf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d88230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d859b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d85e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', '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 08:26:48 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 08:26:48 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 08:26:48 INFO - Using env: {'DISPLAY': ':0', 08:26:48 INFO - 'HOME': '/home/cltbld', 08:26:48 INFO - 'LANG': 'en_US.UTF-8', 08:26:48 INFO - 'LANGUAGE': 'en_US:en', 08:26:48 INFO - 'LOGNAME': 'cltbld', 08:26:48 INFO - 'MAIL': '/var/mail/cltbld', 08:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:48 INFO - 'MOZ_NO_REMOTE': '1', 08:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:48 INFO - 'NO_EM_RESTART': '1', 08:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:48 INFO - 'PWD': '/builds/slave/test', 08:26:48 INFO - 'SHELL': '/bin/bash', 08:26:48 INFO - 'SHLVL': '1', 08:26:48 INFO - 'TERM': 'linux', 08:26:48 INFO - 'TMOUT': '86400', 08:26:48 INFO - 'USER': 'cltbld', 08:26:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', 08:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:48 INFO - '_': '/tools/buildbot/bin/python'} 08:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:48 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 08:26:48 INFO - Cleaning up... 08:26:48 INFO - Return code: 0 08:26:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:26:48 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')]} 08:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:48 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')]} 08:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:48 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 0x7fee6ccf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d88230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d859b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d85e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', '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 08:26:48 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 08:26:48 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 08:26:48 INFO - Using env: {'DISPLAY': ':0', 08:26:48 INFO - 'HOME': '/home/cltbld', 08:26:48 INFO - 'LANG': 'en_US.UTF-8', 08:26:48 INFO - 'LANGUAGE': 'en_US:en', 08:26:48 INFO - 'LOGNAME': 'cltbld', 08:26:48 INFO - 'MAIL': '/var/mail/cltbld', 08:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:48 INFO - 'MOZ_NO_REMOTE': '1', 08:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:48 INFO - 'NO_EM_RESTART': '1', 08:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:48 INFO - 'PWD': '/builds/slave/test', 08:26:48 INFO - 'SHELL': '/bin/bash', 08:26:48 INFO - 'SHLVL': '1', 08:26:48 INFO - 'TERM': 'linux', 08:26:48 INFO - 'TMOUT': '86400', 08:26:48 INFO - 'USER': 'cltbld', 08:26:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', 08:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:48 INFO - '_': '/tools/buildbot/bin/python'} 08:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:48 INFO - Downloading/unpacking psutil>=3.1.1 08:26:48 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 08:26:48 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 08:26:48 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 08:26:48 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 08:26:48 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 08:26:48 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 08:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:26:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:50 INFO - Installing collected packages: psutil 08:26:50 INFO - Running setup.py install for psutil 08:26:50 INFO - building 'psutil._psutil_linux' extension 08:26:50 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 08:26:51 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 08:26:51 INFO - building 'psutil._psutil_posix' extension 08:26:51 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 08:26:51 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 08:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:51 INFO - Successfully installed psutil 08:26:51 INFO - Cleaning up... 08:26:51 INFO - Return code: 0 08:26:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee6ccf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d88230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d859b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d85e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', '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 08:26:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:26:51 INFO - Using env: {'DISPLAY': ':0', 08:26:51 INFO - 'HOME': '/home/cltbld', 08:26:51 INFO - 'LANG': 'en_US.UTF-8', 08:26:51 INFO - 'LANGUAGE': 'en_US:en', 08:26:51 INFO - 'LOGNAME': 'cltbld', 08:26:51 INFO - 'MAIL': '/var/mail/cltbld', 08:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:51 INFO - 'MOZ_NO_REMOTE': '1', 08:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:51 INFO - 'NO_EM_RESTART': '1', 08:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:51 INFO - 'PWD': '/builds/slave/test', 08:26:51 INFO - 'SHELL': '/bin/bash', 08:26:51 INFO - 'SHLVL': '1', 08:26:51 INFO - 'TERM': 'linux', 08:26:51 INFO - 'TMOUT': '86400', 08:26:51 INFO - 'USER': 'cltbld', 08:26:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', 08:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:51 INFO - '_': '/tools/buildbot/bin/python'} 08:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:26:51 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 08:26:51 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 08:26:51 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 08:26:51 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 08:26:51 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 08:26:51 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 08:26:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:26:53 INFO - Installing collected packages: mozsystemmonitor 08:26:53 INFO - Running setup.py install for mozsystemmonitor 08:26:53 INFO - Successfully installed mozsystemmonitor 08:26:53 INFO - Cleaning up... 08:26:53 INFO - Return code: 0 08:26:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:26:53 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')]} 08:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:53 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')]} 08:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:53 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 0x7fee6ccf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d88230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d859b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d85e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', '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 08:26:53 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 08:26:53 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 08:26:53 INFO - Using env: {'DISPLAY': ':0', 08:26:53 INFO - 'HOME': '/home/cltbld', 08:26:53 INFO - 'LANG': 'en_US.UTF-8', 08:26:53 INFO - 'LANGUAGE': 'en_US:en', 08:26:53 INFO - 'LOGNAME': 'cltbld', 08:26:53 INFO - 'MAIL': '/var/mail/cltbld', 08:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:53 INFO - 'MOZ_NO_REMOTE': '1', 08:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:53 INFO - 'NO_EM_RESTART': '1', 08:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:53 INFO - 'PWD': '/builds/slave/test', 08:26:53 INFO - 'SHELL': '/bin/bash', 08:26:53 INFO - 'SHLVL': '1', 08:26:53 INFO - 'TERM': 'linux', 08:26:53 INFO - 'TMOUT': '86400', 08:26:53 INFO - 'USER': 'cltbld', 08:26:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', 08:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:53 INFO - '_': '/tools/buildbot/bin/python'} 08:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:53 INFO - Downloading/unpacking jsonschema==2.5.1 08:26:53 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 08:26:53 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 08:26:53 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 08:26:53 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 08:26:53 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 08:26:53 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 08:26:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:26:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:55 INFO - Downloading functools32-3.2.3-2.tar.gz 08:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:26:55 INFO - warning: no files found matching '*.txt' 08:26:55 INFO - no previously-included directories found matching 'build' 08:26:55 INFO - no previously-included directories found matching 'dist' 08:26:55 INFO - no previously-included directories found matching '.git*' 08:26:55 INFO - Installing collected packages: jsonschema, functools32 08:26:56 INFO - Running setup.py install for functools32 08:26:56 INFO - warning: no files found matching '*.txt' 08:26:56 INFO - no previously-included directories found matching 'build' 08:26:56 INFO - no previously-included directories found matching 'dist' 08:26:56 INFO - no previously-included directories found matching '.git*' 08:26:56 INFO - Successfully installed jsonschema functools32 08:26:56 INFO - Cleaning up... 08:26:56 INFO - Return code: 0 08:26:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:56 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 0x7fee6ccf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d88230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d859b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d85e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', '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 08:26:56 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 08:26:56 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 08:26:56 INFO - Using env: {'DISPLAY': ':0', 08:26:56 INFO - 'HOME': '/home/cltbld', 08:26:56 INFO - 'LANG': 'en_US.UTF-8', 08:26:56 INFO - 'LANGUAGE': 'en_US:en', 08:26:56 INFO - 'LOGNAME': 'cltbld', 08:26:56 INFO - 'MAIL': '/var/mail/cltbld', 08:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:56 INFO - 'MOZ_NO_REMOTE': '1', 08:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:56 INFO - 'NO_EM_RESTART': '1', 08:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:56 INFO - 'PWD': '/builds/slave/test', 08:26:56 INFO - 'SHELL': '/bin/bash', 08:26:56 INFO - 'SHLVL': '1', 08:26:56 INFO - 'TERM': 'linux', 08:26:56 INFO - 'TMOUT': '86400', 08:26:56 INFO - 'USER': 'cltbld', 08:26:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', 08:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:56 INFO - '_': '/tools/buildbot/bin/python'} 08:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:26:56 INFO - Cleaning up... 08:26:56 INFO - Return code: 0 08:26:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:56 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 0x7fee6ccf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d88230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d859b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d85e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', '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 08:26:56 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 08:26:56 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 08:26:56 INFO - Using env: {'DISPLAY': ':0', 08:26:56 INFO - 'HOME': '/home/cltbld', 08:26:56 INFO - 'LANG': 'en_US.UTF-8', 08:26:56 INFO - 'LANGUAGE': 'en_US:en', 08:26:56 INFO - 'LOGNAME': 'cltbld', 08:26:56 INFO - 'MAIL': '/var/mail/cltbld', 08:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:56 INFO - 'MOZ_NO_REMOTE': '1', 08:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:56 INFO - 'NO_EM_RESTART': '1', 08:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:56 INFO - 'PWD': '/builds/slave/test', 08:26:56 INFO - 'SHELL': '/bin/bash', 08:26:56 INFO - 'SHLVL': '1', 08:26:56 INFO - 'TERM': 'linux', 08:26:56 INFO - 'TMOUT': '86400', 08:26:56 INFO - 'USER': 'cltbld', 08:26:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', 08:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:56 INFO - '_': '/tools/buildbot/bin/python'} 08:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:56 INFO - Downloading/unpacking blobuploader==1.2.4 08:26:56 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 08:26:56 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 08:26:56 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 08:26:56 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 08:26:56 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 08:26:56 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 08:26:58 INFO - Downloading blobuploader-1.2.4.tar.gz 08:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:26:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:26:58 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 08:26:58 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 08:26:58 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 08:26:58 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 08:26:58 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 08:26:58 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 08:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:26:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:26:58 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 08:26:58 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 08:26:58 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 08:26:58 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 08:26:58 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 08:26:58 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 08:26:59 INFO - Downloading docopt-0.6.1.tar.gz 08:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:26:59 INFO - Installing collected packages: blobuploader, requests, docopt 08:26:59 INFO - Running setup.py install for blobuploader 08:26:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:26:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:26:59 INFO - Running setup.py install for requests 08:26:59 INFO - Running setup.py install for docopt 08:26:59 INFO - Successfully installed blobuploader requests docopt 08:26:59 INFO - Cleaning up... 08:26:59 INFO - Return code: 0 08:26:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:59 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 0x7fee6ccf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d88230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d859b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d85e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', '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 08:26:59 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 08:26:59 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 08:26:59 INFO - Using env: {'DISPLAY': ':0', 08:26:59 INFO - 'HOME': '/home/cltbld', 08:26:59 INFO - 'LANG': 'en_US.UTF-8', 08:26:59 INFO - 'LANGUAGE': 'en_US:en', 08:26:59 INFO - 'LOGNAME': 'cltbld', 08:26:59 INFO - 'MAIL': '/var/mail/cltbld', 08:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:59 INFO - 'MOZ_NO_REMOTE': '1', 08:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:59 INFO - 'NO_EM_RESTART': '1', 08:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:59 INFO - 'PWD': '/builds/slave/test', 08:26:59 INFO - 'SHELL': '/bin/bash', 08:26:59 INFO - 'SHLVL': '1', 08:26:59 INFO - 'TERM': 'linux', 08:26:59 INFO - 'TMOUT': '86400', 08:26:59 INFO - 'USER': 'cltbld', 08:26:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', 08:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:59 INFO - '_': '/tools/buildbot/bin/python'} 08:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:27:00 INFO - Running setup.py (path:/tmp/pip-y5YGQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:27:00 INFO - Running setup.py (path:/tmp/pip-8QIAL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:27:00 INFO - Running setup.py (path:/tmp/pip-yVQ6EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:27:00 INFO - Running setup.py (path:/tmp/pip-wYpgme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:27:00 INFO - Running setup.py (path:/tmp/pip-LLOIvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:27:00 INFO - Running setup.py (path:/tmp/pip-FvOoiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:27:00 INFO - Running setup.py (path:/tmp/pip-wMQ047-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:27:00 INFO - Running setup.py (path:/tmp/pip-NvAoGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:27:00 INFO - Running setup.py (path:/tmp/pip-H2v0e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:27:00 INFO - Running setup.py (path:/tmp/pip-t7SfRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:27:00 INFO - Running setup.py (path:/tmp/pip-ztUxrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:27:00 INFO - Running setup.py (path:/tmp/pip-3ljbKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:27:00 INFO - Running setup.py (path:/tmp/pip-eAB2b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:27:01 INFO - Running setup.py (path:/tmp/pip-1JMx_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:01 INFO - Running setup.py (path:/tmp/pip-XMsRE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:27:01 INFO - Running setup.py (path:/tmp/pip-0hyKho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:27:01 INFO - Running setup.py (path:/tmp/pip-pcOsP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:27:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:27:01 INFO - Running setup.py install for manifestparser 08:27:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:27:01 INFO - Running setup.py install for mozcrash 08:27:01 INFO - Running setup.py install for mozdebug 08:27:01 INFO - Running setup.py install for mozdevice 08:27:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:27:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:27:01 INFO - Running setup.py install for mozfile 08:27:01 INFO - Running setup.py install for mozhttpd 08:27:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:27:01 INFO - Running setup.py install for mozinfo 08:27:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:27:02 INFO - Running setup.py install for mozInstall 08:27:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:27:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:27:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:27:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:27:02 INFO - Running setup.py install for mozleak 08:27:02 INFO - Running setup.py install for mozlog 08:27:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:27:02 INFO - Running setup.py install for moznetwork 08:27:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:27:02 INFO - Running setup.py install for mozprocess 08:27:02 INFO - Running setup.py install for mozprofile 08:27:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:27:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:27:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:27:02 INFO - Running setup.py install for mozrunner 08:27:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:27:02 INFO - Running setup.py install for mozscreenshot 08:27:02 INFO - Running setup.py install for moztest 08:27:02 INFO - Running setup.py install for mozversion 08:27:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:27:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:27:03 INFO - Cleaning up... 08:27:03 INFO - Return code: 0 08:27:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:03 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 0x7fee6ccf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d88230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d859b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d85e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', '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 08:27:03 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 08:27:03 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 08:27:03 INFO - Using env: {'DISPLAY': ':0', 08:27:03 INFO - 'HOME': '/home/cltbld', 08:27:03 INFO - 'LANG': 'en_US.UTF-8', 08:27:03 INFO - 'LANGUAGE': 'en_US:en', 08:27:03 INFO - 'LOGNAME': 'cltbld', 08:27:03 INFO - 'MAIL': '/var/mail/cltbld', 08:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:03 INFO - 'MOZ_NO_REMOTE': '1', 08:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:03 INFO - 'NO_EM_RESTART': '1', 08:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:03 INFO - 'PWD': '/builds/slave/test', 08:27:03 INFO - 'SHELL': '/bin/bash', 08:27:03 INFO - 'SHLVL': '1', 08:27:03 INFO - 'TERM': 'linux', 08:27:03 INFO - 'TMOUT': '86400', 08:27:03 INFO - 'USER': 'cltbld', 08:27:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', 08:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:03 INFO - '_': '/tools/buildbot/bin/python'} 08:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:27:03 INFO - Running setup.py (path:/tmp/pip-XMn9yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:27:03 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)) 08:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:27:03 INFO - Running setup.py (path:/tmp/pip-wvd_DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:27:03 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)) 08:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:27:03 INFO - Running setup.py (path:/tmp/pip-INGFai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:27:03 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)) 08:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:27:03 INFO - Running setup.py (path:/tmp/pip-GxiNR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:27:03 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)) 08:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:27:03 INFO - Running setup.py (path:/tmp/pip-8EYNSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:27:03 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)) 08:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:27:03 INFO - Running setup.py (path:/tmp/pip-As7HD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:27:03 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)) 08:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:27:03 INFO - Running setup.py (path:/tmp/pip-5usVV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:27:03 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)) 08:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:27:03 INFO - Running setup.py (path:/tmp/pip-wA664H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:27:03 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)) 08:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:27:03 INFO - Running setup.py (path:/tmp/pip-QAakP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:27:03 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)) 08:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:27:04 INFO - Running setup.py (path:/tmp/pip-XgJ5Pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:27:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:27:04 INFO - Running setup.py (path:/tmp/pip-8v2M7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:27:04 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)) 08:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:27:04 INFO - Running setup.py (path:/tmp/pip-XoqpfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:27:04 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)) 08:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:27:04 INFO - Running setup.py (path:/tmp/pip-jIs6w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:27:04 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)) 08:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:27:04 INFO - Running setup.py (path:/tmp/pip-MsftDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:27:04 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)) 08:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:04 INFO - Running setup.py (path:/tmp/pip-OJIkbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:04 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)) 08:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:27:04 INFO - Running setup.py (path:/tmp/pip-ejQS2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:27:04 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)) 08:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:27:04 INFO - Running setup.py (path:/tmp/pip-n_urDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:27:04 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)) 08:27:04 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)) 08:27:04 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)) 08:27:04 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)) 08:27:04 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)) 08:27:04 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)) 08:27:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:06 INFO - Downloading blessings-1.6.tar.gz 08:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:27:06 INFO - Installing collected packages: blessings 08:27:06 INFO - Running setup.py install for blessings 08:27:06 INFO - Successfully installed blessings 08:27:06 INFO - Cleaning up... 08:27:06 INFO - Return code: 0 08:27:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:27:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:07 INFO - Reading from file tmpfile_stdout 08:27:07 INFO - Current package versions: 08:27:07 INFO - argparse == 1.2.1 08:27:07 INFO - blessings == 1.6 08:27:07 INFO - blobuploader == 1.2.4 08:27:07 INFO - docopt == 0.6.1 08:27:07 INFO - functools32 == 3.2.3-2 08:27:07 INFO - jsonschema == 2.5.1 08:27:07 INFO - manifestparser == 1.1 08:27:07 INFO - mozInstall == 1.12 08:27:07 INFO - mozcrash == 0.17 08:27:07 INFO - mozdebug == 0.1 08:27:07 INFO - mozdevice == 0.48 08:27:07 INFO - mozfile == 1.2 08:27:07 INFO - mozhttpd == 0.7 08:27:07 INFO - mozinfo == 0.9 08:27:07 INFO - mozleak == 0.1 08:27:07 INFO - mozlog == 3.3 08:27:07 INFO - moznetwork == 0.27 08:27:07 INFO - mozprocess == 0.23 08:27:07 INFO - mozprofile == 0.28 08:27:07 INFO - mozrunner == 6.12 08:27:07 INFO - mozscreenshot == 0.1 08:27:07 INFO - mozsystemmonitor == 0.3 08:27:07 INFO - moztest == 0.7 08:27:07 INFO - mozversion == 1.4 08:27:07 INFO - psutil == 3.1.1 08:27:07 INFO - requests == 1.2.3 08:27:07 INFO - wsgiref == 0.1.2 08:27:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:07 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 0x7fee6ccf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d88230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d859b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d85e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', '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 08:27:07 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 08:27:07 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 08:27:07 INFO - Using env: {'DISPLAY': ':0', 08:27:07 INFO - 'HOME': '/home/cltbld', 08:27:07 INFO - 'LANG': 'en_US.UTF-8', 08:27:07 INFO - 'LANGUAGE': 'en_US:en', 08:27:07 INFO - 'LOGNAME': 'cltbld', 08:27:07 INFO - 'MAIL': '/var/mail/cltbld', 08:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:07 INFO - 'MOZ_NO_REMOTE': '1', 08:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:07 INFO - 'NO_EM_RESTART': '1', 08:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:07 INFO - 'PWD': '/builds/slave/test', 08:27:07 INFO - 'SHELL': '/bin/bash', 08:27:07 INFO - 'SHLVL': '1', 08:27:07 INFO - 'TERM': 'linux', 08:27:07 INFO - 'TMOUT': '86400', 08:27:07 INFO - 'USER': 'cltbld', 08:27:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', 08:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:07 INFO - '_': '/tools/buildbot/bin/python'} 08:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:07 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)) 08:27:07 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)) 08:27:07 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)) 08:27:07 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)) 08:27:07 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)) 08:27:07 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)) 08:27:07 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)) 08:27:07 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)) 08:27:07 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)) 08:27:07 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)) 08:27:07 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)) 08:27:07 INFO - Cleaning up... 08:27:07 INFO - Return code: 0 08:27:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:07 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 0x7fee6ccf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d88230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d859b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d85e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', '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 08:27:07 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 08:27:07 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 08:27:07 INFO - Using env: {'DISPLAY': ':0', 08:27:07 INFO - 'HOME': '/home/cltbld', 08:27:07 INFO - 'LANG': 'en_US.UTF-8', 08:27:07 INFO - 'LANGUAGE': 'en_US:en', 08:27:07 INFO - 'LOGNAME': 'cltbld', 08:27:07 INFO - 'MAIL': '/var/mail/cltbld', 08:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:07 INFO - 'MOZ_NO_REMOTE': '1', 08:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:07 INFO - 'NO_EM_RESTART': '1', 08:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:07 INFO - 'PWD': '/builds/slave/test', 08:27:07 INFO - 'SHELL': '/bin/bash', 08:27:07 INFO - 'SHLVL': '1', 08:27:07 INFO - 'TERM': 'linux', 08:27:07 INFO - 'TMOUT': '86400', 08:27:07 INFO - 'USER': 'cltbld', 08:27:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', 08:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:07 INFO - '_': '/tools/buildbot/bin/python'} 08:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:27:07 INFO - Cleaning up... 08:27:07 INFO - Return code: 0 08:27:07 INFO - Running post-action listener: _resource_record_post_action 08:27:07 INFO - Running post-action listener: _start_resource_monitoring 08:27:07 INFO - Starting resource monitoring. 08:27:07 INFO - [mozharness: 2016-08-22 15:27:07.494775Z] Finished create-virtualenv step (success) 08:27:07 INFO - [mozharness: 2016-08-22 15:27:07.495287Z] Running install step. 08:27:07 INFO - Running pre-action listener: _resource_record_pre_action 08:27:07 INFO - Running main action method: install 08:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:07 INFO - Reading from file tmpfile_stdout 08:27:07 INFO - Detecting whether we're running mozinstall >=1.0... 08:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:27:07 INFO - Reading from file tmpfile_stdout 08:27:07 INFO - Output received: 08:27:07 INFO - Usage: mozinstall [options] installer 08:27:07 INFO - Options: 08:27:07 INFO - -h, --help show this help message and exit 08:27:07 INFO - -d DEST, --destination=DEST 08:27:07 INFO - Directory to install application into. [default: 08:27:07 INFO - "/builds/slave/test"] 08:27:07 INFO - --app=APP Application being installed. [default: firefox] 08:27:07 INFO - mkdir: /builds/slave/test/build/application 08:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:27:24 INFO - Reading from file tmpfile_stdout 08:27:24 INFO - Output received: 08:27:24 INFO - /builds/slave/test/build/application/firefox/firefox 08:27:24 INFO - Running post-action listener: _resource_record_post_action 08:27:24 INFO - [mozharness: 2016-08-22 15:27:24.550941Z] Finished install step (success) 08:27:24 INFO - [mozharness: 2016-08-22 15:27:24.551186Z] Running run-tests step. 08:27:24 INFO - Running pre-action listener: _resource_record_pre_action 08:27:24 INFO - Running main action method: run_tests 08:27:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:27:24 INFO - Python 2.7.3 08:27:24 INFO - Return code: 0 08:27:24 INFO - grabbing minidump binary from tooltool 08:27:24 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')]} 08:27:24 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 0x1d82090>, '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 0x1d859b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d85e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:27:24 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 08:27:24 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 08:27:24 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 08:27:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:27:24 INFO - Return code: 0 08:27:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:27:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:27:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:27:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:27:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:27:24 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/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 08:27:24 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/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 08:27:24 INFO - Using env: {'DISPLAY': ':0', 08:27:24 INFO - 'HOME': '/home/cltbld', 08:27:24 INFO - 'LANG': 'en_US.UTF-8', 08:27:24 INFO - 'LANGUAGE': 'en_US:en', 08:27:24 INFO - 'LOGNAME': 'cltbld', 08:27:24 INFO - 'MAIL': '/var/mail/cltbld', 08:27:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:27:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:24 INFO - 'MOZ_NO_REMOTE': '1', 08:27:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:24 INFO - 'NO_EM_RESTART': '1', 08:27:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:24 INFO - 'PWD': '/builds/slave/test', 08:27:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:27:24 INFO - 'SHELL': '/bin/bash', 08:27:24 INFO - 'SHLVL': '1', 08:27:24 INFO - 'TERM': 'linux', 08:27:24 INFO - 'TMOUT': '86400', 08:27:24 INFO - 'USER': 'cltbld', 08:27:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704', 08:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:24 INFO - '_': '/tools/buildbot/bin/python'} 08:27:24 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/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 08:27:24 INFO - mozversion application_buildid: 20160822070534 08:27:24 INFO - mozversion application_changeset: a2deef3b5ce0bbddfc66d60c88ef7dab1bad9b4d 08:27:24 INFO - mozversion application_display_name: Nightly 08:27:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:27:24 INFO - mozversion application_name: Firefox 08:27:24 INFO - mozversion application_remotingname: firefox 08:27:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:27:24 INFO - mozversion application_vendor: Mozilla 08:27:24 INFO - mozversion application_version: 51.0a1 08:27:24 INFO - mozversion platform_buildid: 20160822070534 08:27:24 INFO - mozversion platform_changeset: a2deef3b5ce0bbddfc66d60c88ef7dab1bad9b4d 08:27:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:27:24 INFO - mozversion platform_version: 51.0a1 08:27:24 INFO - using testdate: 1471879644 08:27:24 INFO - actual date: 1471879644 08:27:24 INFO - starting webserver on 'localhost:41318' 08:27:24 INFO - SUITE-START | Running 2 tests 08:27:24 INFO - TEST-START | dromaeo_css 08:27:24 INFO - operating with platform_type : linux_ 08:27:24 INFO - Initialising browser for dromaeo_css test... 08:27:24 INFO - TEST-INFO | started process 27724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp91elq9/profile http://localhost:41318/getInfo.html) 08:27:29 INFO - PROCESS | 27724 | __metrics Screen width/height:1600/1200 08:27:29 INFO - PROCESS | 27724 | colorDepth:24 08:27:29 INFO - PROCESS | 27724 | Browser inner width/height: 1024/697 08:27:29 INFO - PROCESS | 27724 | __metrics 08:27:30 INFO - PROCESS | 27724 | 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" 08:27:30 INFO - PROCESS | 27724 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:27:30 INFO - PROCESS | 27724 | console.error: PushService: 08:27:30 INFO - PROCESS | 27724 | stateChangeProcessEnqueue: Error transitioning state 08:27:30 INFO - PROCESS | 27724 | UnknownError 08:27:31 INFO - TEST-INFO | 27724: exit 0 08:27:31 INFO - Browser initialized. 08:27:31 INFO - Running cycle 1/1 for dromaeo_css test... 08:27:31 INFO - TEST-INFO | started process 27803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp91elq9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:43 INFO - PROCESS | 27803 | RSS: Main: 177729536 08:27:43 INFO - PROCESS | 27803 | 08:28:34 INFO - PROCESS | 27803 | 1471879714697 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] 08:30:47 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:41318/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41318/tests/dromaeo/cssquery-ext.html) 08:30:48 INFO - PROCESS | 27803 | RSS: Main: 270204928 08:30:48 INFO - PROCESS | 27803 | 08:33:51 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:41318/tests/dromaeo/cssquery-ext.html (next: http://localhost:41318/tests/dromaeo/cssquery-jquery.html) 08:33:52 INFO - PROCESS | 27803 | RSS: Main: 274386944 08:33:52 INFO - PROCESS | 27803 | 08:36:54 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:41318/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41318/tests/dromaeo/cssquery-mootools.html) 08:36:55 INFO - PROCESS | 27803 | RSS: Main: 249335808 08:36:55 INFO - PROCESS | 27803 | 08:39:57 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:41318/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41318/tests/dromaeo/cssquery-prototype.html) 08:39:58 INFO - PROCESS | 27803 | RSS: Main: 219484160 08:39:58 INFO - PROCESS | 27803 | 08:43:01 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:41318/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41318/tests/dromaeo/cssquery-yui.html) 08:43:02 INFO - PROCESS | 27803 | RSS: Main: 219086848 08:43:02 INFO - PROCESS | 27803 | 08:46:05 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:41318/tests/dromaeo/cssquery-yui.html (next: http://localhost:41318/tests/dromaeo/cssquery-dojo.html) 08:46:05 INFO - PROCESS | 27803 | RSS: Main: 307486720 08:46:05 INFO - PROCESS | 27803 | 08:46:05 INFO - PROCESS | 27803 | __start_tp_report 08:46:05 INFO - PROCESS | 27803 | _x_x_mozilla_page_load 08:46:05 INFO - PROCESS | 27803 | _x_x_mozilla_page_load_details 08:46:05 INFO - PROCESS | 27803 | |i|pagename|runs| 08:46:05 INFO - PROCESS | 27803 | |0;dojo.html;2557.0666706652073;2608.973910260899;2615.0716495644047;2618.0574993002515;2631.592103224;4541.818327266914;4565.223911934971;4569.337446070318;4660.883477913054;4667.789949452279;4528.7056341337875;4552.817887284505;4590.495045544987;4592.448906131269;4694.248920172773;4002.4749603619607;4221;4245.7240279381895;4288.120935208291;4311.28863737483;4281.614654681093;4309.224339618867;4312.029793296499;4318.093200427914;4319.568043195671;4127.050778321003;4127.463429754112;4171.937420938689;4218.325067989138;4223.049813791872;4223.1975924574535;4227;4227.387028880795;4228.746275223466;4237.8304867805255;4235.25882970479;4235.745855248695;4238.131183107486;4239.47006624172;4253.766042867641;4415.028693687384;4460.553944605546;4540.795664195086;4569.885752856172;4618.030213655136;4918.803247870081;4919.704817710913;4930.309756634074;4930.383702037246;4939.135651261051;4941.555260026615;4952.059108769358;4963.032208719301;4965.354503914504;4972.577330926875;4487.439070116236;4550.385697930803;4634.443866736014;4637.443506779175;4647.117047760915;4998.9500104999215;5070.974645126751;5087.186050231945;5092.898142037138;5098.668586541863;4861.756912154378;4872.878178045577;4873.19592267279;4880.975595122001;4884.609231261491;4684.320773487825;4835.29888166221;4934.605231581465;4954.9009019819405;4966.950330496648;4582.381378513925;4832.589229915427;4905.558499735041;4923.581495572845;4927.9507204927495;4905.411350637946;4919.803207871645;4920.138975679241;4922.606191504671;4924.212126059813;4066.9389959150635;4093.2427500912427;4211.915761684749;4215.093754842724;4230.259704551691;3580.2481478889204;3625.329314076904;3636.7816781378006;3665.2486240321205;3693.298273328059;4243.045314804206;4245.745255284693;4250.256205164084;4267.0825772459075;4293.055527783882;4783.617310615212;4826.6621336506105;4827.493113223131;4842.782074806642;4843.951560484421;4289.549597292302;4338.067315527113;4338.240807858675;4348.108637729258;4348.2825333819565;4446.9777651111535;4452.5992660660695;4469.865904022885;4470.6423486121685;4478.619317357996;4534.569215924482;4609.216433206296;4733.266343716729;4749.168895443215;4751.976240118777;4876.21980483121;4925.16272233714;4945.258211268195;4947.060058588857;4947.381577302837;4726.432828060655;4731.645126615449;4732.19552676039;4738.312944622941;4738.384010078667;4656.231721765871;4724.622030237641;4856.8300109495995;4860.222364421676;4872.610191184625;4787.329773831736;4871.244957031666;4890;4896.069746748107;4902.63230257725;4766.571008609242;4773.212419950808;4779.163646361803;4779.880502987453;4794.952050479451;4639.30410438437;4715.78778954941;4776.259679749644;4784.928226076542;4791.065742180242;4638.420197475316;4737.976310118427;4739;4760.309755085563;4762.14281429346;4803.831865884677;4810.13417584838;4848.248521479177;4857.514248575114;4858.878528036827;4527.0493196429115;4595.425571803525;4740.549647783455;4743.715377077387;4761.1429942609275 08:46:05 INFO - PROCESS | 27803 | |1;ext.html;553.4078535966515;559.2059275828324;561.9831405057847;564.7007086244289;576.5330082633067;32983.34033319335;33765.49351759723;33897.32205355894;36486.81756591213;36568;40248.396274055915;40662;40769.38845917313;40775;40830.387544186786;7231.493795434321;7602.77191684249;7744.419168562352;7758.7672369829;9861.654842080528;9663.75840603987;9929.205663546934;9967.202623790115;9981.550830212658;10040.849387259197;10026.849597256047;10044.24668149888;10049.64826231082;10094.79810403795;10133.594656213743;9970.65102721405;10005.699829005069;10011.849822252672;10021.59913603455;10025.498725063791;9813.313068085237;9882.703518894445;9886.714727085504;9891.30760846741;9893.208543316588;37788;38162.04594885122;38257.808710956546;38374.80812595919;38493.42259866104;2958.453114646279;3019.773516986235;3135.2318681922848;3160.3205310858275;3506.8071256080907;28692.282692932637;28759;28781.856090719622;29795.10614681563;30291.545626815616;3275.132089996153;3289.7203737682325;3314.9668503315143;3320.435525960568;3321.2527181383994;236342;237059;238070.99999999825;239484;240372;30223.395532089675;41605;41693;41700;41772.37341439881;30896.69103308983;31080;31134.84432577868;31135.221619459695;31149.532757008663;12139.878601214052;12213.755724885452;12219.327936963375;12223.449944752507;12250.509979600894;9367.110124538158;9562.904370956341;9602.519874006271;9794.314397992071;9906.455144966953;7491.513051651734;7707.614619269014;7751.069871615442;7842.568658723825;7843.803904902423;3012.487877060905;3055.816651000947;3090.644575873803;3107.5960125184033;3117.6258848938273;771.5794891783992;867.2541614211773;882.6557642519423;890.2388457868559;926.4719110107309;23812.52374952526;24722;24772.38069048252;24839.130630427848;24858.254252372095;953.1707414549386;965.4448692002127;977.4379731654327;1003.8644782954353;1011.9627381933577;13837.930810346084;14687.41250349974;14778.630534236516;14977.326020329112;15016.099034057992;355453;361129;361546;361910;362319;40364.59635403667;40692.796536017726;40705.796471018046;40726.38910416346;40740.79629601833;1054.435876805905;1084.446932064637;1141.4178768827792;1191.8033524468365;1212.5695378140633;26972.595411069244;28540.857295713387;29293.414131717673;29334;29725;40638;41137;41252.38121428121;41273;41341.58658413377;299264;300679;301451;302072;302084;24324.878375608718;24600.753992460563;25118.74881251164;25199.87400062988;26050.86974565115;41204.79397602993;41409.37885931653;41484.1703165941;41507.37738933979;41851.58148418598;34896.30207395888;35036.47445288374;35146.82426587851;35155.64844351524;35630.28739425145;35021;35083.824580877954;35218;35432.64567354293;35580.82209588936;34414.82792586121;34909.65090349064;35055.82472087623;35374;35706.64293357033;30107.3978520424;32552;32590.83704581462;32592.511112333807;32596.83701581477;24626.753732462446;24653;24855.627165592894;25301;25395.36511587151 08:46:05 INFO - PROCESS | 27803 | |2;jquery.html;350.7019033821254;363.09045840170387;366.25832688805167;370.7386292663671;394.06999481224307;12906.354682265885;15847.920760396211;16126.919365403171;16489.42287019953;17643.206055727493;15695.764563531557;16715.414960476384;16894.408695695653;16901.661966760657;17016.914915425437;5027.924581131268;5077.771500282487;5081.872953176163;5117.513836185556;5131.3842338919385;3758.740821824692;5082.491750824925;5176.818811341604;5786.68173250471;6132.386761323876;6144.293406258271;6174.84562885927;6177.938220617782;6180.969095154541;6184.28880678721;5889.057750759879;5912.881742365129;5919.556033297498;5928.466438020556;5931.169636250886;5060.74696265189;5153.948460515422;5154.613403994716;5160.587153027749;5161.870953226162;19980.800191998038;20541.178352865867;20563.48591285215;20597;20674.276400326067;2116;2450.0689737899484;2466.802655787533;2506.085278873198;2517.0561039610147;13147.408366623526;13288.26914519701;13325.333733313295;13573;13991.440342386293;1724.2930398536664;1770.849477794389;1830.3410772122024;1959.1967293409634;1982.3359174676357;63006;63193;64910.35089649138;65063.67468162629;66272.3372766271;9985.10134087921;10109.747256318651;10126.038026387481;10179.84730229047;10244.180465562737;13723.931380343034;13739.862601373858;13754.793678094837;13780;13790.931045344709;6951.7914462566205;7122.608256545836;7133.857322853618;7344.742933997284;7362.889556656654;6586.8353291168105;6674.16572928384;6891.552049116892;6896.862062758717;6900.206476255295;4162.854300099542;4241.363795430649;4250.4899412070135;4279.786010699452;4470.664700147502;1811.4837271377594;1830.5515148788365;1842.3183422133895;1862.4785060183171;1907.1036612791966;817.2032268538128;832.3923535818886;838.8406202821567;848.5121055393174;909.8544232922701;16513.504594862174;16715.247813848408;17036.574085647957;17357.826421735623;17423.47729568115;849.1593322610571;870.6572618474383;876.4215617692292;883.3816328570026;888.311558542122;8693.130686931256;9678.370905891095;9705.272104592043;9727.173190278905;9737.951310243403;376618;382996;386219;388709;394848;70910.64544677244;73468.63265683637;73886;74002.62998684972;74304.14239644053;815.0748899998426;824.7855557554959;826.9173082691683;827.7392621324263;831.550962480266;14652.19412932299;14818.925905370405;14982.40070397172;15092.924535377253;15495.30271137779;34580.65419345774;36601.63398366089;36682.63317366899;38539.41178529154;40317.59682403138;47269.527304726515;48646.27030594615;50719.271684329506;51937.7403112982;53059.73470132625;9662.75843103928;10166.949165254126;10225.795484090128;10293.794124117327;10981.780364392507;10828.18788590843;11151;11272.9436352821;11439.370834604177;11935.164538482222;10071.381440825291;10161.745956351151;10366.844497332395;10515.106215971728;10582.047615714622;10143.442110683984;10475.633352832614;10715.839262410915;10740.785184296426;10869.51087201062;10506.737331566772;10557.524911378852;10622.787544248917;10690.839637405601;11144.164187685794;10139.188864890644;10154.238432117472;10266.58933642646;10499.842502362624;11001.22991390627;9814.165795907427;10383.273170877967;10400;10411.47942602882;10846.566137354417 08:46:05 INFO - PROCESS | 27803 | |3;mootools.html;1047.9790404191922;1370.4655184478052;1379.758542255105;1479.6818683982942;1704.7698560694303;6580.21037475503;7293.890591641123;7627.7330293439745;7630.008098947136;7783.844323113534;7675.347595454393;7761.728339508119;7771.961140194306;7780.805479863006;7785.026871641045;2182.2580322690283;2206.6359050756687;2206.889655517226;2207.128184367174;2215.6122678531274;2134.1676746069047;2160.5786871560053;2206.8675879447205;2208.6907832903407;2211.5355775287208;2193.6819161221615;2195.242641288753;2204.1293688992837;2204.4488877780555;2235.832312576555;2155.385715071205;2161.319184456907;2163.3293678959417;2163.8809865457392;2164.101897712447;2114.598226336991;2152.9354119376444;2153.5800518898823;2153.935381938544;2154.2244791874914;7440.702371905118;7612.961935190344;7765.184655611136;7770.494917830323;7772.06735191775;4412.183746006999;4558.749268790215;4617;4623.075384923029;4637.072585482917;2846.6014757933904;2950.3951689903733;3004.819710817358;3007.9398412031856;3008.578798968146;988.8813342398886;990.1682586627196;998.0917365197636;1004.4927311707614;1030.9484525773755;10797.676069717922;11004.504797284142;11005.779884402347;11012.063974562172;11019.173561982883;4170.624643782014;4181.414601955728;4367.10474352757;4422.889427764331;4480.484744254387;8187;8245.670173193004;8266.173382661806;8291.917080829115;8296.294814940677;4539.818407263672;4547.522510136454;4548.044910568751;4548.499665036843;4552.339910712928;3547.5033495310677;3644.7084233261276;4094.6724262058965;4159.064210552662;4166.312558427825;3514.38498262803;3550.4141816600486;3647.835847386874;3660.377735784923;3667.2298817248675;1054.8892366301582;1080.6811990462832;1101.7245688577855;1113.3932007056012;1120.3781901044836;788.1409263902374;805.8186907945666;812.6261919517088;848.2789628815581;857.5026484638895;5156;5210.6004990461915;5392;5500.559955203574;5520.806771762969;831.6382373667474;840.6679361652114;856.7772379181333;916.1525588830306;923.0999775219108;3433.6738009889023;3524.1013541547254;3566.7324950628285;3601.7118630509494;3664.6207781700614;9637.325387222967;10064.245181611408;10064.949675251577;10088.394696318244;10089.142422894136;9231.35380523357;9831.164351030242;9990.300678952404;9992.10071093605;10008.449535275484;7129.322714342129;7432;7432.182459929403;7434.628268586657;7435.702571897172;5138.820141295037;5409.377921538916;5436.918446223231;5516.393196748435;5644.5993031358885;8908.376413650982;9119.361644685074;9126.13301736334;9127.132922372364;9171.587278572613;7322.524035937647;7954.363650908029;9421.811563768822;9503.714888553355;9509.714708558755;6383.712732926937;6656.600603963778;6656.633885136364;6660.234073081658;6660.467162627075;7469.439792015512;7539.246075392417;7553.962230189034;7554.735584254525;7559.1306999695735;6853.17761868579;6911.17065952089;7026.648667566499;7087.255838136922;7114.14630244374;6729.5625784323865;6775.8142325093895;6785.762498312535;7011.088558487364;7038.2961703829205;6020.548458865515;6030.517558595214;6063.848403789941;6066.757329706762;6068.9089663654195;4526.547345265447;4568.17772800899;4617.976910115428;4641.071785642817;4731.172044892199;4396.252637051645;4396.626286765533;4399.472063352418;4471.3740076388685;4534.229181039165 08:46:05 INFO - PROCESS | 27803 | |4;prototype.html;293.95443706225535;302.0199452775742;308.74528513975974;312.6857508204254;312.7794904592261;4606.47025592057;4620.122176786408;4624.722516648999;4627.102887815996;4658.813647454102;4581.862544123674;4589.449266088074;4589.495155532897;4596.862094137181;4601.470830854452;3455.481677748339;3518.736094792888;3556.608773034977;3587.641235876418;3613.8915832524935;3616.6383361663884;3617.149969757105;3619.8914032579064;3623.5868011475545;3633.3278343506404;3583.372909740798;3585.748997570171;3587.7847329160204;3606.891793246207;3611.693006094472;3420.589529256493;3479;3604.7476676632646;3621.6016238213774;3629.401148810443;3223.2425380035675;3234.822084785336;3235.8705651773903;3237.6276728176326;3247.9675203247903;4485.327200919855;4489.887752806206;4490.652804158772;4500.48244451889;4502.57225563571;3945.6448919597374;4114.938275925863;4145.2124096421585;4145.585441455861;4152.854650087233;4764.190087685102;4774.618030557547;4795.348511943409;4815.975920120377;4821.023380414013;3554.3957527220437;3559.893203203908;3570.8214589270433;3581.3553560359123;3582.6775590197008;4877.317175595419;4968.726720030397;4990.70241737151;4996.975619997892;5016.347874776292;3638.1268495560876;3652.5251717277115;3654.506641603403;3666.3501424359147;3673.2286219893585;3646.3072016316814;3677.1726361568967;3681.576618688885;3693.9261214776093;3718.6839118674675;4111.76647005897;4120.855770048034;4129.834806607762;4129.91740165195;4136.607022332873;4543.750093744876;4775.6657034007985;4777.092352453023;4779.569838714532;4780.4741478437345;1259.9370031498388;1277.6933535951305;1281.7116148866617;1282.1665917153925;1287.7231395250067;847.4406891451613;858.3862538285031;859.7549698335944;861.3367706865679;879.8284334554701;4221.9656184235055;4243.978780106079;4245.660347172219;4342.761148136819;4345.695801293879;4939.629527785359;4948.292838970549;4950.381202349707;4956.702597844141;4972.8756781080765;4341.674374421931;4348.369486424451;4357.760323182192;4359.346098085312;4364.646959442583;2475.4306509502917;2576.1498705427166;2610.451805120908;2629.1858617553826;2632.486665100287;4801.959167353931;4808.0383923215495;4811.374521312207;4819.759012049383;4820.855374338776;4915.95084049155;5054.342935418372;5071.644984851025;5079.111155547838;5087.186050231945;4767;4811.422629284508;4812.542808433193;4830;4842.15262329091;4907.730074845917;4916.803327866845;4949.975250123726;4963.801447942186;4986.925196121989;4677.2750223715375;4893.21708526634;4897.485763994871;4900.313956046085;4908.042931628298;4763.54746299101;4787.880302992453;4793.657775822775;4794.544518270898;4803.303520989367;3237.482002879528;3244.3186930743864;3257.2345498808236;3259.3644239373093;3269.3297873936262;4359.825606975685;4376.562343765598;4431.8670439886855;4441.533638967861;4454.196050599512;4133.503979522477;4288.614024737663;4297.742135471882;4318.611324980767;4325.502567204811;4290.978545107255;4294.656427485731;4296.871093867189;4306.50475195344;4308.289132293262;4241.727481755399;4259.595338442843;4265.765382903846;4267.423897773885;4276.657867370665;4303.246931786987;4325.7837108145095;4336.588024137702;4619.491855895782;4789.1858384075485;4679.649026323107;4692.671512994058;4706.317583950239;4720.103180395714;4722.929156062593 08:46:05 INFO - PROCESS | 27803 | |5;yui.html;607.351041921184;610.41095342994;620.9161763161972;684.8459096703242;707.5742379106102;11855.407229638517;14219.715605687892;14670;14689.045212061223;14698.412063517446;13900.93049534751;13907.443702251923;13922.582322530316;13924.651883702913;13966.511172108978;633.645158711121;763.8854171874235;787.9527228366317;792.3938187286731;793.8253584211465;724.1021133794084;780.4302858912997;782.487470706688;783.6943591999125;785.1167436633787;606.6117684681807;609.2627920216544;609.5154352289918;609.7774312375973;610.1671218786347;605.6396444115744;605.8455093951059;606.2482521673138;606.3300053440928;638.0779773227688;564.0749171358933;593.4273426143792;593.717983957621;593.8426317025992;595.4254144750337;13268.800967985391;13299.335033248299;13304;13308.800367994489;13312.733745325137;11851.525938962432;12147.392630368535;12335.75328493434;12531.498740050387;13086.214827110309;11135.345203632467;11210.159238057096;11240.887591124067;11351.318920864775;11385.316880987168;3946.605339466059;4031.9193616127804;4091.85678501251;4155.688323375729;4226.4716910386205;66581.33418665848;67340.3265967339;67610.32389676139;67713.3228667712;68399.65800171017;9226.953865230631;9305.581248843819;9548.331616786758;9555.808883822285;9662.71011869645;16184.67630647404;16200.351985920432;16231.431899883448;16253.024818510927;16278.75581866273;6085.6348619083;6087.817365479043;6110.450059494667;6112.480439162632;6120.785772497941;3727.748483526946;3794.6964242860504;3828.655421012122;3896.3181443247317;3962.32640451124;2838.659360876708;2931.9120426386817;2950.8967186148384;2952.1733914503975;2955.9113226603235;488.1213815132747;498.63599572312415;502.412177752031;506.44797171083695;507.4874376879378;486.57424753340825;520.0638850069859;526.0609811486478;527.6807531443421;541.5099335101739;7111.964440177766;7526.360259377905;7566.583837888969;7646.885296720554;7784.299413052852;516.5325380530626;526.8630156159426;530.6524226631562;531.8112070215018;545.2203349210666;3388.1360253135786;3643.544556930384;3656.3966945453703;3672.559292884871;3731.570869350005;89126.55436722774;91976;94908;95146;98650.50674746724;83881.58059209787;83966;85059.57470212733;85784.28431431337;90500;75264.24735752682;76240.23759762332;78146.6092669533;78364;79079;6900.3444672756;7242.782716518513;7265;7434.1450733166375;7509.849803004018;43051.78474107735;44728.32907506325;45443.54556454393;45521;45965;57942.4205757937;58194.4180558189;64122;65757.67121164555;66395;8341.499510029418;8384.496930184208;8394.244517993166;8768.430052046597;8770.824583508422;9428.528573571431;9600.231981441608;9603.37578057424;9708.902910970799;9777.755556111155;7448.553086814808;9130;9181.632734690538;9639.759006024906;11169.106471482099;10694.786104278026;10870.61952831647;11162.720931976766;11336.376499292288;11924.821127683264;10519.474026298501;11044.613438529614;11096.112311014938;11186.216964812385;11997.64007079789;9582.329236953346;9828.11546960777;9923.255755818198;9997.800043998934;10236.078752912274;9592.472414017297;9969.40183588987;9995.600175992879;10047.799044019224;10057.396556206651 08:46:05 INFO - PROCESS | 27803 | __end_tp_report 08:46:05 INFO - PROCESS | 27803 | __start_cc_report 08:46:05 INFO - PROCESS | 27803 | _x_x_mozilla_cycle_collect,979 08:46:05 INFO - PROCESS | 27803 | __end_cc_report 08:46:05 INFO - PROCESS | 27803 | __startTimestamp1471880765576__endTimestamp 08:46:05 INFO - PROCESS | 27803 | 08:46:05 INFO - PROCESS | 27803 | ------- Summary: start ------- 08:46:05 INFO - PROCESS | 27803 | Number of tests: 6 08:46:05 INFO - PROCESS | 27803 | 08:46:05 INFO - PROCESS | 27803 | [#0] dojo.html Cycles:165 Average:4544.77 Median:4684.32 stddev:467.50 (10.0%) stddev-sans-first:442.16 08:46:05 INFO - PROCESS | 27803 | Values: 2557.1 2609.0 2615.1 2618.1 2631.6 4541.8 4565.2 4569.3 4660.9 4667.8 4528.7 4552.8 4590.5 4592.4 4694.2 4002.5 4221.0 4245.7 4288.1 4311.3 4281.6 4309.2 4312.0 4318.1 4319.6 4127.1 4127.5 4171.9 4218.3 4223.0 4223.2 4227.0 4227.4 4228.7 4237.8 4235.3 4235.7 4238.1 4239.5 4253.8 4415.0 4460.6 4540.8 4569.9 4618.0 4918.8 4919.7 4930.3 4930.4 4939.1 4941.6 4952.1 4963.0 4965.4 4972.6 4487.4 4550.4 4634.4 4637.4 4647.1 4999.0 5071.0 5087.2 5092.9 5098.7 4861.8 4872.9 4873.2 4881.0 4884.6 4684.3 4835.3 4934.6 4954.9 4967.0 4582.4 4832.6 4905.6 4923.6 4928.0 4905.4 4919.8 4920.1 4922.6 4924.2 4066.9 4093.2 4211.9 4215.1 4230.3 3580.2 3625.3 3636.8 3665.2 3693.3 4243.0 4245.7 4250.3 4267.1 4293.1 4783.6 4826.7 4827.5 4842.8 4844.0 4289.5 4338.1 4338.2 4348.1 4348.3 4447.0 4452.6 4469.9 4470.6 4478.6 4534.6 4609.2 4733.3 4749.2 4752.0 4876.2 4925.2 4945.3 4947.1 4947.4 4726.4 4731.6 4732.2 4738.3 4738.4 4656.2 4724.6 4856.8 4860.2 4872.6 4787.3 4871.2 4890.0 4896.1 4902.6 4766.6 4773.2 4779.2 4779.9 4795.0 4639.3 4715.8 4776.3 4784.9 4791.1 4638.4 4738.0 4739.0 4760.3 4762.1 4803.8 4810.1 4848.2 4857.5 4858.9 4527.0 4595.4 4740.5 4743.7 4761.1 08:46:05 INFO - PROCESS | 27803 | 08:46:05 INFO - PROCESS | 27803 | [#1] ext.html Cycles:180 Average:43964.56 Median:34655.56 stddev:79984.32 (230.8%) stddev-sans-first:80142.28 08:46:05 INFO - PROCESS | 27803 | Values: 553.4 559.2 562.0 564.7 576.5 32983.3 33765.5 33897.3 36486.8 36568.0 40248.4 40662.0 40769.4 40775.0 40830.4 7231.5 7602.8 7744.4 7758.8 9861.7 9663.8 9929.2 9967.2 9981.6 10040.8 10026.8 10044.2 10049.6 10094.8 10133.6 9970.7 10005.7 10011.8 10021.6 10025.5 9813.3 9882.7 9886.7 9891.3 9893.2 37788.0 38162.0 38257.8 38374.8 38493.4 2958.5 3019.8 3135.2 3160.3 3506.8 28692.3 28759.0 28781.9 29795.1 30291.5 3275.1 3289.7 3315.0 3320.4 3321.3 236342.0 237059.0 238071.0 239484.0 240372.0 30223.4 41605.0 41693.0 41700.0 41772.4 30896.7 31080.0 31134.8 31135.2 31149.5 12139.9 12213.8 12219.3 12223.4 12250.5 9367.1 9562.9 9602.5 9794.3 9906.5 7491.5 7707.6 7751.1 7842.6 7843.8 3012.5 3055.8 3090.6 3107.6 3117.6 771.6 867.3 882.7 890.2 926.5 23812.5 24722.0 24772.4 24839.1 24858.3 953.2 965.4 977.4 1003.9 1012.0 13837.9 14687.4 14778.6 14977.3 15016.1 355453.0 361129.0 361546.0 361910.0 362319.0 40364.6 40692.8 40705.8 40726.4 40740.8 1054.4 1084.4 1141.4 1191.8 1212.6 26972.6 28540.9 29293.4 29334.0 29725.0 40638.0 41137.0 41252.4 41273.0 41341.6 299264.0 300679.0 301451.0 302072.0 302084.0 24324.9 24600.8 25118.7 25199.9 26050.9 41204.8 41409.4 41484.2 41507.4 41851.6 34896.3 35036.5 35146.8 35155.6 35630.3 35021.0 35083.8 35218.0 35432.6 35580.8 34414.8 34909.7 35055.8 35374.0 35706.6 30107.4 32552.0 32590.8 32592.5 32596.8 24626.8 24653.0 24855.6 25301.0 25395.4 08:46:05 INFO - PROCESS | 27803 | 08:46:05 INFO - PROCESS | 27803 | [#2] jquery.html Cycles:180 Average:24220.71 Median:18483.95 stddev:63507.12 (343.6%) stddev-sans-first:63659.99 08:46:05 INFO - PROCESS | 27803 | Values: 350.7 363.1 366.3 370.7 394.1 12906.4 15847.9 16126.9 16489.4 17643.2 15695.8 16715.4 16894.4 16901.7 17016.9 5027.9 5077.8 5081.9 5117.5 5131.4 3758.7 5082.5 5176.8 5786.7 6132.4 6144.3 6174.8 6177.9 6181.0 6184.3 5889.1 5912.9 5919.6 5928.5 5931.2 5060.7 5153.9 5154.6 5160.6 5161.9 19980.8 20541.2 20563.5 20597.0 20674.3 2116.0 2450.1 2466.8 2506.1 2517.1 13147.4 13288.3 13325.3 13573.0 13991.4 1724.3 1770.8 1830.3 1959.2 1982.3 63006.0 63193.0 64910.4 65063.7 66272.3 9985.1 10109.7 10126.0 10179.8 10244.2 13723.9 13739.9 13754.8 13780.0 13790.9 6951.8 7122.6 7133.9 7344.7 7362.9 6586.8 6674.2 6891.6 6896.9 6900.2 4162.9 4241.4 4250.5 4279.8 4470.7 1811.5 1830.6 1842.3 1862.5 1907.1 817.2 832.4 838.8 848.5 909.9 16513.5 16715.2 17036.6 17357.8 17423.5 849.2 870.7 876.4 883.4 888.3 8693.1 9678.4 9705.3 9727.2 9738.0 376618.0 382996.0 386219.0 388709.0 394848.0 70910.6 73468.6 73886.0 74002.6 74304.1 815.1 824.8 826.9 827.7 831.6 14652.2 14818.9 14982.4 15092.9 15495.3 34580.7 36601.6 36682.6 38539.4 40317.6 47269.5 48646.3 50719.3 51937.7 53059.7 9662.8 10166.9 10225.8 10293.8 10981.8 10828.2 11151.0 11272.9 11439.4 11935.2 10071.4 10161.7 10366.8 10515.1 10582.0 10143.4 10475.6 10715.8 10740.8 10869.5 10506.7 10557.5 10622.8 10690.8 11144.2 10139.2 10154.2 10266.6 10499.8 11001.2 9814.2 10383.3 10400.0 10411.5 10846.6 08:46:05 INFO - PROCESS | 27803 | 08:46:05 INFO - PROCESS | 27803 | [#3] mootools.html Cycles:180 Average:5125.65 Median:4686.12 stddev:2889.55 (61.7%) stddev-sans-first:2881.40 08:46:05 INFO - PROCESS | 27803 | Values: 1048.0 1370.5 1379.8 1479.7 1704.8 6580.2 7293.9 7627.7 7630.0 7783.8 7675.3 7761.7 7772.0 7780.8 7785.0 2182.3 2206.6 2206.9 2207.1 2215.6 2134.2 2160.6 2206.9 2208.7 2211.5 2193.7 2195.2 2204.1 2204.4 2235.8 2155.4 2161.3 2163.3 2163.9 2164.1 2114.6 2152.9 2153.6 2153.9 2154.2 7440.7 7613.0 7765.2 7770.5 7772.1 4412.2 4558.7 4617.0 4623.1 4637.1 2846.6 2950.4 3004.8 3007.9 3008.6 988.9 990.2 998.1 1004.5 1030.9 10797.7 11004.5 11005.8 11012.1 11019.2 4170.6 4181.4 4367.1 4422.9 4480.5 8187.0 8245.7 8266.2 8291.9 8296.3 4539.8 4547.5 4548.0 4548.5 4552.3 3547.5 3644.7 4094.7 4159.1 4166.3 3514.4 3550.4 3647.8 3660.4 3667.2 1054.9 1080.7 1101.7 1113.4 1120.4 788.1 805.8 812.6 848.3 857.5 5156.0 5210.6 5392.0 5500.6 5520.8 831.6 840.7 856.8 916.2 923.1 3433.7 3524.1 3566.7 3601.7 3664.6 9637.3 10064.2 10064.9 10088.4 10089.1 9231.4 9831.2 9990.3 9992.1 10008.4 7129.3 7432.0 7432.2 7434.6 7435.7 5138.8 5409.4 5436.9 5516.4 5644.6 8908.4 9119.4 9126.1 9127.1 9171.6 7322.5 7954.4 9421.8 9503.7 9509.7 6383.7 6656.6 6656.6 6660.2 6660.5 7469.4 7539.2 7554.0 7554.7 7559.1 6853.2 6911.2 7026.6 7087.3 7114.1 6729.6 6775.8 6785.8 7011.1 7038.3 6020.5 6030.5 6063.8 6066.8 6068.9 4526.5 4568.2 4618.0 4641.1 4731.2 4396.3 4396.6 4399.5 4471.4 4534.2 08:46:05 INFO - PROCESS | 27803 | 08:46:05 INFO - PROCESS | 27803 | [#4] prototype.html Cycles:180 Average:3956.94 Median:4339.13 stddev:1123.72 (25.9%) stddev-sans-first:1092.72 08:46:05 INFO - PROCESS | 27803 | Values: 294.0 302.0 308.7 312.7 312.8 4606.5 4620.1 4624.7 4627.1 4658.8 4581.9 4589.4 4589.5 4596.9 4601.5 3455.5 3518.7 3556.6 3587.6 3613.9 3616.6 3617.1 3619.9 3623.6 3633.3 3583.4 3585.7 3587.8 3606.9 3611.7 3420.6 3479.0 3604.7 3621.6 3629.4 3223.2 3234.8 3235.9 3237.6 3248.0 4485.3 4489.9 4490.7 4500.5 4502.6 3945.6 4114.9 4145.2 4145.6 4152.9 4764.2 4774.6 4795.3 4816.0 4821.0 3554.4 3559.9 3570.8 3581.4 3582.7 4877.3 4968.7 4990.7 4997.0 5016.3 3638.1 3652.5 3654.5 3666.4 3673.2 3646.3 3677.2 3681.6 3693.9 3718.7 4111.8 4120.9 4129.8 4129.9 4136.6 4543.8 4775.7 4777.1 4779.6 4780.5 1259.9 1277.7 1281.7 1282.2 1287.7 847.4 858.4 859.8 861.3 879.8 4222.0 4244.0 4245.7 4342.8 4345.7 4939.6 4948.3 4950.4 4956.7 4972.9 4341.7 4348.4 4357.8 4359.3 4364.6 2475.4 2576.1 2610.5 2629.2 2632.5 4802.0 4808.0 4811.4 4819.8 4820.9 4916.0 5054.3 5071.6 5079.1 5087.2 4767.0 4811.4 4812.5 4830.0 4842.2 4907.7 4916.8 4950.0 4963.8 4986.9 4677.3 4893.2 4897.5 4900.3 4908.0 4763.5 4787.9 4793.7 4794.5 4803.3 3237.5 3244.3 3257.2 3259.4 3269.3 4359.8 4376.6 4431.9 4441.5 4454.2 4133.5 4288.6 4297.7 4318.6 4325.5 4291.0 4294.7 4296.9 4306.5 4308.3 4241.7 4259.6 4265.8 4267.4 4276.7 4303.2 4325.8 4336.6 4619.5 4789.2 4679.6 4692.7 4706.3 4720.1 4722.9 08:46:05 INFO - PROCESS | 27803 | 08:46:05 INFO - PROCESS | 27803 | [#5] yui.html Cycles:180 Average:17593.30 Median:600.53 stddev:25714.32 (4281.9%) stddev-sans-first:25754.83 08:46:05 INFO - PROCESS | 27803 | Values: 607.4 610.4 620.9 684.8 707.6 11855.4 14219.7 14670.0 14689.0 14698.4 13900.9 13907.4 13922.6 13924.7 13966.5 633.6 763.9 788.0 792.4 793.8 724.1 780.4 782.5 783.7 785.1 606.6 609.3 609.5 609.8 610.2 605.6 605.8 606.2 606.3 638.1 564.1 593.4 593.7 593.8 595.4 13268.8 13299.3 13304.0 13308.8 13312.7 11851.5 12147.4 12335.8 12531.5 13086.2 11135.3 11210.2 11240.9 11351.3 11385.3 3946.6 4031.9 4091.9 4155.7 4226.5 66581.3 67340.3 67610.3 67713.3 68399.7 9227.0 9305.6 9548.3 9555.8 9662.7 16184.7 16200.4 16231.4 16253.0 16278.8 6085.6 6087.8 6110.5 6112.5 6120.8 3727.7 3794.7 3828.7 3896.3 3962.3 2838.7 2931.9 2950.9 2952.2 2955.9 488.1 498.6 502.4 506.4 507.5 486.6 520.1 526.1 527.7 541.5 7112.0 7526.4 7566.6 7646.9 7784.3 516.5 526.9 530.7 531.8 545.2 3388.1 3643.5 3656.4 3672.6 3731.6 89126.6 91976.0 94908.0 95146.0 98650.5 83881.6 83966.0 85059.6 85784.3 90500.0 75264.2 76240.2 78146.6 78364.0 79079.0 6900.3 7242.8 7265.0 7434.1 7509.8 43051.8 44728.3 45443.5 45521.0 45965.0 57942.4 58194.4 64122.0 65757.7 66395.0 8341.5 8384.5 8394.2 8768.4 8770.8 9428.5 9600.2 9603.4 9708.9 9777.8 7448.6 9130.0 9181.6 9639.8 11169.1 10694.8 10870.6 11162.7 11336.4 11924.8 10519.5 11044.6 11096.1 11186.2 11997.6 9582.3 9828.1 9923.3 9997.8 10236.1 9592.5 9969.4 9995.6 10047.8 10057.4 08:46:05 INFO - PROCESS | 27803 | -------- Summary: end -------- 08:46:05 INFO - PROCESS | 27803 | 08:46:06 INFO - TEST-INFO | 27803: exit 0 08:46:06 INFO - TEST-OK | dromaeo_css | took 1121752ms 08:46:06 INFO - TEST-START | kraken 08:46:06 INFO - operating with platform_type : linux_ 08:46:06 INFO - Initialising browser for kraken test... 08:46:06 INFO - TEST-INFO | started process 28105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXQbzRI/profile http://localhost:41318/getInfo.html) 08:46:11 INFO - PROCESS | 28105 | __metrics Screen width/height:1600/1200 08:46:11 INFO - PROCESS | 28105 | colorDepth:24 08:46:11 INFO - PROCESS | 28105 | Browser inner width/height: 1024/697 08:46:11 INFO - PROCESS | 28105 | __metrics 08:46:11 INFO - PROCESS | 28105 | 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" 08:46:11 INFO - PROCESS | 28105 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:46:12 INFO - PROCESS | 28105 | console.error: PushService: 08:46:12 INFO - PROCESS | 28105 | stateChangeProcessEnqueue: Error transitioning state 08:46:12 INFO - PROCESS | 28105 | UnknownError 08:46:13 INFO - TEST-INFO | 28105: exit 0 08:46:13 INFO - Browser initialized. 08:46:13 INFO - Running cycle 1/1 for kraken test... 08:46:13 INFO - TEST-INFO | started process 28186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXQbzRI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:25 INFO - PROCESS | 28186 | RSS: Main: 175435776 08:46:25 INFO - PROCESS | 28186 | 08:46:28 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41318/tests/kraken/driver.html?testName=audio-beat-detection) 08:46:29 INFO - PROCESS | 28186 | RSS: Main: 236261376 08:46:29 INFO - PROCESS | 28186 | 08:46:32 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41318/tests/kraken/driver.html?testName=audio-dft) 08:46:32 INFO - PROCESS | 28186 | RSS: Main: 227225600 08:46:32 INFO - PROCESS | 28186 | 08:46:35 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41318/tests/kraken/driver.html?testName=audio-fft) 08:46:36 INFO - PROCESS | 28186 | RSS: Main: 302669824 08:46:36 INFO - PROCESS | 28186 | 08:46:38 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41318/tests/kraken/driver.html?testName=audio-oscillator) 08:46:39 INFO - PROCESS | 28186 | RSS: Main: 210427904 08:46:39 INFO - PROCESS | 28186 | 08:46:41 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41318/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:46:42 INFO - PROCESS | 28186 | RSS: Main: 214749184 08:46:42 INFO - PROCESS | 28186 | 08:46:45 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41318/tests/kraken/driver.html?testName=imaging-darkroom) 08:46:46 INFO - PROCESS | 28186 | RSS: Main: 251088896 08:46:46 INFO - PROCESS | 28186 | 08:46:49 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41318/tests/kraken/driver.html?testName=imaging-desaturate) 08:46:50 INFO - PROCESS | 28186 | RSS: Main: 244744192 08:46:50 INFO - PROCESS | 28186 | 08:46:53 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41318/tests/kraken/driver.html?testName=json-parse-financial) 08:46:53 INFO - PROCESS | 28186 | RSS: Main: 248143872 08:46:53 INFO - PROCESS | 28186 | 08:46:55 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41318/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:46:56 INFO - PROCESS | 28186 | RSS: Main: 211853312 08:46:56 INFO - PROCESS | 28186 | 08:46:58 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41318/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:46:58 INFO - PROCESS | 28186 | RSS: Main: 219504640 08:46:58 INFO - PROCESS | 28186 | 08:47:01 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41318/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:47:01 INFO - PROCESS | 28186 | RSS: Main: 223580160 08:47:01 INFO - PROCESS | 28186 | 08:47:04 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:47:05 INFO - PROCESS | 28186 | RSS: Main: 218796032 08:47:05 INFO - PROCESS | 28186 | 08:47:08 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:47:08 INFO - PROCESS | 28186 | RSS: Main: 222494720 08:47:08 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | Cycle 1(1): loaded http://localhost:41318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41318/tests/kraken/driver.html?testName=ai-astar) 08:47:10 INFO - PROCESS | 28186 | RSS: Main: 273686528 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | __start_tp_report 08:47:10 INFO - PROCESS | 28186 | _x_x_mozilla_page_load 08:47:10 INFO - PROCESS | 28186 | _x_x_mozilla_page_load_details 08:47:10 INFO - PROCESS | 28186 | |i|pagename|runs| 08:47:10 INFO - PROCESS | 28186 | |0;ai-astar;102;115;113;118;115;115;122;115;116;115 08:47:10 INFO - PROCESS | 28186 | |1;audio-beat-detection;153;125;156;187;130;151;149;129;190;120 08:47:10 INFO - PROCESS | 28186 | |2;audio-dft;161;163;160;161;162;163;164;162;162;163 08:47:10 INFO - PROCESS | 28186 | |3;audio-fft;75;77;77;180;76;76;76;116;112;75 08:47:10 INFO - PROCESS | 28186 | |4;audio-oscillator;88;87;151;86;87;86;145;86;86;141 08:47:10 INFO - PROCESS | 28186 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;116;117 08:47:10 INFO - PROCESS | 28186 | |6;imaging-darkroom;146;147;146;146;147;150;148;146;146;147 08:47:10 INFO - PROCESS | 28186 | |7;imaging-desaturate;95;95;96;94;95;96;95;95;95;94 08:47:10 INFO - PROCESS | 28186 | |8;json-parse-financial;65;66;66;65;66;67;68;67;66;66 08:47:10 INFO - PROCESS | 28186 | |9;json-stringify-tinderbox;65;65;66;65;66;65;70;66;65;64 08:47:10 INFO - PROCESS | 28186 | |10;stanford-crypto-aes;82;81;83;82;93;92;82;82;82;88 08:47:10 INFO - PROCESS | 28186 | |11;stanford-crypto-ccm;134;142;133;134;132;131;134;133;159;134 08:47:10 INFO - PROCESS | 28186 | |12;stanford-crypto-pbkdf2;174;174;181;177;177;178;175;180;172;172 08:47:10 INFO - PROCESS | 28186 | |13;stanford-crypto-sha256-iterative;77;72;69;69;68;70;68;72;68;68 08:47:10 INFO - PROCESS | 28186 | __end_tp_report 08:47:10 INFO - PROCESS | 28186 | __start_cc_report 08:47:10 INFO - PROCESS | 28186 | _x_x_mozilla_cycle_collect,1987 08:47:10 INFO - PROCESS | 28186 | __end_cc_report 08:47:10 INFO - PROCESS | 28186 | __startTimestamp1471880830823__endTimestamp 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | ------- Summary: start ------- 08:47:10 INFO - PROCESS | 28186 | Number of tests: 14 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:5.06 (4.4%) stddev-sans-first:2.60 08:47:10 INFO - PROCESS | 28186 | Values: 102.0 115.0 113.0 118.0 115.0 115.0 122.0 115.0 116.0 115.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:152.00 stddev:24.43 (16.1%) stddev-sans-first:25.87 08:47:10 INFO - PROCESS | 28186 | Values: 153.0 125.0 156.0 187.0 130.0 151.0 149.0 129.0 190.0 120.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.20 (0.7%) stddev-sans-first:1.20 08:47:10 INFO - PROCESS | 28186 | Values: 161.0 163.0 160.0 161.0 162.0 163.0 164.0 162.0 162.0 163.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:34.12 (44.9%) stddev-sans-first:35.49 08:47:10 INFO - PROCESS | 28186 | Values: 75.0 77.0 77.0 180.0 76.0 76.0 76.0 116.0 112.0 75.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:86.00 stddev:28.65 (33.3%) stddev-sans-first:29.78 08:47:10 INFO - PROCESS | 28186 | Values: 88.0 87.0 151.0 86.0 87.0 86.0 145.0 86.0 86.0 141.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 08:47:10 INFO - PROCESS | 28186 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.29 (0.9%) stddev-sans-first:1.32 08:47:10 INFO - PROCESS | 28186 | Values: 146.0 147.0 146.0 146.0 147.0 150.0 148.0 146.0 146.0 147.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:47:10 INFO - PROCESS | 28186 | Values: 95.0 95.0 96.0 94.0 95.0 96.0 95.0 95.0 95.0 94.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 08:47:10 INFO - PROCESS | 28186 | Values: 65.0 66.0 66.0 65.0 66.0 67.0 68.0 67.0 66.0 66.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.50 stddev:1.64 (2.5%) stddev-sans-first:1.72 08:47:10 INFO - PROCESS | 28186 | Values: 65.0 65.0 66.0 65.0 66.0 65.0 70.0 66.0 65.0 64.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:82.50 stddev:4.55 (5.5%) stddev-sans-first:4.72 08:47:10 INFO - PROCESS | 28186 | Values: 82.0 81.0 83.0 82.0 93.0 92.0 82.0 82.0 82.0 88.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:134.00 stddev:8.41 (6.3%) stddev-sans-first:8.87 08:47:10 INFO - PROCESS | 28186 | Values: 134.0 142.0 133.0 134.0 132.0 131.0 134.0 133.0 159.0 134.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:177.00 stddev:3.13 (1.8%) stddev-sans-first:3.23 08:47:10 INFO - PROCESS | 28186 | Values: 174.0 174.0 181.0 177.0 177.0 178.0 175.0 180.0 172.0 172.0 08:47:10 INFO - PROCESS | 28186 | 08:47:10 INFO - PROCESS | 28186 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:69.50 stddev:2.88 (4.2%) stddev-sans-first:1.66 08:47:10 INFO - PROCESS | 28186 | Values: 77.0 72.0 69.0 69.0 68.0 70.0 68.0 72.0 68.0 68.0 08:47:10 INFO - PROCESS | 28186 | -------- Summary: end -------- 08:47:10 INFO - PROCESS | 28186 | 08:47:12 INFO - TEST-INFO | 28186: exit 0 08:47:12 INFO - TEST-OK | kraken | took 65544ms 08:47:12 INFO - SUITE-END | took 1187s 08:47:12 INFO - Completed test suite (00:19:47) 08:47:12 INFO - javascript benchmark 08:47:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2557.0666706652073, 2608.973910260899, 2615.0716495644047, 2618.0574993002515, 2631.592103224, 4541.818327266914, 4565.223911934971, 4569.337446070318, 4660.883477913054, 4667.789949452279, 4528.7056341337875, 4552.817887284505, 4590.495045544987, 4592.448906131269, 4694.248920172773, 4002.4749603619607, 4221.0, 4245.7240279381895, 4288.120935208291, 4311.28863737483, 4281.614654681093, 4309.224339618867, 4312.029793296499, 4318.093200427914, 4319.568043195671, 4127.050778321003, 4127.463429754112, 4171.937420938689, 4218.325067989138, 4223.049813791872, 4223.1975924574535, 4227.0, 4227.387028880795, 4228.746275223466, 4237.8304867805255, 4235.25882970479, 4235.745855248695, 4238.131183107486, 4239.47006624172, 4253.766042867641, 4415.028693687384, 4460.553944605546, 4540.795664195086, 4569.885752856172, 4618.030213655136, 4918.803247870081, 4919.704817710913, 4930.309756634074, 4930.383702037246, 4939.135651261051, 4941.555260026615, 4952.059108769358, 4963.032208719301, 4965.354503914504, 4972.577330926875, 4487.439070116236, 4550.385697930803, 4634.443866736014, 4637.443506779175, 4647.117047760915, 4998.9500104999215, 5070.974645126751, 5087.186050231945, 5092.898142037138, 5098.668586541863, 4861.756912154378, 4872.878178045577, 4873.19592267279, 4880.975595122001, 4884.609231261491, 4684.320773487825, 4835.29888166221, 4934.605231581465, 4954.9009019819405, 4966.950330496648, 4582.381378513925, 4832.589229915427, 4905.558499735041, 4923.581495572845, 4927.9507204927495, 4905.411350637946, 4919.803207871645, 4920.138975679241, 4922.606191504671, 4924.212126059813, 4066.9389959150635, 4093.2427500912427, 4211.915761684749, 4215.093754842724, 4230.259704551691, 3580.2481478889204, 3625.329314076904, 3636.7816781378006, 3665.2486240321205, 3693.298273328059, 4243.045314804206, 4245.745255284693, 4250.256205164084, 4267.0825772459075, 4293.055527783882, 4783.617310615212, 4826.6621336506105, 4827.493113223131, 4842.782074806642, 4843.951560484421, 4289.549597292302, 4338.067315527113, 4338.240807858675, 4348.108637729258, 4348.2825333819565, 4446.9777651111535, 4452.5992660660695, 4469.865904022885, 4470.6423486121685, 4478.619317357996, 4534.569215924482, 4609.216433206296, 4733.266343716729, 4749.168895443215, 4751.976240118777, 4876.21980483121, 4925.16272233714, 4945.258211268195, 4947.060058588857, 4947.381577302837, 4726.432828060655, 4731.645126615449, 4732.19552676039, 4738.312944622941, 4738.384010078667, 4656.231721765871, 4724.622030237641, 4856.8300109495995, 4860.222364421676, 4872.610191184625, 4787.329773831736, 4871.244957031666, 4890.0, 4896.069746748107, 4902.63230257725, 4766.571008609242, 4773.212419950808, 4779.163646361803, 4779.880502987453, 4794.952050479451, 4639.30410438437, 4715.78778954941, 4776.259679749644, 4784.928226076542, 4791.065742180242, 4638.420197475316, 4737.976310118427, 4739.0, 4760.309755085563, 4762.14281429346, 4803.831865884677, 4810.13417584838, 4848.248521479177, 4857.514248575114, 4858.878528036827, 4527.0493196429115, 4595.425571803525, 4740.549647783455, 4743.715377077387, 4761.1429942609275], "value": 4515.722792671924, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.4078535966515, 559.2059275828324, 561.9831405057847, 564.7007086244289, 576.5330082633067, 32983.34033319335, 33765.49351759723, 33897.32205355894, 36486.81756591213, 36568.0, 40248.396274055915, 40662.0, 40769.38845917313, 40775.0, 40830.387544186786, 7231.493795434321, 7602.77191684249, 7744.419168562352, 7758.7672369829, 9861.654842080528, 9663.75840603987, 9929.205663546934, 9967.202623790115, 9981.550830212658, 10040.849387259197, 10026.849597256047, 10044.24668149888, 10049.64826231082, 10094.79810403795, 10133.594656213743, 9970.65102721405, 10005.699829005069, 10011.849822252672, 10021.59913603455, 10025.498725063791, 9813.313068085237, 9882.703518894445, 9886.714727085504, 9891.30760846741, 9893.208543316588, 37788.0, 38162.04594885122, 38257.808710956546, 38374.80812595919, 38493.42259866104, 2958.453114646279, 3019.773516986235, 3135.2318681922848, 3160.3205310858275, 3506.8071256080907, 28692.282692932637, 28759.0, 28781.856090719622, 29795.10614681563, 30291.545626815616, 3275.132089996153, 3289.7203737682325, 3314.9668503315143, 3320.435525960568, 3321.2527181383994, 236342.0, 237059.0, 238070.99999999825, 239484.0, 240372.0, 30223.395532089675, 41605.0, 41693.0, 41700.0, 41772.37341439881, 30896.69103308983, 31080.0, 31134.84432577868, 31135.221619459695, 31149.532757008663, 12139.878601214052, 12213.755724885452, 12219.327936963375, 12223.449944752507, 12250.509979600894, 9367.110124538158, 9562.904370956341, 9602.519874006271, 9794.314397992071, 9906.455144966953, 7491.513051651734, 7707.614619269014, 7751.069871615442, 7842.568658723825, 7843.803904902423, 3012.487877060905, 3055.816651000947, 3090.644575873803, 3107.5960125184033, 3117.6258848938273, 771.5794891783992, 867.2541614211773, 882.6557642519423, 890.2388457868559, 926.4719110107309, 23812.52374952526, 24722.0, 24772.38069048252, 24839.130630427848, 24858.254252372095, 953.1707414549386, 965.4448692002127, 977.4379731654327, 1003.8644782954353, 1011.9627381933577, 13837.930810346084, 14687.41250349974, 14778.630534236516, 14977.326020329112, 15016.099034057992, 355453.0, 361129.0, 361546.0, 361910.0, 362319.0, 40364.59635403667, 40692.796536017726, 40705.796471018046, 40726.38910416346, 40740.79629601833, 1054.435876805905, 1084.446932064637, 1141.4178768827792, 1191.8033524468365, 1212.5695378140633, 26972.595411069244, 28540.857295713387, 29293.414131717673, 29334.0, 29725.0, 40638.0, 41137.0, 41252.38121428121, 41273.0, 41341.58658413377, 299264.0, 300679.0, 301451.0, 302072.0, 302084.0, 24324.878375608718, 24600.753992460563, 25118.74881251164, 25199.87400062988, 26050.86974565115, 41204.79397602993, 41409.37885931653, 41484.1703165941, 41507.37738933979, 41851.58148418598, 34896.30207395888, 35036.47445288374, 35146.82426587851, 35155.64844351524, 35630.28739425145, 35021.0, 35083.824580877954, 35218.0, 35432.64567354293, 35580.82209588936, 34414.82792586121, 34909.65090349064, 35055.82472087623, 35374.0, 35706.64293357033, 30107.3978520424, 32552.0, 32590.83704581462, 32592.511112333807, 32596.83701581477, 24626.753732462446, 24653.0, 24855.627165592894, 25301.0, 25395.36511587151], "value": 16261.489945013656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.7019033821254, 363.09045840170387, 366.25832688805167, 370.7386292663671, 394.06999481224307, 12906.354682265885, 15847.920760396211, 16126.919365403171, 16489.42287019953, 17643.206055727493, 15695.764563531557, 16715.414960476384, 16894.408695695653, 16901.661966760657, 17016.914915425437, 5027.924581131268, 5077.771500282487, 5081.872953176163, 5117.513836185556, 5131.3842338919385, 3758.740821824692, 5082.491750824925, 5176.818811341604, 5786.68173250471, 6132.386761323876, 6144.293406258271, 6174.84562885927, 6177.938220617782, 6180.969095154541, 6184.28880678721, 5889.057750759879, 5912.881742365129, 5919.556033297498, 5928.466438020556, 5931.169636250886, 5060.74696265189, 5153.948460515422, 5154.613403994716, 5160.587153027749, 5161.870953226162, 19980.800191998038, 20541.178352865867, 20563.48591285215, 20597.0, 20674.276400326067, 2116.0, 2450.0689737899484, 2466.802655787533, 2506.085278873198, 2517.0561039610147, 13147.408366623526, 13288.26914519701, 13325.333733313295, 13573.0, 13991.440342386293, 1724.2930398536664, 1770.849477794389, 1830.3410772122024, 1959.1967293409634, 1982.3359174676357, 63006.0, 63193.0, 64910.35089649138, 65063.67468162629, 66272.3372766271, 9985.10134087921, 10109.747256318651, 10126.038026387481, 10179.84730229047, 10244.180465562737, 13723.931380343034, 13739.862601373858, 13754.793678094837, 13780.0, 13790.931045344709, 6951.7914462566205, 7122.608256545836, 7133.857322853618, 7344.742933997284, 7362.889556656654, 6586.8353291168105, 6674.16572928384, 6891.552049116892, 6896.862062758717, 6900.206476255295, 4162.854300099542, 4241.363795430649, 4250.4899412070135, 4279.786010699452, 4470.664700147502, 1811.4837271377594, 1830.5515148788365, 1842.3183422133895, 1862.4785060183171, 1907.1036612791966, 817.2032268538128, 832.3923535818886, 838.8406202821567, 848.5121055393174, 909.8544232922701, 16513.504594862174, 16715.247813848408, 17036.574085647957, 17357.826421735623, 17423.47729568115, 849.1593322610571, 870.6572618474383, 876.4215617692292, 883.3816328570026, 888.311558542122, 8693.130686931256, 9678.370905891095, 9705.272104592043, 9727.173190278905, 9737.951310243403, 376618.0, 382996.0, 386219.0, 388709.0, 394848.0, 70910.64544677244, 73468.63265683637, 73886.0, 74002.62998684972, 74304.14239644053, 815.0748899998426, 824.7855557554959, 826.9173082691683, 827.7392621324263, 831.550962480266, 14652.19412932299, 14818.925905370405, 14982.40070397172, 15092.924535377253, 15495.30271137779, 34580.65419345774, 36601.63398366089, 36682.63317366899, 38539.41178529154, 40317.59682403138, 47269.527304726515, 48646.27030594615, 50719.271684329506, 51937.7403112982, 53059.73470132625, 9662.75843103928, 10166.949165254126, 10225.795484090128, 10293.794124117327, 10981.780364392507, 10828.18788590843, 11151.0, 11272.9436352821, 11439.370834604177, 11935.164538482222, 10071.381440825291, 10161.745956351151, 10366.844497332395, 10515.106215971728, 10582.047615714622, 10143.442110683984, 10475.633352832614, 10715.839262410915, 10740.785184296426, 10869.51087201062, 10506.737331566772, 10557.524911378852, 10622.787544248917, 10690.839637405601, 11144.164187685794, 10139.188864890644, 10154.238432117472, 10266.58933642646, 10499.842502362624, 11001.22991390627, 9814.165795907427, 10383.273170877967, 10400.0, 10411.47942602882, 10846.566137354417], "value": 8457.794029020273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1047.9790404191922, 1370.4655184478052, 1379.758542255105, 1479.6818683982942, 1704.7698560694303, 6580.21037475503, 7293.890591641123, 7627.7330293439745, 7630.008098947136, 7783.844323113534, 7675.347595454393, 7761.728339508119, 7771.961140194306, 7780.805479863006, 7785.026871641045, 2182.2580322690283, 2206.6359050756687, 2206.889655517226, 2207.128184367174, 2215.6122678531274, 2134.1676746069047, 2160.5786871560053, 2206.8675879447205, 2208.6907832903407, 2211.5355775287208, 2193.6819161221615, 2195.242641288753, 2204.1293688992837, 2204.4488877780555, 2235.832312576555, 2155.385715071205, 2161.319184456907, 2163.3293678959417, 2163.8809865457392, 2164.101897712447, 2114.598226336991, 2152.9354119376444, 2153.5800518898823, 2153.935381938544, 2154.2244791874914, 7440.702371905118, 7612.961935190344, 7765.184655611136, 7770.494917830323, 7772.06735191775, 4412.183746006999, 4558.749268790215, 4617.0, 4623.075384923029, 4637.072585482917, 2846.6014757933904, 2950.3951689903733, 3004.819710817358, 3007.9398412031856, 3008.578798968146, 988.8813342398886, 990.1682586627196, 998.0917365197636, 1004.4927311707614, 1030.9484525773755, 10797.676069717922, 11004.504797284142, 11005.779884402347, 11012.063974562172, 11019.173561982883, 4170.624643782014, 4181.414601955728, 4367.10474352757, 4422.889427764331, 4480.484744254387, 8187.0, 8245.670173193004, 8266.173382661806, 8291.917080829115, 8296.294814940677, 4539.818407263672, 4547.522510136454, 4548.044910568751, 4548.499665036843, 4552.339910712928, 3547.5033495310677, 3644.7084233261276, 4094.6724262058965, 4159.064210552662, 4166.312558427825, 3514.38498262803, 3550.4141816600486, 3647.835847386874, 3660.377735784923, 3667.2298817248675, 1054.8892366301582, 1080.6811990462832, 1101.7245688577855, 1113.3932007056012, 1120.3781901044836, 788.1409263902374, 805.8186907945666, 812.6261919517088, 848.2789628815581, 857.5026484638895, 5156.0, 5210.6004990461915, 5392.0, 5500.559955203574, 5520.806771762969, 831.6382373667474, 840.6679361652114, 856.7772379181333, 916.1525588830306, 923.0999775219108, 3433.6738009889023, 3524.1013541547254, 3566.7324950628285, 3601.7118630509494, 3664.6207781700614, 9637.325387222967, 10064.245181611408, 10064.949675251577, 10088.394696318244, 10089.142422894136, 9231.35380523357, 9831.164351030242, 9990.300678952404, 9992.10071093605, 10008.449535275484, 7129.322714342129, 7432.0, 7432.182459929403, 7434.628268586657, 7435.702571897172, 5138.820141295037, 5409.377921538916, 5436.918446223231, 5516.393196748435, 5644.5993031358885, 8908.376413650982, 9119.361644685074, 9126.13301736334, 9127.132922372364, 9171.587278572613, 7322.524035937647, 7954.363650908029, 9421.811563768822, 9503.714888553355, 9509.714708558755, 6383.712732926937, 6656.600603963778, 6656.633885136364, 6660.234073081658, 6660.467162627075, 7469.439792015512, 7539.246075392417, 7553.962230189034, 7554.735584254525, 7559.1306999695735, 6853.17761868579, 6911.17065952089, 7026.648667566499, 7087.255838136922, 7114.14630244374, 6729.5625784323865, 6775.8142325093895, 6785.762498312535, 7011.088558487364, 7038.2961703829205, 6020.548458865515, 6030.517558595214, 6063.848403789941, 6066.757329706762, 6068.9089663654195, 4526.547345265447, 4568.17772800899, 4617.976910115428, 4641.071785642817, 4731.172044892199, 4396.252637051645, 4396.626286765533, 4399.472063352418, 4471.3740076388685, 4534.229181039165], "value": 4125.6255791473095, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.95443706225535, 302.0199452775742, 308.74528513975974, 312.6857508204254, 312.7794904592261, 4606.47025592057, 4620.122176786408, 4624.722516648999, 4627.102887815996, 4658.813647454102, 4581.862544123674, 4589.449266088074, 4589.495155532897, 4596.862094137181, 4601.470830854452, 3455.481677748339, 3518.736094792888, 3556.608773034977, 3587.641235876418, 3613.8915832524935, 3616.6383361663884, 3617.149969757105, 3619.8914032579064, 3623.5868011475545, 3633.3278343506404, 3583.372909740798, 3585.748997570171, 3587.7847329160204, 3606.891793246207, 3611.693006094472, 3420.589529256493, 3479.0, 3604.7476676632646, 3621.6016238213774, 3629.401148810443, 3223.2425380035675, 3234.822084785336, 3235.8705651773903, 3237.6276728176326, 3247.9675203247903, 4485.327200919855, 4489.887752806206, 4490.652804158772, 4500.48244451889, 4502.57225563571, 3945.6448919597374, 4114.938275925863, 4145.2124096421585, 4145.585441455861, 4152.854650087233, 4764.190087685102, 4774.618030557547, 4795.348511943409, 4815.975920120377, 4821.023380414013, 3554.3957527220437, 3559.893203203908, 3570.8214589270433, 3581.3553560359123, 3582.6775590197008, 4877.317175595419, 4968.726720030397, 4990.70241737151, 4996.975619997892, 5016.347874776292, 3638.1268495560876, 3652.5251717277115, 3654.506641603403, 3666.3501424359147, 3673.2286219893585, 3646.3072016316814, 3677.1726361568967, 3681.576618688885, 3693.9261214776093, 3718.6839118674675, 4111.76647005897, 4120.855770048034, 4129.834806607762, 4129.91740165195, 4136.607022332873, 4543.750093744876, 4775.6657034007985, 4777.092352453023, 4779.569838714532, 4780.4741478437345, 1259.9370031498388, 1277.6933535951305, 1281.7116148866617, 1282.1665917153925, 1287.7231395250067, 847.4406891451613, 858.3862538285031, 859.7549698335944, 861.3367706865679, 879.8284334554701, 4221.9656184235055, 4243.978780106079, 4245.660347172219, 4342.761148136819, 4345.695801293879, 4939.629527785359, 4948.292838970549, 4950.381202349707, 4956.702597844141, 4972.8756781080765, 4341.674374421931, 4348.369486424451, 4357.760323182192, 4359.346098085312, 4364.646959442583, 2475.4306509502917, 2576.1498705427166, 2610.451805120908, 2629.1858617553826, 2632.486665100287, 4801.959167353931, 4808.0383923215495, 4811.374521312207, 4819.759012049383, 4820.855374338776, 4915.95084049155, 5054.342935418372, 5071.644984851025, 5079.111155547838, 5087.186050231945, 4767.0, 4811.422629284508, 4812.542808433193, 4830.0, 4842.15262329091, 4907.730074845917, 4916.803327866845, 4949.975250123726, 4963.801447942186, 4986.925196121989, 4677.2750223715375, 4893.21708526634, 4897.485763994871, 4900.313956046085, 4908.042931628298, 4763.54746299101, 4787.880302992453, 4793.657775822775, 4794.544518270898, 4803.303520989367, 3237.482002879528, 3244.3186930743864, 3257.2345498808236, 3259.3644239373093, 3269.3297873936262, 4359.825606975685, 4376.562343765598, 4431.8670439886855, 4441.533638967861, 4454.196050599512, 4133.503979522477, 4288.614024737663, 4297.742135471882, 4318.611324980767, 4325.502567204811, 4290.978545107255, 4294.656427485731, 4296.871093867189, 4306.50475195344, 4308.289132293262, 4241.727481755399, 4259.595338442843, 4265.765382903846, 4267.423897773885, 4276.657867370665, 4303.246931786987, 4325.7837108145095, 4336.588024137702, 4619.491855895782, 4789.1858384075485, 4679.649026323107, 4692.671512994058, 4706.317583950239, 4720.103180395714, 4722.929156062593], "value": 3611.2754573697207, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.351041921184, 610.41095342994, 620.9161763161972, 684.8459096703242, 707.5742379106102, 11855.407229638517, 14219.715605687892, 14670.0, 14689.045212061223, 14698.412063517446, 13900.93049534751, 13907.443702251923, 13922.582322530316, 13924.651883702913, 13966.511172108978, 633.645158711121, 763.8854171874235, 787.9527228366317, 792.3938187286731, 793.8253584211465, 724.1021133794084, 780.4302858912997, 782.487470706688, 783.6943591999125, 785.1167436633787, 606.6117684681807, 609.2627920216544, 609.5154352289918, 609.7774312375973, 610.1671218786347, 605.6396444115744, 605.8455093951059, 606.2482521673138, 606.3300053440928, 638.0779773227688, 564.0749171358933, 593.4273426143792, 593.717983957621, 593.8426317025992, 595.4254144750337, 13268.800967985391, 13299.335033248299, 13304.0, 13308.800367994489, 13312.733745325137, 11851.525938962432, 12147.392630368535, 12335.75328493434, 12531.498740050387, 13086.214827110309, 11135.345203632467, 11210.159238057096, 11240.887591124067, 11351.318920864775, 11385.316880987168, 3946.605339466059, 4031.9193616127804, 4091.85678501251, 4155.688323375729, 4226.4716910386205, 66581.33418665848, 67340.3265967339, 67610.32389676139, 67713.3228667712, 68399.65800171017, 9226.953865230631, 9305.581248843819, 9548.331616786758, 9555.808883822285, 9662.71011869645, 16184.67630647404, 16200.351985920432, 16231.431899883448, 16253.024818510927, 16278.75581866273, 6085.6348619083, 6087.817365479043, 6110.450059494667, 6112.480439162632, 6120.785772497941, 3727.748483526946, 3794.6964242860504, 3828.655421012122, 3896.3181443247317, 3962.32640451124, 2838.659360876708, 2931.9120426386817, 2950.8967186148384, 2952.1733914503975, 2955.9113226603235, 488.1213815132747, 498.63599572312415, 502.412177752031, 506.44797171083695, 507.4874376879378, 486.57424753340825, 520.0638850069859, 526.0609811486478, 527.6807531443421, 541.5099335101739, 7111.964440177766, 7526.360259377905, 7566.583837888969, 7646.885296720554, 7784.299413052852, 516.5325380530626, 526.8630156159426, 530.6524226631562, 531.8112070215018, 545.2203349210666, 3388.1360253135786, 3643.544556930384, 3656.3966945453703, 3672.559292884871, 3731.570869350005, 89126.55436722774, 91976.0, 94908.0, 95146.0, 98650.50674746724, 83881.58059209787, 83966.0, 85059.57470212733, 85784.28431431337, 90500.0, 75264.24735752682, 76240.23759762332, 78146.6092669533, 78364.0, 79079.0, 6900.3444672756, 7242.782716518513, 7265.0, 7434.1450733166375, 7509.849803004018, 43051.78474107735, 44728.32907506325, 45443.54556454393, 45521.0, 45965.0, 57942.4205757937, 58194.4180558189, 64122.0, 65757.67121164555, 66395.0, 8341.499510029418, 8384.496930184208, 8394.244517993166, 8768.430052046597, 8770.824583508422, 9428.528573571431, 9600.231981441608, 9603.37578057424, 9708.902910970799, 9777.755556111155, 7448.553086814808, 9130.0, 9181.632734690538, 9639.759006024906, 11169.106471482099, 10694.786104278026, 10870.61952831647, 11162.720931976766, 11336.376499292288, 11924.821127683264, 10519.474026298501, 11044.613438529614, 11096.112311014938, 11186.216964812385, 11997.64007079789, 9582.329236953346, 9828.11546960777, 9923.255755818198, 9997.800043998934, 10236.078752912274, 9592.472414017297, 9969.40183588987, 9995.600175992879, 10047.799044019224, 10057.396556206651], "value": 6229.186049489018, "unit": "score"}], "name": "dromaeo_css", "value": 6215.309728219269, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 113.0, 118.0, 115.0, 115.0, 122.0, 115.0, 116.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 156.0, 187.0, 130.0, 151.0, 149.0, 129.0, 190.0, 120.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 161.0, 162.0, 163.0, 164.0, 162.0, 162.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 180.0, 76.0, 76.0, 76.0, 116.0, 112.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 151.0, 86.0, 87.0, 86.0, 145.0, 86.0, 86.0, 141.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 150.0, 148.0, 146.0, 146.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 67.0, 68.0, 67.0, 66.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 70.0, 66.0, 65.0, 64.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 83.0, 82.0, 93.0, 92.0, 82.0, 82.0, 82.0, 88.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 142.0, 133.0, 134.0, 132.0, 131.0, 134.0, 133.0, 159.0, 134.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 181.0, 177.0, 177.0, 178.0, 175.0, 180.0, 172.0, 172.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 69.0, 69.0, 68.0, 70.0, 68.0, 72.0, 68.0, 68.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1582.1999999999998, "alertThreshold": 2.0}]} 08:47:12 INFO - Return code: 0 08:47:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:47:12 INFO - # TBPL SUCCESS # 08:47:12 INFO - Running post-action listener: _resource_record_post_action 08:47:12 INFO - [mozharness: 2016-08-22 15:47:12.601986Z] Finished run-tests step (success) 08:47:12 INFO - Running post-run listener: _resource_record_post_run 08:47:12 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 420720640; Read time: 8; Write time: 340404 08:47:12 INFO - TinderboxPrint: CPU usage
13.3% 08:47:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:47:12 INFO - TinderboxPrint: I/O write bytes / time
420,720,640 / 340,404 08:47:12 INFO - TinderboxPrint: CPU idle
8,334.3 (86.7%) 08:47:12 INFO - TinderboxPrint: CPU user
1,209.3 (12.6%) 08:47:12 INFO - TinderboxPrint: Swap in / out
0 / 0 08:47:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 130809856; Read time: 0; Write time: 113384 08:47:12 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 289460224; Read time: 0; Write time: 226888 08:47:13 INFO - Running post-run listener: _upload_blobber_files 08:47:13 INFO - Blob upload gear active. 08:47:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:47:13 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 08:47:13 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'] 08:47:13 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 08:47:13 INFO - (blobuploader) - INFO - Open directory for files ... 08:47:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:47:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:47:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:14 INFO - (blobuploader) - INFO - Done attempting. 08:47:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:47:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:47:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:22 INFO - (blobuploader) - INFO - Done attempting. 08:47:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:47:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:47:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:23 INFO - (blobuploader) - INFO - Done attempting. 08:47:23 INFO - (blobuploader) - INFO - Iteration through files over. 08:47:23 INFO - Return code: 0 08:47:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:47:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:47:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cbbeed4c835b6a8fa9fb30d6b2dacca5a8e42484c8f1971cb136e53d98adf90608bde32d31ef031c5badfbb99a29f2bbe45e745d81421ab776f320d3bb0f1d61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d35d314697d30656649fdc03f2a9ea94edfb2531ee2ad624a2bafda079bb6a9ecc16a9ac07039471c57f91c2eafe116c78e919145c1d3384f7f3de523a394949", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06055cafad258f3b73c044a544966b8726c0e97f182c4b05bf6551f626480e7825f6ccd079a5b28bfaa181163ca30ea60db8f0b4a21e8c2739f6a298b7041525"} 08:47:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:47:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:47:23 INFO - Contents: 08:47:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cbbeed4c835b6a8fa9fb30d6b2dacca5a8e42484c8f1971cb136e53d98adf90608bde32d31ef031c5badfbb99a29f2bbe45e745d81421ab776f320d3bb0f1d61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d35d314697d30656649fdc03f2a9ea94edfb2531ee2ad624a2bafda079bb6a9ecc16a9ac07039471c57f91c2eafe116c78e919145c1d3384f7f3de523a394949", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06055cafad258f3b73c044a544966b8726c0e97f182c4b05bf6551f626480e7825f6ccd079a5b28bfaa181163ca30ea60db8f0b4a21e8c2739f6a298b7041525"} 08:47:23 INFO - Running post-run listener: copy_logs_to_upload_dir 08:47:23 INFO - Copying logs to upload dir... 08:47:23 INFO - mkdir: /builds/slave/test/build/upload/logs 08:47:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.602457 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-08-22 08:47:21.413576) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 08:47:21.417783) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704 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/cbbeed4c835b6a8fa9fb30d6b2dacca5a8e42484c8f1971cb136e53d98adf90608bde32d31ef031c5badfbb99a29f2bbe45e745d81421ab776f320d3bb0f1d61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d35d314697d30656649fdc03f2a9ea94edfb2531ee2ad624a2bafda079bb6a9ecc16a9ac07039471c57f91c2eafe116c78e919145c1d3384f7f3de523a394949", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06055cafad258f3b73c044a544966b8726c0e97f182c4b05bf6551f626480e7825f6ccd079a5b28bfaa181163ca30ea60db8f0b4a21e8c2739f6a298b7041525"} build_url:https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/do_JFcX7R4G_Vq1EqtRI8w/artifacts/public/build/firefox-51.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/cbbeed4c835b6a8fa9fb30d6b2dacca5a8e42484c8f1971cb136e53d98adf90608bde32d31ef031c5badfbb99a29f2bbe45e745d81421ab776f320d3bb0f1d61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d35d314697d30656649fdc03f2a9ea94edfb2531ee2ad624a2bafda079bb6a9ecc16a9ac07039471c57f91c2eafe116c78e919145c1d3384f7f3de523a394949", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06055cafad258f3b73c044a544966b8726c0e97f182c4b05bf6551f626480e7825f6ccd079a5b28bfaa181163ca30ea60db8f0b4a21e8c2739f6a298b7041525"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 08:47:21.445250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:47:21.445745) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1471879588.529270-1510826704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:47:21.531022) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 08:47:21.531356) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 08:47:21.531726) ========= ========= Total master_lag: 0.17 =========