builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1471504408.38 results: success (0) buildid: 20160817222415 builduid: dcf6f576d4e547ff9a98639b63032e67 revision: f5ed7f38160ed375a0ea04eb2ac847983b1da2f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:28.380304) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:28.380723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:28.380987) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:28.462347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:28.463001) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 00:13: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% 38.7M=0s 2016-08-18 00:13:29 (38.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106499 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:28.596833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:28.597102) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015405 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:28.647123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:28.647429) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f5ed7f38160ed375a0ea04eb2ac847983b1da2f1 --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 f5ed7f38160ed375a0ea04eb2ac847983b1da2f1 --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=9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 00:13:29,555 truncating revision to first 12 chars 2016-08-18 00:13:29,555 Setting DEBUG logging. 2016-08-18 00:13:29,555 attempt 1/10 2016-08-18 00:13:29,555 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f5ed7f38160e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 00:13:29,874 unpacking tar archive at: autoland-f5ed7f38160e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:29.417942) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:29.418210) ========= script_repo_revision: f5ed7f38160ed375a0ea04eb2ac847983b1da2f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:29.418582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:29.418854) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 00:13:29.429069) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-18 00:13:29.429327) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:13:30 INFO - MultiFileLogger online at 20160818 00:13:30 in /builds/slave/test 00:13: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 00:13:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:13:30 INFO - {'append_to_log': False, 00:13:30 INFO - 'base_work_dir': '/builds/slave/test', 00:13:30 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 00:13:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:13:30 INFO - 'branch': 'Autoland-Non-PGO', 00:13:30 INFO - 'buildbot_json_path': 'buildprops.json', 00:13:30 INFO - 'config_files': ('talos/linux_config.py',), 00:13:30 INFO - 'default_actions': ('clobber', 00:13:30 INFO - 'read-buildbot-config', 00:13:30 INFO - 'download-and-extract', 00:13:30 INFO - 'populate-webroot', 00:13:30 INFO - 'create-virtualenv', 00:13:30 INFO - 'install', 00:13:30 INFO - 'run-tests'), 00:13:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:13:30 INFO - 'download_minidump_stackwalk': True, 00:13:30 INFO - 'download_symbols': 'ondemand', 00:13:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:13:30 INFO - 'tooltool.py': '/tools/tooltool.py', 00:13:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:13:30 INFO - '/tools/misc-python/virtualenv.py')}, 00:13:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:13:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:13:30 INFO - 'installer_path': 'installer.exe', 00:13:30 INFO - 'log_level': 'info', 00:13:30 INFO - 'log_name': 'talos', 00:13:30 INFO - 'log_to_console': True, 00:13:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:13:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:13:30 INFO - 'opt_config_files': (), 00:13:30 INFO - 'pip_index': False, 00:13:30 INFO - 'sps_profile': False, 00:13:30 INFO - 'sps_profile_interval': 0, 00:13:30 INFO - 'suite': 'dromaeojs', 00:13:30 INFO - 'system_bits': '32', 00:13:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:13:30 INFO - 'title': 'talos-linux64-ix-022', 00:13:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:13:30 INFO - 'use_talos_json': True, 00:13:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:13:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:13:30 INFO - 'work_dir': 'build'} 00:13:30 INFO - [mozharness: 2016-08-18 07:13:30.424352Z] Running clobber step. 00:13:30 INFO - Running pre-action listener: _resource_record_pre_action 00:13:30 INFO - Running main action method: clobber 00:13:30 INFO - rmtree: /builds/slave/test/build 00:13:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:13:30 INFO - Running post-action listener: _resource_record_post_action 00:13:30 INFO - [mozharness: 2016-08-18 07:13:30.887482Z] Finished clobber step (success) 00:13:30 INFO - [mozharness: 2016-08-18 07:13:30.887582Z] Running read-buildbot-config step. 00:13:30 INFO - Running pre-action listener: _resource_record_pre_action 00:13:30 INFO - Running main action method: read_buildbot_config 00:13:30 INFO - Using buildbot properties: 00:13:30 INFO - { 00:13:30 INFO - "project": "", 00:13:30 INFO - "product": "firefox", 00:13:30 INFO - "script_repo_revision": "production", 00:13:30 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 00:13:30 INFO - "repository": "", 00:13:30 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 00:13:30 INFO - "buildid": "20160817222415", 00:13:30 INFO - "pgo_build": "False", 00:13:30 INFO - "basedir": "/builds/slave/test", 00:13:30 INFO - "buildnumber": 306, 00:13:30 INFO - "slavename": "talos-linux64-ix-022", 00:13:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:13:30 INFO - "platform": "ubuntu64_hw", 00:13:30 INFO - "scheduler": "tests-autoland-linux64-talos-7-3600", 00:13:30 INFO - "branch": "autoland", 00:13:30 INFO - "repo_path": "integration/autoland", 00:13:30 INFO - "revision": "f5ed7f38160ed375a0ea04eb2ac847983b1da2f1", 00:13:30 INFO - "stage_platform": "linux64", 00:13:30 INFO - "builduid": "dcf6f576d4e547ff9a98639b63032e67", 00:13:30 INFO - "slavebuilddir": "test" 00:13:30 INFO - } 00:13:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 00:13:30 INFO - Running post-action listener: _resource_record_post_action 00:13:30 INFO - [mozharness: 2016-08-18 07:13:30.890079Z] Finished read-buildbot-config step (success) 00:13:30 INFO - [mozharness: 2016-08-18 07:13:30.890167Z] Running download-and-extract step. 00:13:30 INFO - Running pre-action listener: _resource_record_pre_action 00:13:30 INFO - Running main action method: download_and_extract 00:13:30 INFO - mkdir: /builds/slave/test/build/tests 00:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:13:30 INFO - trying https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:13:30 INFO - Downloading https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/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 00:13:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/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 00:13:31 INFO - Downloaded 1361 bytes. 00:13:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:13:31 INFO - Using the following test package requirements: 00:13:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:13:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:13:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:13:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:31 INFO - u'jsshell-linux-x86_64.zip'], 00:13:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:13:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:13:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:13:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:13:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:13:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:13:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:13: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')]} 00:13:31 INFO - trying https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:13:31 INFO - Downloading https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/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 00:13:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/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 00:13:35 INFO - Downloaded 20317434 bytes. 00:13:35 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 00:13:39 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 00:13:39 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')]} 00:13:39 INFO - trying https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:13:39 INFO - Downloading https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/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 00:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/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 00:13:40 INFO - Downloaded 20317434 bytes. 00:13:40 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 00:13: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')]} 00:13:44 INFO - trying https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 00:13:44 INFO - Downloading https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/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 00:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/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 00:13:45 INFO - Downloaded 14413981 bytes. 00:13:45 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 00:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:13:45 INFO - trying https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:13:45 INFO - Downloading https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/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 00:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/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 00:13:46 INFO - Downloaded 55767728 bytes. 00:13:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:13:46 INFO - mkdir: /builds/slave/test/properties 00:13:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:13:46 INFO - Writing to file /builds/slave/test/properties/build_url 00:13:46 INFO - Contents: 00:13:46 INFO - build_url:https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:13:47 INFO - Running post-action listener: _resource_record_post_action 00:13:47 INFO - Running post-action listener: set_extra_try_arguments 00:13:47 INFO - [mozharness: 2016-08-18 07:13:47.622826Z] Finished download-and-extract step (success) 00:13:47 INFO - [mozharness: 2016-08-18 07:13:47.623050Z] Running populate-webroot step. 00:13:47 INFO - Running pre-action listener: _resource_record_pre_action 00:13:47 INFO - Running main action method: populate_webroot 00:13:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:13:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:13:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:13:47 INFO - '--tppagecycles', 00:13:47 INFO - '7'], 00:13:47 INFO - 'tests': ['tsvgm']}}, 00:13:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:13:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:13:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:13:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:13:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:13:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:13:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:13:47 INFO - 'talos_options': ['--disable-e10s'], 00:13:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:13:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:13:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:13:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:13:47 INFO - 'talos_options': ['--disable-e10s'], 00:13:47 INFO - 'tests': ['damp', 'tps']}, 00:13:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:13:47 INFO - 'tests': ['damp', 'tps']}, 00:13:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:13:47 INFO - 'tests': ['dromaeo_dom']}, 00:13:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:13:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:13:47 INFO - 'tests': ['basic_compositor_video']}, 00:13:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:13:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:13:47 INFO - 'tests': ['a11yr', 00:13:47 INFO - 'ts_paint', 00:13:47 INFO - 'tpaint', 00:13:47 INFO - 'sessionrestore', 00:13:47 INFO - 'sessionrestore_no_auto_restore', 00:13:47 INFO - 'tabpaint']}, 00:13:47 INFO - 'other-e10s': {'tests': ['a11yr', 00:13:47 INFO - 'ts_paint', 00:13:47 INFO - 'tpaint', 00:13:47 INFO - 'sessionrestore', 00:13:47 INFO - 'sessionrestore_no_auto_restore', 00:13:47 INFO - 'tabpaint']}, 00:13:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:13:47 INFO - 'ts_paint', 00:13:47 INFO - 'tpaint', 00:13:47 INFO - 'sessionrestore', 00:13:47 INFO - 'sessionrestore_no_auto_restore', 00:13:47 INFO - 'tabpaint']}, 00:13:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:13:47 INFO - 'ts_paint', 00:13:47 INFO - 'tpaint', 00:13:47 INFO - 'sessionrestore', 00:13:47 INFO - 'sessionrestore_no_auto_restore', 00:13:47 INFO - 'tabpaint']}, 00:13:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:13:47 INFO - 'tests': ['a11yr', 00:13:47 INFO - 'ts_paint', 00:13:47 INFO - 'tpaint', 00:13:47 INFO - 'sessionrestore', 00:13:47 INFO - 'sessionrestore_no_auto_restore', 00:13:47 INFO - 'tabpaint']}, 00:13:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:13:47 INFO - 'tests': ['a11yr', 00:13:47 INFO - 'ts_paint', 00:13:47 INFO - 'tpaint', 00:13:47 INFO - 'sessionrestore', 00:13:47 INFO - 'sessionrestore_no_auto_restore', 00:13:47 INFO - 'tabpaint']}, 00:13:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:13:47 INFO - 'tests': ['tsvgx', 00:13:47 INFO - 'tsvgr_opacity', 00:13:47 INFO - 'tart', 00:13:47 INFO - 'tscrollx', 00:13:47 INFO - 'cart']}, 00:13:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:13:47 INFO - 'tsvgr_opacity', 00:13:47 INFO - 'tart', 00:13:47 INFO - 'tscrollx', 00:13:47 INFO - 'cart']}, 00:13:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:13:47 INFO - 'talos_options': ['--disable-e10s'], 00:13:47 INFO - 'tests': ['tp5o']}, 00:13:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:13:47 INFO - 'tests': ['tp5o']}, 00:13:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:13:47 INFO - 'talos_options': ['--disable-e10s', 00:13:47 INFO - '--xperf_path', 00:13:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:13:47 INFO - 'tests': ['tp5n']}, 00:13:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:13:47 INFO - 'talos_options': ['--xperf_path', 00:13:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:13:47 INFO - 'tests': ['tp5n']}}, 00:13:47 INFO - 'talos.zip': {'path': '', 00:13:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:13:47 INFO - Running post-action listener: _resource_record_post_action 00:13:47 INFO - [mozharness: 2016-08-18 07:13:47.644878Z] Finished populate-webroot step (success) 00:13:47 INFO - [mozharness: 2016-08-18 07:13:47.644966Z] Running create-virtualenv step. 00:13:47 INFO - Running pre-action listener: _resource_record_pre_action 00:13:47 INFO - Running main action method: create_virtualenv 00:13:47 INFO - Creating virtualenv /builds/slave/test/build/venv 00:13:47 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 00:13:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:13:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:13:47 INFO - Using real prefix '/usr' 00:13:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:13:48 INFO - Installing distribute.............................................................................................................................................................................................done. 00:13:50 INFO - Installing pip.................done. 00:13:50 INFO - Return code: 0 00:13:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:13:50 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')]} 00:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:13:50 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')]} 00:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:13:50 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 0x7f22a345df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1757230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x17549b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754e40>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', '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 00:13:50 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 00:13:50 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 00:13:50 INFO - Using env: {'DISPLAY': ':0', 00:13:50 INFO - 'HOME': '/home/cltbld', 00:13:50 INFO - 'LANG': 'en_US.UTF-8', 00:13:50 INFO - 'LANGUAGE': 'en_US:en', 00:13:50 INFO - 'LOGNAME': 'cltbld', 00:13:50 INFO - 'MAIL': '/var/mail/cltbld', 00:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:13:50 INFO - 'MOZ_NO_REMOTE': '1', 00:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:13:50 INFO - 'NO_EM_RESTART': '1', 00:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:13:50 INFO - 'PWD': '/builds/slave/test', 00:13:50 INFO - 'SHELL': '/bin/bash', 00:13:50 INFO - 'SHLVL': '1', 00:13:50 INFO - 'TERM': 'linux', 00:13:50 INFO - 'TMOUT': '86400', 00:13:50 INFO - 'USER': 'cltbld', 00:13:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', 00:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:13:50 INFO - '_': '/tools/buildbot/bin/python'} 00:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:13:50 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 00:13:50 INFO - Cleaning up... 00:13:50 INFO - Return code: 0 00:13:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:13:50 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')]} 00:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:13:50 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')]} 00:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:13:50 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 0x7f22a345df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1757230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x17549b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754e40>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', '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 00:13:50 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 00:13:50 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 00:13:50 INFO - Using env: {'DISPLAY': ':0', 00:13:50 INFO - 'HOME': '/home/cltbld', 00:13:50 INFO - 'LANG': 'en_US.UTF-8', 00:13:50 INFO - 'LANGUAGE': 'en_US:en', 00:13:50 INFO - 'LOGNAME': 'cltbld', 00:13:50 INFO - 'MAIL': '/var/mail/cltbld', 00:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:13:50 INFO - 'MOZ_NO_REMOTE': '1', 00:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:13:50 INFO - 'NO_EM_RESTART': '1', 00:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:13:50 INFO - 'PWD': '/builds/slave/test', 00:13:50 INFO - 'SHELL': '/bin/bash', 00:13:50 INFO - 'SHLVL': '1', 00:13:50 INFO - 'TERM': 'linux', 00:13:50 INFO - 'TMOUT': '86400', 00:13:50 INFO - 'USER': 'cltbld', 00:13:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', 00:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:13:50 INFO - '_': '/tools/buildbot/bin/python'} 00:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:13:50 INFO - Downloading/unpacking psutil>=3.1.1 00:13:50 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 00:13:50 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 00:13:50 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 00:13:50 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 00:13:50 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 00:13:50 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 00:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:13:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:13:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:13:52 INFO - Installing collected packages: psutil 00:13:52 INFO - Running setup.py install for psutil 00:13:52 INFO - building 'psutil._psutil_linux' extension 00:13:52 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 00:13:52 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 00:13:52 INFO - building 'psutil._psutil_posix' extension 00:13:52 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 00:13:53 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 00:13:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:13:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:13:53 INFO - Successfully installed psutil 00:13:53 INFO - Cleaning up... 00:13:53 INFO - Return code: 0 00:13:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:13: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')]} 00:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:13: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')]} 00:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:13: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f22a345df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1757230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x17549b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754e40>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', '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 00:13: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:13: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 mozsystemmonitor==0.3 00:13:53 INFO - Using env: {'DISPLAY': ':0', 00:13:53 INFO - 'HOME': '/home/cltbld', 00:13:53 INFO - 'LANG': 'en_US.UTF-8', 00:13:53 INFO - 'LANGUAGE': 'en_US:en', 00:13:53 INFO - 'LOGNAME': 'cltbld', 00:13:53 INFO - 'MAIL': '/var/mail/cltbld', 00:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:13:53 INFO - 'MOZ_NO_REMOTE': '1', 00:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:13:53 INFO - 'NO_EM_RESTART': '1', 00:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:13:53 INFO - 'PWD': '/builds/slave/test', 00:13:53 INFO - 'SHELL': '/bin/bash', 00:13:53 INFO - 'SHLVL': '1', 00:13:53 INFO - 'TERM': 'linux', 00:13:53 INFO - 'TMOUT': '86400', 00:13:53 INFO - 'USER': 'cltbld', 00:13:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', 00:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:13:53 INFO - '_': '/tools/buildbot/bin/python'} 00:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:13:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:13: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 00:13: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 00:13: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 00:13: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 00:13: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 00:13: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 00:13:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:13:55 INFO - Installing collected packages: mozsystemmonitor 00:13:55 INFO - Running setup.py install for mozsystemmonitor 00:13:55 INFO - Successfully installed mozsystemmonitor 00:13:55 INFO - Cleaning up... 00:13:55 INFO - Return code: 0 00:13:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:13:55 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')]} 00:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:13:55 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')]} 00:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:13:55 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 0x7f22a345df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1757230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x17549b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754e40>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', '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 00:13:55 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 00:13:55 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 00:13:55 INFO - Using env: {'DISPLAY': ':0', 00:13:55 INFO - 'HOME': '/home/cltbld', 00:13:55 INFO - 'LANG': 'en_US.UTF-8', 00:13:55 INFO - 'LANGUAGE': 'en_US:en', 00:13:55 INFO - 'LOGNAME': 'cltbld', 00:13:55 INFO - 'MAIL': '/var/mail/cltbld', 00:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:13:55 INFO - 'MOZ_NO_REMOTE': '1', 00:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:13:55 INFO - 'NO_EM_RESTART': '1', 00:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:13:55 INFO - 'PWD': '/builds/slave/test', 00:13:55 INFO - 'SHELL': '/bin/bash', 00:13:55 INFO - 'SHLVL': '1', 00:13:55 INFO - 'TERM': 'linux', 00:13:55 INFO - 'TMOUT': '86400', 00:13:55 INFO - 'USER': 'cltbld', 00:13:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', 00:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:13:55 INFO - '_': '/tools/buildbot/bin/python'} 00:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:13:55 INFO - Downloading/unpacking jsonschema==2.5.1 00:13: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 00:13: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 00:13: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 00:13: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 00:13: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 00:13: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 00:13:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:13:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:13:57 INFO - Downloading functools32-3.2.3-2.tar.gz 00:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:13:57 INFO - warning: no files found matching '*.txt' 00:13:57 INFO - no previously-included directories found matching 'build' 00:13:57 INFO - no previously-included directories found matching 'dist' 00:13:57 INFO - no previously-included directories found matching '.git*' 00:13:57 INFO - Installing collected packages: jsonschema, functools32 00:13:57 INFO - Running setup.py install for functools32 00:13:57 INFO - warning: no files found matching '*.txt' 00:13:57 INFO - no previously-included directories found matching 'build' 00:13:57 INFO - no previously-included directories found matching 'dist' 00:13:57 INFO - no previously-included directories found matching '.git*' 00:13:57 INFO - Successfully installed jsonschema functools32 00:13:57 INFO - Cleaning up... 00:13:58 INFO - Return code: 0 00:13:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:13:58 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')]} 00:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:13:58 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')]} 00:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:13:58 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 0x7f22a345df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1757230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x17549b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754e40>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', '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 00:13:58 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 00:13:58 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 00:13:58 INFO - Using env: {'DISPLAY': ':0', 00:13:58 INFO - 'HOME': '/home/cltbld', 00:13:58 INFO - 'LANG': 'en_US.UTF-8', 00:13:58 INFO - 'LANGUAGE': 'en_US:en', 00:13:58 INFO - 'LOGNAME': 'cltbld', 00:13:58 INFO - 'MAIL': '/var/mail/cltbld', 00:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:13:58 INFO - 'MOZ_NO_REMOTE': '1', 00:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:13:58 INFO - 'NO_EM_RESTART': '1', 00:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:13:58 INFO - 'PWD': '/builds/slave/test', 00:13:58 INFO - 'SHELL': '/bin/bash', 00:13:58 INFO - 'SHLVL': '1', 00:13:58 INFO - 'TERM': 'linux', 00:13:58 INFO - 'TMOUT': '86400', 00:13:58 INFO - 'USER': 'cltbld', 00:13:58 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', 00:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:13:58 INFO - '_': '/tools/buildbot/bin/python'} 00:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:13:58 INFO - Cleaning up... 00:13:58 INFO - Return code: 0 00:13:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:13:58 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')]} 00:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:13:58 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')]} 00:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:13:58 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 0x7f22a345df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1757230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x17549b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754e40>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', '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 00:13:58 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 00:13:58 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 00:13:58 INFO - Using env: {'DISPLAY': ':0', 00:13:58 INFO - 'HOME': '/home/cltbld', 00:13:58 INFO - 'LANG': 'en_US.UTF-8', 00:13:58 INFO - 'LANGUAGE': 'en_US:en', 00:13:58 INFO - 'LOGNAME': 'cltbld', 00:13:58 INFO - 'MAIL': '/var/mail/cltbld', 00:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:13:58 INFO - 'MOZ_NO_REMOTE': '1', 00:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:13:58 INFO - 'NO_EM_RESTART': '1', 00:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:13:58 INFO - 'PWD': '/builds/slave/test', 00:13:58 INFO - 'SHELL': '/bin/bash', 00:13:58 INFO - 'SHLVL': '1', 00:13:58 INFO - 'TERM': 'linux', 00:13:58 INFO - 'TMOUT': '86400', 00:13:58 INFO - 'USER': 'cltbld', 00:13:58 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', 00:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:13:58 INFO - '_': '/tools/buildbot/bin/python'} 00:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:13:58 INFO - Downloading/unpacking blobuploader==1.2.4 00:13: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 00:13: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 00:13: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 00:13: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 00:13: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 00:13: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 00:14:00 INFO - Downloading blobuploader-1.2.4.tar.gz 00:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:14:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:14:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:01 INFO - Downloading docopt-0.6.1.tar.gz 00:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:14:01 INFO - Installing collected packages: blobuploader, requests, docopt 00:14:01 INFO - Running setup.py install for blobuploader 00:14:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:14:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:14:01 INFO - Running setup.py install for requests 00:14:01 INFO - Running setup.py install for docopt 00:14:01 INFO - Successfully installed blobuploader requests docopt 00:14:01 INFO - Cleaning up... 00:14:01 INFO - Return code: 0 00:14:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:01 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 0x7f22a345df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1757230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x17549b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754e40>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', '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 00:14:01 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 00:14:01 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 00:14:01 INFO - Using env: {'DISPLAY': ':0', 00:14:01 INFO - 'HOME': '/home/cltbld', 00:14:01 INFO - 'LANG': 'en_US.UTF-8', 00:14:01 INFO - 'LANGUAGE': 'en_US:en', 00:14:01 INFO - 'LOGNAME': 'cltbld', 00:14:01 INFO - 'MAIL': '/var/mail/cltbld', 00:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:01 INFO - 'MOZ_NO_REMOTE': '1', 00:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:01 INFO - 'NO_EM_RESTART': '1', 00:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:01 INFO - 'PWD': '/builds/slave/test', 00:14:01 INFO - 'SHELL': '/bin/bash', 00:14:01 INFO - 'SHLVL': '1', 00:14:01 INFO - 'TERM': 'linux', 00:14:01 INFO - 'TMOUT': '86400', 00:14:01 INFO - 'USER': 'cltbld', 00:14:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', 00:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:01 INFO - '_': '/tools/buildbot/bin/python'} 00:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:14:01 INFO - Running setup.py (path:/tmp/pip-Mw6rF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:14:02 INFO - Running setup.py (path:/tmp/pip-keCZtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:14:02 INFO - Running setup.py (path:/tmp/pip-0U2VQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:14:02 INFO - Running setup.py (path:/tmp/pip-WYEkF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:14:02 INFO - Running setup.py (path:/tmp/pip-C7lbS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:14:02 INFO - Running setup.py (path:/tmp/pip-ISBq_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:14:02 INFO - Running setup.py (path:/tmp/pip-hpda1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:14:02 INFO - Running setup.py (path:/tmp/pip-mpYdd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:14:02 INFO - Running setup.py (path:/tmp/pip-Ufwl5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:14:02 INFO - Running setup.py (path:/tmp/pip-ozt88E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:14:02 INFO - Running setup.py (path:/tmp/pip-fs0mdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:14:02 INFO - Running setup.py (path:/tmp/pip-cJhL0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:14:02 INFO - Running setup.py (path:/tmp/pip-uzogIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:14:02 INFO - Running setup.py (path:/tmp/pip-r_rzG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:14:03 INFO - Running setup.py (path:/tmp/pip-dSPa4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:14:03 INFO - Running setup.py (path:/tmp/pip-KOmZDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:14:03 INFO - Running setup.py (path:/tmp/pip-q3qJ2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:14:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:14:03 INFO - Running setup.py install for manifestparser 00:14:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:14:03 INFO - Running setup.py install for mozcrash 00:14:03 INFO - Running setup.py install for mozdebug 00:14:03 INFO - Running setup.py install for mozdevice 00:14:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:14:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:14:03 INFO - Running setup.py install for mozfile 00:14:03 INFO - Running setup.py install for mozhttpd 00:14:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:14:03 INFO - Running setup.py install for mozinfo 00:14:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:14:03 INFO - Running setup.py install for mozInstall 00:14:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:14:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:14:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:14:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:14:04 INFO - Running setup.py install for mozleak 00:14:04 INFO - Running setup.py install for mozlog 00:14:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:14:04 INFO - Running setup.py install for moznetwork 00:14:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:14:04 INFO - Running setup.py install for mozprocess 00:14:04 INFO - Running setup.py install for mozprofile 00:14:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:14:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:14:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:14:04 INFO - Running setup.py install for mozrunner 00:14:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:14:04 INFO - Running setup.py install for mozscreenshot 00:14:04 INFO - Running setup.py install for moztest 00:14:04 INFO - Running setup.py install for mozversion 00:14:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:14:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:14:05 INFO - Cleaning up... 00:14:05 INFO - Return code: 0 00:14:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:14:05 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')]} 00:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:05 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')]} 00:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:05 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 0x7f22a345df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1757230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x17549b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754e40>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', '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 00:14:05 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 00:14:05 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 00:14:05 INFO - Using env: {'DISPLAY': ':0', 00:14:05 INFO - 'HOME': '/home/cltbld', 00:14:05 INFO - 'LANG': 'en_US.UTF-8', 00:14:05 INFO - 'LANGUAGE': 'en_US:en', 00:14:05 INFO - 'LOGNAME': 'cltbld', 00:14:05 INFO - 'MAIL': '/var/mail/cltbld', 00:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:05 INFO - 'MOZ_NO_REMOTE': '1', 00:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:05 INFO - 'NO_EM_RESTART': '1', 00:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:05 INFO - 'PWD': '/builds/slave/test', 00:14:05 INFO - 'SHELL': '/bin/bash', 00:14:05 INFO - 'SHLVL': '1', 00:14:05 INFO - 'TERM': 'linux', 00:14:05 INFO - 'TMOUT': '86400', 00:14:05 INFO - 'USER': 'cltbld', 00:14:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', 00:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:05 INFO - '_': '/tools/buildbot/bin/python'} 00:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:14:05 INFO - Running setup.py (path:/tmp/pip-0raXGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:14:05 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)) 00:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:14:05 INFO - Running setup.py (path:/tmp/pip-gKkoeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:14:05 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)) 00:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:14:05 INFO - Running setup.py (path:/tmp/pip-DNDe53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:14:05 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)) 00:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:14:05 INFO - Running setup.py (path:/tmp/pip-Rc6Xhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:14:05 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)) 00:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:14:05 INFO - Running setup.py (path:/tmp/pip-O4hBeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:14:05 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)) 00:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:14:05 INFO - Running setup.py (path:/tmp/pip-ae99tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:14:05 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)) 00:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:14:05 INFO - Running setup.py (path:/tmp/pip-oz2IWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:14:05 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)) 00:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:14:05 INFO - Running setup.py (path:/tmp/pip-3fOxiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:14:05 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)) 00:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:14:05 INFO - Running setup.py (path:/tmp/pip-MkfdhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:14:05 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)) 00:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:14:05 INFO - Running setup.py (path:/tmp/pip-HQ94MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:14:05 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)) 00:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:14:05 INFO - Running setup.py (path:/tmp/pip-PzaqqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:14:06 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)) 00:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:14:06 INFO - Running setup.py (path:/tmp/pip-17w5Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:14:06 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)) 00:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:14:06 INFO - Running setup.py (path:/tmp/pip-HkxdBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:14:06 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)) 00:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:14:06 INFO - Running setup.py (path:/tmp/pip-Ir3hNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:14:06 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)) 00:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:14:06 INFO - Running setup.py (path:/tmp/pip-REEnCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:14:06 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)) 00:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:14:06 INFO - Running setup.py (path:/tmp/pip-iBqWsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:14:06 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)) 00:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:14:06 INFO - Running setup.py (path:/tmp/pip-yGbYxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:14:06 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)) 00:14:06 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)) 00:14:06 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)) 00:14:06 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)) 00:14:06 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)) 00:14:06 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)) 00:14:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:08 INFO - Downloading blessings-1.6.tar.gz 00:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:14:08 INFO - Installing collected packages: blessings 00:14:08 INFO - Running setup.py install for blessings 00:14:08 INFO - Successfully installed blessings 00:14:08 INFO - Cleaning up... 00:14:08 INFO - Return code: 0 00:14:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:14:08 INFO - Reading from file tmpfile_stdout 00:14:08 INFO - Current package versions: 00:14:08 INFO - argparse == 1.2.1 00:14:08 INFO - blessings == 1.6 00:14:08 INFO - blobuploader == 1.2.4 00:14:08 INFO - docopt == 0.6.1 00:14:08 INFO - functools32 == 3.2.3-2 00:14:08 INFO - jsonschema == 2.5.1 00:14:08 INFO - manifestparser == 1.1 00:14:08 INFO - mozInstall == 1.12 00:14:08 INFO - mozcrash == 0.17 00:14:08 INFO - mozdebug == 0.1 00:14:08 INFO - mozdevice == 0.48 00:14:08 INFO - mozfile == 1.2 00:14:08 INFO - mozhttpd == 0.7 00:14:08 INFO - mozinfo == 0.9 00:14:08 INFO - mozleak == 0.1 00:14:08 INFO - mozlog == 3.3 00:14:08 INFO - moznetwork == 0.27 00:14:08 INFO - mozprocess == 0.23 00:14:08 INFO - mozprofile == 0.28 00:14:08 INFO - mozrunner == 6.12 00:14:08 INFO - mozscreenshot == 0.1 00:14:08 INFO - mozsystemmonitor == 0.3 00:14:08 INFO - moztest == 0.7 00:14:08 INFO - mozversion == 1.4 00:14:08 INFO - psutil == 3.1.1 00:14:08 INFO - requests == 1.2.3 00:14:08 INFO - wsgiref == 0.1.2 00:14:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:14:08 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')]} 00:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:08 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')]} 00:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:08 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 0x7f22a345df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1757230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x17549b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754e40>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', '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 00:14:08 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 00:14:08 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 00:14:08 INFO - Using env: {'DISPLAY': ':0', 00:14:08 INFO - 'HOME': '/home/cltbld', 00:14:08 INFO - 'LANG': 'en_US.UTF-8', 00:14:08 INFO - 'LANGUAGE': 'en_US:en', 00:14:08 INFO - 'LOGNAME': 'cltbld', 00:14:08 INFO - 'MAIL': '/var/mail/cltbld', 00:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:08 INFO - 'MOZ_NO_REMOTE': '1', 00:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:08 INFO - 'NO_EM_RESTART': '1', 00:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:08 INFO - 'PWD': '/builds/slave/test', 00:14:08 INFO - 'SHELL': '/bin/bash', 00:14:08 INFO - 'SHLVL': '1', 00:14:08 INFO - 'TERM': 'linux', 00:14:08 INFO - 'TMOUT': '86400', 00:14:08 INFO - 'USER': 'cltbld', 00:14:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', 00:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:08 INFO - '_': '/tools/buildbot/bin/python'} 00:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:09 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)) 00:14:09 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)) 00:14:09 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)) 00:14:09 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)) 00:14:09 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)) 00:14:09 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)) 00:14:09 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)) 00:14:09 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)) 00:14:09 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)) 00:14:09 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)) 00:14:09 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)) 00:14:09 INFO - Cleaning up... 00:14:09 INFO - Return code: 0 00:14:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f22a345df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1757230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x17549b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754e40>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', '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 00:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:14:09 INFO - Using env: {'DISPLAY': ':0', 00:14:09 INFO - 'HOME': '/home/cltbld', 00:14:09 INFO - 'LANG': 'en_US.UTF-8', 00:14:09 INFO - 'LANGUAGE': 'en_US:en', 00:14:09 INFO - 'LOGNAME': 'cltbld', 00:14:09 INFO - 'MAIL': '/var/mail/cltbld', 00:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:09 INFO - 'MOZ_NO_REMOTE': '1', 00:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:09 INFO - 'NO_EM_RESTART': '1', 00:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:09 INFO - 'PWD': '/builds/slave/test', 00:14:09 INFO - 'SHELL': '/bin/bash', 00:14:09 INFO - 'SHLVL': '1', 00:14:09 INFO - 'TERM': 'linux', 00:14:09 INFO - 'TMOUT': '86400', 00:14:09 INFO - 'USER': 'cltbld', 00:14:09 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', 00:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:09 INFO - '_': '/tools/buildbot/bin/python'} 00:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:14:09 INFO - Cleaning up... 00:14:09 INFO - Return code: 0 00:14:09 INFO - Running post-action listener: _resource_record_post_action 00:14:09 INFO - Running post-action listener: _start_resource_monitoring 00:14:09 INFO - Starting resource monitoring. 00:14:09 INFO - [mozharness: 2016-08-18 07:14:09.360681Z] Finished create-virtualenv step (success) 00:14:09 INFO - [mozharness: 2016-08-18 07:14:09.361140Z] Running install step. 00:14:09 INFO - Running pre-action listener: _resource_record_pre_action 00:14:09 INFO - Running main action method: install 00:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:14:09 INFO - Reading from file tmpfile_stdout 00:14:09 INFO - Detecting whether we're running mozinstall >=1.0... 00:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:14:09 INFO - Reading from file tmpfile_stdout 00:14:09 INFO - Output received: 00:14:09 INFO - Usage: mozinstall [options] installer 00:14:09 INFO - Options: 00:14:09 INFO - -h, --help show this help message and exit 00:14:09 INFO - -d DEST, --destination=DEST 00:14:09 INFO - Directory to install application into. [default: 00:14:09 INFO - "/builds/slave/test"] 00:14:09 INFO - --app=APP Application being installed. [default: firefox] 00:14:09 INFO - mkdir: /builds/slave/test/build/application 00:14:09 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'] 00:14:09 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 00:14:25 INFO - Reading from file tmpfile_stdout 00:14:25 INFO - Output received: 00:14:25 INFO - /builds/slave/test/build/application/firefox/firefox 00:14:25 INFO - Running post-action listener: _resource_record_post_action 00:14:25 INFO - [mozharness: 2016-08-18 07:14:25.765686Z] Finished install step (success) 00:14:25 INFO - [mozharness: 2016-08-18 07:14:25.765933Z] Running run-tests step. 00:14:25 INFO - Running pre-action listener: _resource_record_pre_action 00:14:25 INFO - Running main action method: run_tests 00:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:14:25 INFO - Python 2.7.3 00:14:25 INFO - Return code: 0 00:14:25 INFO - grabbing minidump binary from tooltool 00:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x17549b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:14:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:14:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:14:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:14:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:14:25 INFO - Return code: 0 00:14:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:14:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:14:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:14:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:14:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:14:25 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/ZieEt-DnQDWVNDNOOkmguQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 00:14:25 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/ZieEt-DnQDWVNDNOOkmguQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 00:14:25 INFO - Using env: {'DISPLAY': ':0', 00:14:25 INFO - 'HOME': '/home/cltbld', 00:14:25 INFO - 'LANG': 'en_US.UTF-8', 00:14:25 INFO - 'LANGUAGE': 'en_US:en', 00:14:25 INFO - 'LOGNAME': 'cltbld', 00:14:25 INFO - 'MAIL': '/var/mail/cltbld', 00:14:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:14:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:25 INFO - 'MOZ_NO_REMOTE': '1', 00:14:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:25 INFO - 'NO_EM_RESTART': '1', 00:14:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:25 INFO - 'PWD': '/builds/slave/test', 00:14:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:14:25 INFO - 'SHELL': '/bin/bash', 00:14:25 INFO - 'SHLVL': '1', 00:14:25 INFO - 'TERM': 'linux', 00:14:25 INFO - 'TMOUT': '86400', 00:14:25 INFO - 'USER': 'cltbld', 00:14:25 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794', 00:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:25 INFO - '_': '/tools/buildbot/bin/python'} 00:14:25 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/ZieEt-DnQDWVNDNOOkmguQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 00:14:26 INFO - mozversion application_buildid: 20160817222415 00:14:26 INFO - mozversion application_changeset: f5ed7f38160ed375a0ea04eb2ac847983b1da2f1 00:14:26 INFO - mozversion application_display_name: Nightly 00:14:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:14:26 INFO - mozversion application_name: Firefox 00:14:26 INFO - mozversion application_remotingname: firefox 00:14:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:14:26 INFO - mozversion application_vendor: Mozilla 00:14:26 INFO - mozversion application_version: 51.0a1 00:14:26 INFO - mozversion platform_buildid: 20160817222415 00:14:26 INFO - mozversion platform_changeset: f5ed7f38160ed375a0ea04eb2ac847983b1da2f1 00:14:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:14:26 INFO - mozversion platform_version: 51.0a1 00:14:26 INFO - using testdate: 1471504466 00:14:26 INFO - actual date: 1471504466 00:14:26 INFO - starting webserver on 'localhost:36483' 00:14:26 INFO - SUITE-START | Running 2 tests 00:14:26 INFO - TEST-START | dromaeo_css 00:14:26 INFO - operating with platform_type : linux_ 00:14:26 INFO - Initialising browser for dromaeo_css test... 00:14:26 INFO - TEST-INFO | started process 23282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKyfGuu/profile http://localhost:36483/getInfo.html) 00:14:30 INFO - PROCESS | 23282 | __metrics Screen width/height:1600/1200 00:14:30 INFO - PROCESS | 23282 | colorDepth:24 00:14:30 INFO - PROCESS | 23282 | Browser inner width/height: 1024/697 00:14:30 INFO - PROCESS | 23282 | __metrics 00:14:31 INFO - PROCESS | 23282 | 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" 00:14:31 INFO - PROCESS | 23282 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:14:31 INFO - PROCESS | 23282 | console.error: PushService: 00:14:31 INFO - PROCESS | 23282 | stateChangeProcessEnqueue: Error transitioning state 00:14:31 INFO - PROCESS | 23282 | UnknownError 00:14:32 INFO - TEST-INFO | 23282: exit 0 00:14:32 INFO - Browser initialized. 00:14:32 INFO - Running cycle 1/1 for dromaeo_css test... 00:14:32 INFO - TEST-INFO | started process 23363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKyfGuu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:14:44 INFO - PROCESS | 23363 | RSS: Main: 157519872 00:14:44 INFO - PROCESS | 23363 | 00:15:34 INFO - PROCESS | 23363 | 1471504534932 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] 00:17:48 INFO - PROCESS | 23363 | Cycle 1(1): loaded http://localhost:36483/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36483/tests/dromaeo/cssquery-ext.html) 00:17:49 INFO - PROCESS | 23363 | RSS: Main: 229580800 00:17:49 INFO - PROCESS | 23363 | 00:20:51 INFO - PROCESS | 23363 | Cycle 1(1): loaded http://localhost:36483/tests/dromaeo/cssquery-ext.html (next: http://localhost:36483/tests/dromaeo/cssquery-jquery.html) 00:20:52 INFO - PROCESS | 23363 | RSS: Main: 245981184 00:20:52 INFO - PROCESS | 23363 | 00:23:54 INFO - PROCESS | 23363 | Cycle 1(1): loaded http://localhost:36483/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36483/tests/dromaeo/cssquery-mootools.html) 00:23:55 INFO - PROCESS | 23363 | RSS: Main: 189157376 00:23:55 INFO - PROCESS | 23363 | 00:26:57 INFO - PROCESS | 23363 | Cycle 1(1): loaded http://localhost:36483/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36483/tests/dromaeo/cssquery-prototype.html) 00:26:58 INFO - PROCESS | 23363 | RSS: Main: 202563584 00:26:58 INFO - PROCESS | 23363 | 00:30:01 INFO - PROCESS | 23363 | Cycle 1(1): loaded http://localhost:36483/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36483/tests/dromaeo/cssquery-yui.html) 00:30:01 INFO - PROCESS | 23363 | RSS: Main: 190091264 00:30:01 INFO - PROCESS | 23363 | 00:33:04 INFO - PROCESS | 23363 | Cycle 1(1): loaded http://localhost:36483/tests/dromaeo/cssquery-yui.html (next: http://localhost:36483/tests/dromaeo/cssquery-dojo.html) 00:33:05 INFO - PROCESS | 23363 | RSS: Main: 272916480 00:33:05 INFO - PROCESS | 23363 | 00:33:05 INFO - PROCESS | 23363 | __start_tp_report 00:33:05 INFO - PROCESS | 23363 | _x_x_mozilla_page_load 00:33:05 INFO - PROCESS | 23363 | _x_x_mozilla_page_load_details 00:33:05 INFO - PROCESS | 23363 | |i|pagename|runs| 00:33:05 INFO - PROCESS | 23363 | |0;dojo.html;2588.4564241509283;2590.948181036378;2618.2537976676645;2638.656974593304;2643.193825883105;4550.63594912407;4612.492625811158;4673.065386922616;4693.202155633542;4709.576138147566;4573.908521829561;4626.4910859805395;4635.953640463595;4661.394018777562;4730.432348118222;4224.8732538023905;4251.5323314435545;4297.312430011199;4321.459817522809;4412.40432541606;4301.053768171013;4354.433923589929;4422.447194100738;4454.465464144308;4457.33140028995;4300.290452075404;4343.67422443318;4346.500152482457;4364.236258654739;4388.319810429372;4158.521769996459;4212.957870421287;4215.093754842724;4233.534311225762;4287.571242875719;4195.181939521794;4201.012762000958;4231.407602935591;4241.024564350186;4350.912981740347;4612.838550650745;4617.284320930227;4643.117807616576;4662;4664.160451118797;4818.084563932876;4954.355933728628;4959.057779021974;4990.87522811929;4996.475370086125;5042.697438153723;5051.090803655341;5053.317802096707;5091.261767043795;5094.032133894548;4712.034033023257;4723.149833030019;4761.047790441856;4769.546893045155;4771.5467030632035;4951.801927922915;5084.923726144111;5135.717535535507;5148.665336753099;5208.7916483341;4919.803207871645;4974.030064137531;4976.129177393942;4987.875303117451;4990.850274491771;5027.321311622884;5031.974840125849;5034.395872495324;5034.84895453137;5091.338126043591;4797.520247975174;4886.120498310267;4950.801967921243;4957.256411538298;4958.206686930146;4928.8767780805765;4969.403671559436;4971.502849715;4975.0796102721115;5001.42483614389;4252.638525725286;4268.530461649216;4270.338097594878;4272.081502476983;4305.07440900208;3652.5251717277115;3681.171736359351;3684.428913518409;3722.2555488901785;3766.2655782122224;4315.956840431619;4333.220020396296;4366.257736184856;4375.78121093944;4377.365282034088;5029.170186919117;5030.446650868402;5031.572316353151;5031.672941258879;5056.544910958031;4177.916441671149;4208.305629571087;4250.957490425056;4308.784560771949;4356.564343565618;4418.977905110454;4434.955650443519;4469.597736203757;4484.304932735431;4485.730856148576;4622.2835460503675;4628;4636.83771068011;4639.234526303189;4672.906541869075;4845.466998630078;4915.926261106015;4920.827771027997;4933.210686290176;5002.599792016557;4723.763811809327;4736.976315118402;4744.4069491313585;4764.857054288377;4780.521947805191;4920.31115643803;4946.109700253989;4952.479989601185;4956.058348913695;4975.6517043808035;4785.545373189541;4970.726610036482;5025.47232540578;5045.974770126126;5058.494150585059;4903.485134061015;4920.8769780755765;4921.212605983025;4944.258361245842;4970.950290497193;4868.853934381974;4895.755212239303;4896.853094407174;4896.902061958812;4958.479359667183;4617.2612382018715;4668.11305851887;4739.146953548395;4826.903461930812;4862.6839255448285;4856.927146092741;4908.190148625436;4913.115639184981;4937.851864444073;4954.529319714766;4798.760061996956;4810.326554282333;4813.205821039489;4815.759212039314;4857.708537487762 00:33:05 INFO - PROCESS | 23363 | |1;ext.html;565.0873838750418;580.5790801668791;588.0620410445338;590.4656286061113;591.5208680968416;28181;30513.542296865537;30520;39258.60741392585;40651.59348406515;39401.40897886534;39832.800835995855;39835.203295934065;39891;39899.40150897739;7655.617219139049;7805.492642978188;7806.804829879242;7810.258025487569;7810.336121429686;7657.310842024217;7737.342325902305;7739.651715672809;7743.032120984877;7744.070711514598;7756.6509507072315;7794.571298578576;7809.101953275389;7815.882761758578;7816.491928024689;7715.6913723451;7751.612419379008;7753.457257991943;7757.650905709256;7758.844823103506;7714.035745531809;7791;7793.61031948406;7795.961020194919;7797.337226335769;37130.443043354375;37518;37567.62432375669;37579.81210093959;37581.43627845585;3111.4088323218516;3145.622525296956;3165.683431656839;3372.971243770649;3536.5756109267054;28539.85730071357;28769.856150719323;28785.42429151426;28846.567301490286;30170.547441788392;3379.9831000845084;3459.6540345965454;3472.9826350868084;3474.722022238215;3549.7337699672626;252086;253345;254354;254431.99999999814;255259;50335;50549.74725126351;50576.74711626418;50678.239826402634;50767.23849142266;32567.348653027282;33423.498647520304;33479.66520334766;35262.47106293408;35315.64684353175;13268.40292186854;13438.529651462151;13447.394867230998;13485.66285842842;13504.864951350557;9658.661946831828;9694.90305096954;9695.951520242354;9753.463559504153;9767;17185.484435466955;17243.568910777332;17254.827451725574;17362.13189340528;17409;6561.835954101186;6607.075009498674;6683.465322774166;6712.160979877515;6846.178458585002;769.9191584883619;877.0790669796688;895.8790563273875;920.4339331311195;970.2736250748048;25747;26345.604815927778;26691.33271668185;26738.465230695667;26836.46327073487;742.5693098003145;895.5611750242334;901.963921443148;905.714699869539;960.0975083421562;14391.712165756626;15160;15260.847391526164;15444.227788610524;16036.358545658277;194607;196306;196678;197219;368022;50156.24765628519;50523.48429547119;50645.49354506481;50712.23931641028;50743.74628126836;1100.7303210713267;1143.0455569599312;1148.190525679394;1151.9078473722082;1153.411760002405;27404.177874663794;28129.296767580974;29167.270818229714;29263.653699656054;29326;42022.78988605038;42833;42873.35689964715;42890.2843886241;42898.14203715846;342776;343225;343708;344451;345266;24868.253952381456;24986.500269994864;25296.367590810376;25403.110891118722;25422.491550168525;40615.3907691379;40764;40855.1828963425;41129.588704112575;41249.79375103105;34796.47805282872;34847.9545613632;34971;35605;35623.64376356203;34440.383759705874;34510.309793803484;34553.654463455045;35487.645123548435;35659.108522286115;34059.14852128716;34209.31581368409;36508;37173.25653486861;37233.25533489369;30034.84982575073;31725;32788.67211327856;32922.83538582292;32939.50590741093;24111;24121;24289.39276518101;24871.751282486945;24939.251822445356 00:33:05 INFO - PROCESS | 23363 | |2;jquery.html;346.99653003469956;365.5832351119722;366.30950658009647;369.11596725841616;389.4158761857214;12812.679683007918;16046.679066418665;16060.678786424265;16593;17569.736453953203;15874.682506349865;16118.516444506684;16351.83648163518;16608.83391166088;16701.081440520797;5018.146915024437;5221.190715439113;5258.6318957672975;5472.644278121929;5517.668939863621;3454.998050565333;5543.362513310981;5575.776968921238;5580.804671836487;5820.9708951455395;6126.632402055869;6155.230596175478;6157.6305421674615;6160.1375807387;6164.506839452833;5929.258842644669;6049.183360246355;6077.726502307407;6079.787207447718;6141.263048434194;5422.403535611119;5429.669730915951;5429.864253393657;5434.184872269191;5437.972810135924;12742.108052436333;17689.646207075915;18785.906070469697;21153;21223.5755284895;1723.4140392266563;1839.3930003098944;1903.7810651775085;1903.9528259457243;2119.2158901206653;9065.864012039825;9172.312076594215;9228.307876909192;9289.349745517817;9562.378445401097;1653.1475491415774;1663.534210421084;1727.196853463133;1756.771619689432;1767.6818172728904;47239.291410628866;62633.373666263666;64246.67876660633;64705.676471617815;72321.63839180823;8877.467351958903;8973;9049;9079.182873541413;10070.949645251727;11958.940205299092;12008.519659213709;12025.158238923366;12030.39848007596;12043.337616431181;6842.794716158523;6960.79117626472;7036.859262814817;7091.6454177290925;7143.071400717873;6790.660466976631;6862.519623626398;6973.965130174317;6994.825129371807;7032;3721.6650501455;3757.6242375762754;3780.1494663700446;3809.732442470635;3911.5110611173604;1818.7453756474104;1865.2538984406074;1870.925162993465;1871.3543827379533;1876.9155388007573;721.5670597641373;790.4506368074133;855.3285670748432;884.3632584539122;947.990520094804;16853.410130645614;17172.484825455256;17572.736408953875;17929.7310540342;18154.18306176199;833.954132522705;835.1481488881307;844.273924424994;845.2688424512875;848.6435697007148;9284.489353085644;9436.95281523588;9766.804663906682;9886.110250077527;10069.647562335284;382308;385716;413689;415703;424944;79154;79183;83671;89846;90865;868.4832524647825;911.2209061252667;930.2046750028763;931.8974912759727;936.480253459323;14948.515445366129;15526.9223653881;16465.094419807025;16618.418355357506;16715.414960476326;38165;38284.617153828105;39490;39663.20673586454;39919;50585.747071264406;51712.74143629258;52422;52433;53299.733501332244;7699.422543309162;7728.111267204344;7759.2240775921955;7875.566843823644;8178.427510074238;10429.582816687247;11061.004509593853;12049.457774400349;12188.634340969786;12861.871381286443;10063.949680251844;10138.087572118544;10162.593496260362;10288.742781430525;10320.43237621908;10567.154627629618;10691.572337106429;10714.678559643224;11048.447577621248;11184.720381990515;9637.566309516229;9644.903550964682;9659.565319560495;10209.642662506776;11015.284006539548;7734;7859.4891332063235;7883.290503854451;7891.921080789119;8103.189681032086;7486.353002339477;9625.51872406391;9674.226061915171;9728.9027109728;10006.09945104944 00:33:05 INFO - PROCESS | 23363 | |3;mootools.html;1185.9881401185985;1338.4913732781545;1376;1440.5894320118769;1656.5692919840844;6564.638944858031;7415.592142432164;7684.577348245844;7686.192949740273;7917;7723.111842138156;7822.530648161114;7836.412269079813;7837.4121940854375;7839.608019599026;2166.1985065525737;2182;2190.7371115466167;2193.2214064007285;2198.263581700124;2150.354893531942;2197.21998690465;2218.234709025384;2220.9333719988426;2225.1766846266905;2156.471664442206;2178.901949412272;2182;2192.6272533669317;2194.58302922445;2121.352987338861;2132.2537112010828;2133.8506304558687;2139.465133716571;2140.2081229944943;2059.8970051497513;2119.5548934723724;2121.5120522279963;2125;2146.162996431393;7683.308502234826;7691.423143264277;7756.883646745303;7838.137804841463;7840.568768717718;4320.13597280542;4498.730076195438;4503.774811259424;4510.954890451087;4512.887177820548;2733.3576609496754;2900.0864727610733;2947.5726019727235;2960.037987654021;2961.970380296191;883.7039591736776;894.0478390514147;904.841652710773;905.5472263868066;928.517171071046;10717.46412679363;10803;10817.783644327148;10821.404822734747;10836.241463097585;3874.1089549403796;3999.7600143991453;4124.484439445069;4186.079062606222;4260.2970509866145;8476.27951624119;8495.428345756054;8496.192861678132;8556.358273129541;8597.226249637562;4371.060222052274;4372.038151606642;4373.3877257183385;4374.606285434263;4375.190589740908;3408.471686888536;3952.3873799561115;4034.374671925856;4060.817263223162;4125.1131006833675;3352.379809735207;3373.5614370132216;3478.4260597001717;3478.91302717429;3485.72114230866;1018.6485662446444;1036.9533370998172;1047.4029803012363;1048.842673598951;1048.8531605575226;729.6023667101442;839.1273076001013;841.6507149532998;871.5337294547387;874.5190145419994;5196.402413722395;5250.921236181461;5284.816117493474;5390.64960777556;5510.531604813636;412.3093817855081;412.4761552827892;416.07008336368193;418.6044188242143;421.30695006713785;3729.757565758217;3797.7721336719887;3819.8472061117245;3822.980885095557;3901.843926242975;9285;9732.90267097334;9735.075167859042;9759.853602195974;9777.413355198569;9460.8580871287;9595.616175352907;9664.323497355259;9692.22462203022;9754.170895473822;7272.200057993617;7327.340539351484;7332.633368331562;7373.373263272575;7427.8143046424275;5274.736263186748;5275.973620131875;5366.087765080024;5375.865603359947;5379.085555455504;8763.430377025474;8865.423747456394;8908.331875109263;8950;9007.954960225157;8995.460272383678;9044.819103618023;9147.993720690853;9180.540972951192;9191.03494133133;5631.605787594829;6159.784407545714;6308.243010838729;6402.6158430494315;6408.871822563429;7147.106611673541;7461.664225109775;7468.775936721907;7476.4018878488505;7488;6516.218053833571;6543.995641298658;6566.343365663395;6740.797776066725;6744.865102698017;6309.3690630936535;6317.178766760292;6489.967550162408;6570.375814297634;6618.271990080991;6151.507879369729;6218.751249949952;6234.844128896632;6240.188775459162;6246.375362463899;4659.487456379863;4799.66402351832;4816.686915350631;4860.17377045896;4893.877653058702;4652.8138874445995;4680.695754776065;4717.528247175255;4758.619310455086;4801.685708748043 00:33:05 INFO - PROCESS | 23363 | |4;prototype.html;287.36922455210805;290.4380024652297;297.7945217799719;300.7533822265743;302.20670739309315;4740.336352910586;4889.951100488994;4951.232558953359;4952.380952380952;4974.507647705687;4704.894349827788;4805.543473370033;4857.202834951064;4859.271109333602;4861.8055277788935;3782.2813665403623;3793.6965042796646;3812.637799409066;3813.733038687286;3823.5220597425323;3612.313660404528;3624.7825130492256;3795.5065841440573;3821.789801560913;3826.7321287509885;3778.622137786227;3810.3522401191863;3820.9808950955344;3822.617738226169;3826.5025546678894;3815.923681526368;3823.9808800956093;3824.6175382461947;3826.253880493305;3837.213371258913;3352.664733526628;3363.327334533103;3370.292238629866;3371.3088816792497;3383.204946837491;4583.72497650142;4705.12955103307;4709;4723.055388922229;4824.469308376076;4312.9137417251795;4328.696991210617;4335.284678028122;4362.1275744851155;4365.759883206422;5034.748262586856;5044.218146187347;5046;5050.646454748169;5106.872328191787;3563.1626567756557;3611;3639.4532323762296;3666.431703086026;3669.7798132112157;5249.790008399659;5282.445343238943;5284.392294886099;5297.5232229099565;5367.1680889462195;3718.163413232001;3721.2743515014854;3721.739478236552;3723.888283351504;3726.366517691945;3766.4915236443276;3766.981165094157;3815.8855234343014;3822.8149273725235;3828.0812604974603;4157.272477316457;4261.083866968616;4273.585424235297;4288.463942007249;4292.5707429257445;5010.949890501121;5032.823851165192;5035.949640503622;5036.32009678696;5067.199600299775;1240.6526172671665;1271.8918891894293;1273.070658419359;1296.2999980010688;1322.530501671912;800.2717527050356;821.4003777242647;883.9337049721297;903.7695387676232;907.6641642592151;4411.7573533455325;4415.646748260131;4423.889402764957;4433.623142032899;4445.333200019958;5155.61332900034;5172.172452407597;5182.144946083854;5182.585393168538;5193.84418467439;4314.374415709767;4521;4531.592156705912;4573.611243044378;4585.862424127282;2791.581262810554;2805.6773471050683;2806.9017584384856;2809.8314101153996;2811.5801520232153;4757.762111894392;4985.277134815431;4987.526185012418;4999.975000124976;5005.624578156653;5251.632385733038;5300.814471493556;5312.707801070978;5323.733813309319;5369.530016192517;4911.327416833563;4936.555709986119;4938.75306234694;4957.934044180519;5001.224810154432;5138.353747819801;5230.2677625131755;5278.313819203479;5291.708956007303;5325.600579956596;5156.1492353761205;5161.380634323755;5164.870878228075;5172.637915345889;5204.219367094966;4936.753162341796;4963.31247375894;4968.925466118083;4993.550580447777;4993.650444468853;3576.7675101118343;3674.283514714605;3675;3682.8710995115043;3688.723345749026;5146.871328216675;5187.533122019036;5202.453742356998;5224.50367215114;5251.658642188246;5037.748112594429;5055.418626857959;5066.620003499678;5110.284560161506;5135.974320128375;4891.730954797378;5098.745062746922;5108.719020453762;5121.411037730709;5146.665466744649;4766.761661916959;4844.4186697596515;4972.403311602631;4995.700257984533;5001.174806156943;5097.796088156432;5114.948850511447;5142.151544995184;5145.61407894402;5185.718283955048;5028.924566131438;5035.446100928822;5044.965782014605;5059.392872855281;5067.13858644024 00:33:05 INFO - PROCESS | 23363 | |5;yui.html;560.3304051658265;569.4021277658458;623.3236937922354;704.6089420371695;716.3230746944137;11691.532338706453;12605.243685378884;12663.11358204926;12698.301593412358;12799.104062715614;12416.565420210294;12553.18404303722;12555.811662825065;12576.937115314433;12798.04014698899;616.910547970544;722.5664601239267;745.124478737484;746.0413368821053;749.4678778067552;775.1318523253935;777.1451403456209;777.8172129549552;778.0857492446381;778.3734094054284;798.3732769775727;799.6601444386142;802.5265093594778;804.9959750201241;806.4516129032256;626.0452809465579;783.2519943453988;792.3581898662073;804.505229283992;805.4281460163292;596.9611975221596;597.2385208858697;597.310106826616;597.3608239184075;597.6892016151577;12142.45358958849;12158;12162.695932601755;12190.08574356918;12206.633800985985;11683;12183.878161218363;12537.686557836036;12855.614331570068;13087.214767114003;11772.527769168399;11794.410279485992;11798.174127811057;12310;12458.81311780324;3931.0761970936805;3970.980145099285;3999.3800960851113;4048.4939382577177;4048.635622793933;63866;64259.67870160666;64375.67812160909;64572.3542764571;65342.67328663326;9987.750306242257;10238.12975897057;10497.370157790558;10560.155187584975;10588.841167382496;20025.297849682942;20134.19463221484;20189.596208075756;20313.79686203119;20506.487337816674;6254.499640028786;6320.652364120017;6392.968035159794;6513.348665133543;6847.452203823682;3463.290025544757;3470.236547959445;3474.652534746505;3507.210877552581;3526.5062891195253;2676.130257666266;2768.9446211075665;2790.7209279072335;2791.2045067155764;2800.1599520143877;513.0636588226502;515.7730598536632;516.1818517649492;521.6869878073202;528.5903424845699;476.3973573429614;502.97736601853006;505.919052951526;509.80882169186555;510.9233614957786;7339.59632220233;7345.853082938312;7384.852302953911;7761.340286075634;7932.920670793334;412.7729748638297;416.44404719698935;503.1722815967786;516.7106420404585;526.5340173946008;3656.780593164419;3682.5212722345923;3816.2367526494813;3817.6373244541724;3903.512060992376;93276;100366;101519.49240253899;107687;111978.44010780058;78718.60640696759;79179;79984.20015799768;81218.18781812106;82170.58914705388;69393;70283.64858175676;71375.28624713686;71505;72351.2764872355;7848;7943.364530837634;8417.326613870753;8631.43895646781;8661.566921653766;42045;42581.36127958021;43274.6433106379;43315.78342108269;45069;51896.74051629718;62936.37063629305;63302.36697632965;63745.68127159335;64565.35434645781;10861.294015888941;11047.668569942914;11282.887171128184;11318.94340528292;11841.171118021655;12105.636830895088;12274.202176858476;12364.319962402154;12527.749445011232;12536.874631253571;6598.802035938929;10942.343459392461;11287.831765026991;11309.321440713584;11340.94329528347;11333.886661133283;11439.885601143882;11463.426828658701;12102.45538950767;12103.878961210276;9870.851937220803;10299.897001029894;10567.313124646873;10903.836442453528;10958.068564172134;9397.453297142065;9734.853977190489;10069.798604028025;10157.695269141937;10279.640212592523;9229.215516681157;9649.46927918943;9776;9777.266704997011;9784.9021509784 00:33:05 INFO - PROCESS | 23363 | __end_tp_report 00:33:05 INFO - PROCESS | 23363 | __start_cc_report 00:33:05 INFO - PROCESS | 23363 | _x_x_mozilla_cycle_collect,1078 00:33:05 INFO - PROCESS | 23363 | __end_cc_report 00:33:05 INFO - PROCESS | 23363 | __startTimestamp1471505585056__endTimestamp 00:33:05 INFO - PROCESS | 23363 | 00:33:05 INFO - PROCESS | 23363 | ------- Summary: start ------- 00:33:05 INFO - PROCESS | 23363 | Number of tests: 6 00:33:05 INFO - PROCESS | 23363 | 00:33:05 INFO - PROCESS | 23363 | [#0] dojo.html Cycles:165 Average:4619.87 Median:4744.41 stddev:484.75 (10.2%) stddev-sans-first:459.30 00:33:05 INFO - PROCESS | 23363 | Values: 2588.5 2590.9 2618.3 2638.7 2643.2 4550.6 4612.5 4673.1 4693.2 4709.6 4573.9 4626.5 4636.0 4661.4 4730.4 4224.9 4251.5 4297.3 4321.5 4412.4 4301.1 4354.4 4422.4 4454.5 4457.3 4300.3 4343.7 4346.5 4364.2 4388.3 4158.5 4213.0 4215.1 4233.5 4287.6 4195.2 4201.0 4231.4 4241.0 4350.9 4612.8 4617.3 4643.1 4662.0 4664.2 4818.1 4954.4 4959.1 4990.9 4996.5 5042.7 5051.1 5053.3 5091.3 5094.0 4712.0 4723.1 4761.0 4769.5 4771.5 4951.8 5084.9 5135.7 5148.7 5208.8 4919.8 4974.0 4976.1 4987.9 4990.9 5027.3 5032.0 5034.4 5034.8 5091.3 4797.5 4886.1 4950.8 4957.3 4958.2 4928.9 4969.4 4971.5 4975.1 5001.4 4252.6 4268.5 4270.3 4272.1 4305.1 3652.5 3681.2 3684.4 3722.3 3766.3 4316.0 4333.2 4366.3 4375.8 4377.4 5029.2 5030.4 5031.6 5031.7 5056.5 4177.9 4208.3 4251.0 4308.8 4356.6 4419.0 4435.0 4469.6 4484.3 4485.7 4622.3 4628.0 4636.8 4639.2 4672.9 4845.5 4915.9 4920.8 4933.2 5002.6 4723.8 4737.0 4744.4 4764.9 4780.5 4920.3 4946.1 4952.5 4956.1 4975.7 4785.5 4970.7 5025.5 5046.0 5058.5 4903.5 4920.9 4921.2 4944.3 4971.0 4868.9 4895.8 4896.9 4896.9 4958.5 4617.3 4668.1 4739.1 4826.9 4862.7 4856.9 4908.2 4913.1 4937.9 4954.5 4798.8 4810.3 4813.2 4815.8 4857.7 00:33:05 INFO - PROCESS | 23363 | 00:33:05 INFO - PROCESS | 23363 | [#1] ext.html Cycles:180 Average:42818.06 Median:19577.37 stddev:74384.67 (380.0%) stddev-sans-first:74525.69 00:33:05 INFO - PROCESS | 23363 | Values: 565.1 580.6 588.1 590.5 591.5 28181.0 30513.5 30520.0 39258.6 40651.6 39401.4 39832.8 39835.2 39891.0 39899.4 7655.6 7805.5 7806.8 7810.3 7810.3 7657.3 7737.3 7739.7 7743.0 7744.1 7756.7 7794.6 7809.1 7815.9 7816.5 7715.7 7751.6 7753.5 7757.7 7758.8 7714.0 7791.0 7793.6 7796.0 7797.3 37130.4 37518.0 37567.6 37579.8 37581.4 3111.4 3145.6 3165.7 3373.0 3536.6 28539.9 28769.9 28785.4 28846.6 30170.5 3380.0 3459.7 3473.0 3474.7 3549.7 252086.0 253345.0 254354.0 254432.0 255259.0 50335.0 50549.7 50576.7 50678.2 50767.2 32567.3 33423.5 33479.7 35262.5 35315.6 13268.4 13438.5 13447.4 13485.7 13504.9 9658.7 9694.9 9696.0 9753.5 9767.0 17185.5 17243.6 17254.8 17362.1 17409.0 6561.8 6607.1 6683.5 6712.2 6846.2 769.9 877.1 895.9 920.4 970.3 25747.0 26345.6 26691.3 26738.5 26836.5 742.6 895.6 902.0 905.7 960.1 14391.7 15160.0 15260.8 15444.2 16036.4 194607.0 196306.0 196678.0 197219.0 368022.0 50156.2 50523.5 50645.5 50712.2 50743.7 1100.7 1143.0 1148.2 1151.9 1153.4 27404.2 28129.3 29167.3 29263.7 29326.0 42022.8 42833.0 42873.4 42890.3 42898.1 342776.0 343225.0 343708.0 344451.0 345266.0 24868.3 24986.5 25296.4 25403.1 25422.5 40615.4 40764.0 40855.2 41129.6 41249.8 34796.5 34848.0 34971.0 35605.0 35623.6 34440.4 34510.3 34553.7 35487.6 35659.1 34059.1 34209.3 36508.0 37173.3 37233.3 30034.8 31725.0 32788.7 32922.8 32939.5 24111.0 24121.0 24289.4 24871.8 24939.3 00:33:05 INFO - PROCESS | 23363 | 00:33:05 INFO - PROCESS | 23363 | [#2] jquery.html Cycles:180 Average:24689.40 Median:28821.60 stddev:66873.60 (232.0%) stddev-sans-first:67036.22 00:33:05 INFO - PROCESS | 23363 | Values: 347.0 365.6 366.3 369.1 389.4 12812.7 16046.7 16060.7 16593.0 17569.7 15874.7 16118.5 16351.8 16608.8 16701.1 5018.1 5221.2 5258.6 5472.6 5517.7 3455.0 5543.4 5575.8 5580.8 5821.0 6126.6 6155.2 6157.6 6160.1 6164.5 5929.3 6049.2 6077.7 6079.8 6141.3 5422.4 5429.7 5429.9 5434.2 5438.0 12742.1 17689.6 18785.9 21153.0 21223.6 1723.4 1839.4 1903.8 1904.0 2119.2 9065.9 9172.3 9228.3 9289.3 9562.4 1653.1 1663.5 1727.2 1756.8 1767.7 47239.3 62633.4 64246.7 64705.7 72321.6 8877.5 8973.0 9049.0 9079.2 10070.9 11958.9 12008.5 12025.2 12030.4 12043.3 6842.8 6960.8 7036.9 7091.6 7143.1 6790.7 6862.5 6974.0 6994.8 7032.0 3721.7 3757.6 3780.1 3809.7 3911.5 1818.7 1865.3 1870.9 1871.4 1876.9 721.6 790.5 855.3 884.4 948.0 16853.4 17172.5 17572.7 17929.7 18154.2 834.0 835.1 844.3 845.3 848.6 9284.5 9437.0 9766.8 9886.1 10069.6 382308.0 385716.0 413689.0 415703.0 424944.0 79154.0 79183.0 83671.0 89846.0 90865.0 868.5 911.2 930.2 931.9 936.5 14948.5 15526.9 16465.1 16618.4 16715.4 38165.0 38284.6 39490.0 39663.2 39919.0 50585.7 51712.7 52422.0 52433.0 53299.7 7699.4 7728.1 7759.2 7875.6 8178.4 10429.6 11061.0 12049.5 12188.6 12861.9 10063.9 10138.1 10162.6 10288.7 10320.4 10567.2 10691.6 10714.7 11048.4 11184.7 9637.6 9644.9 9659.6 10209.6 11015.3 7734.0 7859.5 7883.3 7891.9 8103.2 7486.4 9625.5 9674.2 9728.9 10006.1 00:33:05 INFO - PROCESS | 23363 | 00:33:05 INFO - PROCESS | 23363 | [#3] mootools.html Cycles:180 Average:5069.06 Median:5223.66 stddev:2883.10 (55.2%) stddev-sans-first:2876.42 00:33:05 INFO - PROCESS | 23363 | Values: 1186.0 1338.5 1376.0 1440.6 1656.6 6564.6 7415.6 7684.6 7686.2 7917.0 7723.1 7822.5 7836.4 7837.4 7839.6 2166.2 2182.0 2190.7 2193.2 2198.3 2150.4 2197.2 2218.2 2220.9 2225.2 2156.5 2178.9 2182.0 2192.6 2194.6 2121.4 2132.3 2133.9 2139.5 2140.2 2059.9 2119.6 2121.5 2125.0 2146.2 7683.3 7691.4 7756.9 7838.1 7840.6 4320.1 4498.7 4503.8 4511.0 4512.9 2733.4 2900.1 2947.6 2960.0 2962.0 883.7 894.0 904.8 905.5 928.5 10717.5 10803.0 10817.8 10821.4 10836.2 3874.1 3999.8 4124.5 4186.1 4260.3 8476.3 8495.4 8496.2 8556.4 8597.2 4371.1 4372.0 4373.4 4374.6 4375.2 3408.5 3952.4 4034.4 4060.8 4125.1 3352.4 3373.6 3478.4 3478.9 3485.7 1018.6 1037.0 1047.4 1048.8 1048.9 729.6 839.1 841.7 871.5 874.5 5196.4 5250.9 5284.8 5390.6 5510.5 412.3 412.5 416.1 418.6 421.3 3729.8 3797.8 3819.8 3823.0 3901.8 9285.0 9732.9 9735.1 9759.9 9777.4 9460.9 9595.6 9664.3 9692.2 9754.2 7272.2 7327.3 7332.6 7373.4 7427.8 5274.7 5276.0 5366.1 5375.9 5379.1 8763.4 8865.4 8908.3 8950.0 9008.0 8995.5 9044.8 9148.0 9180.5 9191.0 5631.6 6159.8 6308.2 6402.6 6408.9 7147.1 7461.7 7468.8 7476.4 7488.0 6516.2 6544.0 6566.3 6740.8 6744.9 6309.4 6317.2 6490.0 6570.4 6618.3 6151.5 6218.8 6234.8 6240.2 6246.4 4659.5 4799.7 4816.7 4860.2 4893.9 4652.8 4680.7 4717.5 4758.6 4801.7 00:33:05 INFO - PROCESS | 23363 | 00:33:05 INFO - PROCESS | 23363 | [#4] prototype.html Cycles:180 Average:4227.44 Median:4850.81 stddev:1225.99 (25.3%) stddev-sans-first:1193.23 00:33:05 INFO - PROCESS | 23363 | Values: 287.4 290.4 297.8 300.8 302.2 4740.3 4890.0 4951.2 4952.4 4974.5 4704.9 4805.5 4857.2 4859.3 4861.8 3782.3 3793.7 3812.6 3813.7 3823.5 3612.3 3624.8 3795.5 3821.8 3826.7 3778.6 3810.4 3821.0 3822.6 3826.5 3815.9 3824.0 3824.6 3826.3 3837.2 3352.7 3363.3 3370.3 3371.3 3383.2 4583.7 4705.1 4709.0 4723.1 4824.5 4312.9 4328.7 4335.3 4362.1 4365.8 5034.7 5044.2 5046.0 5050.6 5106.9 3563.2 3611.0 3639.5 3666.4 3669.8 5249.8 5282.4 5284.4 5297.5 5367.2 3718.2 3721.3 3721.7 3723.9 3726.4 3766.5 3767.0 3815.9 3822.8 3828.1 4157.3 4261.1 4273.6 4288.5 4292.6 5010.9 5032.8 5035.9 5036.3 5067.2 1240.7 1271.9 1273.1 1296.3 1322.5 800.3 821.4 883.9 903.8 907.7 4411.8 4415.6 4423.9 4433.6 4445.3 5155.6 5172.2 5182.1 5182.6 5193.8 4314.4 4521.0 4531.6 4573.6 4585.9 2791.6 2805.7 2806.9 2809.8 2811.6 4757.8 4985.3 4987.5 5000.0 5005.6 5251.6 5300.8 5312.7 5323.7 5369.5 4911.3 4936.6 4938.8 4957.9 5001.2 5138.4 5230.3 5278.3 5291.7 5325.6 5156.1 5161.4 5164.9 5172.6 5204.2 4936.8 4963.3 4968.9 4993.6 4993.7 3576.8 3674.3 3675.0 3682.9 3688.7 5146.9 5187.5 5202.5 5224.5 5251.7 5037.7 5055.4 5066.6 5110.3 5136.0 4891.7 5098.7 5108.7 5121.4 5146.7 4766.8 4844.4 4972.4 4995.7 5001.2 5097.8 5114.9 5142.2 5145.6 5185.7 5028.9 5035.4 5045.0 5059.4 5067.1 00:33:05 INFO - PROCESS | 23363 | 00:33:05 INFO - PROCESS | 23363 | [#5] yui.html Cycles:180 Average:17595.01 Median:22772.70 stddev:25412.80 (111.6%) stddev-sans-first:25451.90 00:33:05 INFO - PROCESS | 23363 | Values: 560.3 569.4 623.3 704.6 716.3 11691.5 12605.2 12663.1 12698.3 12799.1 12416.6 12553.2 12555.8 12576.9 12798.0 616.9 722.6 745.1 746.0 749.5 775.1 777.1 777.8 778.1 778.4 798.4 799.7 802.5 805.0 806.5 626.0 783.3 792.4 804.5 805.4 597.0 597.2 597.3 597.4 597.7 12142.5 12158.0 12162.7 12190.1 12206.6 11683.0 12183.9 12537.7 12855.6 13087.2 11772.5 11794.4 11798.2 12310.0 12458.8 3931.1 3971.0 3999.4 4048.5 4048.6 63866.0 64259.7 64375.7 64572.4 65342.7 9987.8 10238.1 10497.4 10560.2 10588.8 20025.3 20134.2 20189.6 20313.8 20506.5 6254.5 6320.7 6393.0 6513.3 6847.5 3463.3 3470.2 3474.7 3507.2 3526.5 2676.1 2768.9 2790.7 2791.2 2800.2 513.1 515.8 516.2 521.7 528.6 476.4 503.0 505.9 509.8 510.9 7339.6 7345.9 7384.9 7761.3 7932.9 412.8 416.4 503.2 516.7 526.5 3656.8 3682.5 3816.2 3817.6 3903.5 93276.0 100366.0 101519.5 107687.0 111978.4 78718.6 79179.0 79984.2 81218.2 82170.6 69393.0 70283.6 71375.3 71505.0 72351.3 7848.0 7943.4 8417.3 8631.4 8661.6 42045.0 42581.4 43274.6 43315.8 45069.0 51896.7 62936.4 63302.4 63745.7 64565.4 10861.3 11047.7 11282.9 11318.9 11841.2 12105.6 12274.2 12364.3 12527.7 12536.9 6598.8 10942.3 11287.8 11309.3 11340.9 11333.9 11439.9 11463.4 12102.5 12103.9 9870.9 10299.9 10567.3 10903.8 10958.1 9397.5 9734.9 10069.8 10157.7 10279.6 9229.2 9649.5 9776.0 9777.3 9784.9 00:33:05 INFO - PROCESS | 23363 | -------- Summary: end -------- 00:33:05 INFO - PROCESS | 23363 | 00:33:05 INFO - TEST-INFO | 23363: exit 0 00:33:05 INFO - TEST-OK | dromaeo_css | took 1119846ms 00:33:05 INFO - TEST-START | kraken 00:33:05 INFO - operating with platform_type : linux_ 00:33:05 INFO - Initialising browser for kraken test... 00:33:05 INFO - TEST-INFO | started process 23664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ2HkHQ/profile http://localhost:36483/getInfo.html) 00:33:10 INFO - PROCESS | 23664 | __metrics Screen width/height:1600/1200 00:33:10 INFO - PROCESS | 23664 | colorDepth:24 00:33:10 INFO - PROCESS | 23664 | Browser inner width/height: 1024/697 00:33:10 INFO - PROCESS | 23664 | __metrics 00:33:10 INFO - PROCESS | 23664 | 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" 00:33:10 INFO - PROCESS | 23664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:33:11 INFO - PROCESS | 23664 | console.error: PushService: 00:33:11 INFO - PROCESS | 23664 | stateChangeProcessEnqueue: Error transitioning state 00:33:11 INFO - PROCESS | 23664 | UnknownError 00:33:11 INFO - TEST-INFO | 23664: exit 0 00:33:11 INFO - Browser initialized. 00:33:11 INFO - Running cycle 1/1 for kraken test... 00:33:11 INFO - TEST-INFO | started process 23747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ2HkHQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:33:23 INFO - PROCESS | 23747 | RSS: Main: 157679616 00:33:23 INFO - PROCESS | 23747 | 00:33:26 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36483/tests/kraken/driver.html?testName=audio-beat-detection) 00:33:27 INFO - PROCESS | 23747 | RSS: Main: 205303808 00:33:27 INFO - PROCESS | 23747 | 00:33:30 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36483/tests/kraken/driver.html?testName=audio-dft) 00:33:30 INFO - PROCESS | 23747 | RSS: Main: 196481024 00:33:30 INFO - PROCESS | 23747 | 00:33:34 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36483/tests/kraken/driver.html?testName=audio-fft) 00:33:34 INFO - PROCESS | 23747 | RSS: Main: 277352448 00:33:34 INFO - PROCESS | 23747 | 00:33:37 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36483/tests/kraken/driver.html?testName=audio-oscillator) 00:33:37 INFO - PROCESS | 23747 | RSS: Main: 188039168 00:33:37 INFO - PROCESS | 23747 | 00:33:39 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36483/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:33:40 INFO - PROCESS | 23747 | RSS: Main: 192147456 00:33:40 INFO - PROCESS | 23747 | 00:33:43 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36483/tests/kraken/driver.html?testName=imaging-darkroom) 00:33:44 INFO - PROCESS | 23747 | RSS: Main: 228515840 00:33:44 INFO - PROCESS | 23747 | 00:33:47 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36483/tests/kraken/driver.html?testName=imaging-desaturate) 00:33:48 INFO - PROCESS | 23747 | RSS: Main: 227651584 00:33:48 INFO - PROCESS | 23747 | 00:33:51 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36483/tests/kraken/driver.html?testName=json-parse-financial) 00:33:51 INFO - PROCESS | 23747 | RSS: Main: 227319808 00:33:51 INFO - PROCESS | 23747 | 00:33:53 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36483/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:33:54 INFO - PROCESS | 23747 | RSS: Main: 190050304 00:33:54 INFO - PROCESS | 23747 | 00:33:56 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36483/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:33:56 INFO - PROCESS | 23747 | RSS: Main: 197902336 00:33:56 INFO - PROCESS | 23747 | 00:33:58 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36483/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:33:59 INFO - PROCESS | 23747 | RSS: Main: 193732608 00:33:59 INFO - PROCESS | 23747 | 00:34:02 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:34:03 INFO - PROCESS | 23747 | RSS: Main: 189546496 00:34:03 INFO - PROCESS | 23747 | 00:34:05 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:34:06 INFO - PROCESS | 23747 | RSS: Main: 192737280 00:34:06 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:36483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36483/tests/kraken/driver.html?testName=ai-astar) 00:34:08 INFO - PROCESS | 23747 | RSS: Main: 243441664 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | __start_tp_report 00:34:08 INFO - PROCESS | 23747 | _x_x_mozilla_page_load 00:34:08 INFO - PROCESS | 23747 | _x_x_mozilla_page_load_details 00:34:08 INFO - PROCESS | 23747 | |i|pagename|runs| 00:34:08 INFO - PROCESS | 23747 | |0;ai-astar;105;117;116;116;109;114;115;114;115;114 00:34:08 INFO - PROCESS | 23747 | |1;audio-beat-detection;148;122;125;195;123;127;154;120;194;127 00:34:08 INFO - PROCESS | 23747 | |2;audio-dft;161;161;161;163;163;162;162;163;163;163 00:34:08 INFO - PROCESS | 23747 | |3;audio-fft;76;77;75;113;76;76;75;76;133;75 00:34:08 INFO - PROCESS | 23747 | |4;audio-oscillator;87;85;140;86;86;85;118;86;86;122 00:34:08 INFO - PROCESS | 23747 | |5;imaging-gaussian-blur;117;116;117;116;117;116;117;116;116;116 00:34:08 INFO - PROCESS | 23747 | |6;imaging-darkroom;146;146;146;147;147;147;146;147;147;146 00:34:08 INFO - PROCESS | 23747 | |7;imaging-desaturate;95;95;94;95;94;95;95;94;95;94 00:34:08 INFO - PROCESS | 23747 | |8;json-parse-financial;68;65;66;65;74;67;66;65;66;66 00:34:08 INFO - PROCESS | 23747 | |9;json-stringify-tinderbox;65;65;65;66;67;66;67;66;66;67 00:34:08 INFO - PROCESS | 23747 | |10;stanford-crypto-aes;84;83;90;88;83;82;81;82;82;85 00:34:08 INFO - PROCESS | 23747 | |11;stanford-crypto-ccm;133;140;132;133;141;138;132;138;149;132 00:34:08 INFO - PROCESS | 23747 | |12;stanford-crypto-pbkdf2;176;174;171;172;171;174;170;170;172;171 00:34:08 INFO - PROCESS | 23747 | |13;stanford-crypto-sha256-iterative;67;68;70;67;67;66;67;69;74;67 00:34:08 INFO - PROCESS | 23747 | __end_tp_report 00:34:08 INFO - PROCESS | 23747 | __start_cc_report 00:34:08 INFO - PROCESS | 23747 | _x_x_mozilla_cycle_collect,1945 00:34:08 INFO - PROCESS | 23747 | __end_cc_report 00:34:08 INFO - PROCESS | 23747 | __startTimestamp1471505648579__endTimestamp 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | ------- Summary: start ------- 00:34:08 INFO - PROCESS | 23747 | Number of tests: 14 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.69 (3.2%) stddev-sans-first:2.30 00:34:08 INFO - PROCESS | 23747 | Values: 105.0 117.0 116.0 116.0 109.0 114.0 115.0 114.0 115.0 114.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:137.50 stddev:29.16 (21.2%) stddev-sans-first:30.89 00:34:08 INFO - PROCESS | 23747 | Values: 148.0 122.0 125.0 195.0 123.0 127.0 154.0 120.0 194.0 127.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 00:34:08 INFO - PROCESS | 23747 | Values: 161.0 161.0 161.0 163.0 163.0 162.0 162.0 163.0 163.0 163.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#3] audio-fft Cycles:10 Average:85.20 Median:76.00 stddev:20.48 (26.9%) stddev-sans-first:21.45 00:34:08 INFO - PROCESS | 23747 | Values: 76.0 77.0 75.0 113.0 76.0 76.0 75.0 76.0 133.0 75.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:86.00 stddev:20.48 (23.8%) stddev-sans-first:21.32 00:34:08 INFO - PROCESS | 23747 | Values: 87.0 85.0 140.0 86.0 86.0 85.0 118.0 86.0 86.0 122.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 00:34:08 INFO - PROCESS | 23747 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 116.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 00:34:08 INFO - PROCESS | 23747 | Values: 146.0 146.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 00:34:08 INFO - PROCESS | 23747 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:66.00 stddev:2.70 (4.1%) stddev-sans-first:2.83 00:34:08 INFO - PROCESS | 23747 | Values: 68.0 65.0 66.0 65.0 74.0 67.0 66.0 65.0 66.0 66.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 00:34:08 INFO - PROCESS | 23747 | Values: 65.0 65.0 65.0 66.0 67.0 66.0 67.0 66.0 66.0 67.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.50 stddev:2.91 (3.5%) stddev-sans-first:3.08 00:34:08 INFO - PROCESS | 23747 | Values: 84.0 83.0 90.0 88.0 83.0 82.0 81.0 82.0 82.0 85.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:138.00 stddev:5.55 (4.0%) stddev-sans-first:5.72 00:34:08 INFO - PROCESS | 23747 | Values: 133.0 140.0 132.0 133.0 141.0 138.0 132.0 138.0 149.0 132.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:172.00 stddev:1.97 (1.1%) stddev-sans-first:1.50 00:34:08 INFO - PROCESS | 23747 | Values: 176.0 174.0 171.0 172.0 171.0 174.0 170.0 170.0 172.0 171.0 00:34:08 INFO - PROCESS | 23747 | 00:34:08 INFO - PROCESS | 23747 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:67.50 stddev:2.35 (3.5%) stddev-sans-first:2.45 00:34:08 INFO - PROCESS | 23747 | Values: 67.0 68.0 70.0 67.0 67.0 66.0 67.0 69.0 74.0 67.0 00:34:08 INFO - PROCESS | 23747 | -------- Summary: end -------- 00:34:08 INFO - PROCESS | 23747 | 00:34:09 INFO - TEST-INFO | 23747: exit 0 00:34:09 INFO - TEST-OK | kraken | took 63801ms 00:34:09 INFO - SUITE-END | took 1183s 00:34:09 INFO - Completed test suite (00:19:43) 00:34:09 INFO - javascript benchmark 00:34:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2588.4564241509283, 2590.948181036378, 2618.2537976676645, 2638.656974593304, 2643.193825883105, 4550.63594912407, 4612.492625811158, 4673.065386922616, 4693.202155633542, 4709.576138147566, 4573.908521829561, 4626.4910859805395, 4635.953640463595, 4661.394018777562, 4730.432348118222, 4224.8732538023905, 4251.5323314435545, 4297.312430011199, 4321.459817522809, 4412.40432541606, 4301.053768171013, 4354.433923589929, 4422.447194100738, 4454.465464144308, 4457.33140028995, 4300.290452075404, 4343.67422443318, 4346.500152482457, 4364.236258654739, 4388.319810429372, 4158.521769996459, 4212.957870421287, 4215.093754842724, 4233.534311225762, 4287.571242875719, 4195.181939521794, 4201.012762000958, 4231.407602935591, 4241.024564350186, 4350.912981740347, 4612.838550650745, 4617.284320930227, 4643.117807616576, 4662.0, 4664.160451118797, 4818.084563932876, 4954.355933728628, 4959.057779021974, 4990.87522811929, 4996.475370086125, 5042.697438153723, 5051.090803655341, 5053.317802096707, 5091.261767043795, 5094.032133894548, 4712.034033023257, 4723.149833030019, 4761.047790441856, 4769.546893045155, 4771.5467030632035, 4951.801927922915, 5084.923726144111, 5135.717535535507, 5148.665336753099, 5208.7916483341, 4919.803207871645, 4974.030064137531, 4976.129177393942, 4987.875303117451, 4990.850274491771, 5027.321311622884, 5031.974840125849, 5034.395872495324, 5034.84895453137, 5091.338126043591, 4797.520247975174, 4886.120498310267, 4950.801967921243, 4957.256411538298, 4958.206686930146, 4928.8767780805765, 4969.403671559436, 4971.502849715, 4975.0796102721115, 5001.42483614389, 4252.638525725286, 4268.530461649216, 4270.338097594878, 4272.081502476983, 4305.07440900208, 3652.5251717277115, 3681.171736359351, 3684.428913518409, 3722.2555488901785, 3766.2655782122224, 4315.956840431619, 4333.220020396296, 4366.257736184856, 4375.78121093944, 4377.365282034088, 5029.170186919117, 5030.446650868402, 5031.572316353151, 5031.672941258879, 5056.544910958031, 4177.916441671149, 4208.305629571087, 4250.957490425056, 4308.784560771949, 4356.564343565618, 4418.977905110454, 4434.955650443519, 4469.597736203757, 4484.304932735431, 4485.730856148576, 4622.2835460503675, 4628.0, 4636.83771068011, 4639.234526303189, 4672.906541869075, 4845.466998630078, 4915.926261106015, 4920.827771027997, 4933.210686290176, 5002.599792016557, 4723.763811809327, 4736.976315118402, 4744.4069491313585, 4764.857054288377, 4780.521947805191, 4920.31115643803, 4946.109700253989, 4952.479989601185, 4956.058348913695, 4975.6517043808035, 4785.545373189541, 4970.726610036482, 5025.47232540578, 5045.974770126126, 5058.494150585059, 4903.485134061015, 4920.8769780755765, 4921.212605983025, 4944.258361245842, 4970.950290497193, 4868.853934381974, 4895.755212239303, 4896.853094407174, 4896.902061958812, 4958.479359667183, 4617.2612382018715, 4668.11305851887, 4739.146953548395, 4826.903461930812, 4862.6839255448285, 4856.927146092741, 4908.190148625436, 4913.115639184981, 4937.851864444073, 4954.529319714766, 4798.760061996956, 4810.326554282333, 4813.205821039489, 4815.759212039314, 4857.708537487762], "value": 4588.9500622960095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.0873838750418, 580.5790801668791, 588.0620410445338, 590.4656286061113, 591.5208680968416, 28181.0, 30513.542296865537, 30520.0, 39258.60741392585, 40651.59348406515, 39401.40897886534, 39832.800835995855, 39835.203295934065, 39891.0, 39899.40150897739, 7655.617219139049, 7805.492642978188, 7806.804829879242, 7810.258025487569, 7810.336121429686, 7657.310842024217, 7737.342325902305, 7739.651715672809, 7743.032120984877, 7744.070711514598, 7756.6509507072315, 7794.571298578576, 7809.101953275389, 7815.882761758578, 7816.491928024689, 7715.6913723451, 7751.612419379008, 7753.457257991943, 7757.650905709256, 7758.844823103506, 7714.035745531809, 7791.0, 7793.61031948406, 7795.961020194919, 7797.337226335769, 37130.443043354375, 37518.0, 37567.62432375669, 37579.81210093959, 37581.43627845585, 3111.4088323218516, 3145.622525296956, 3165.683431656839, 3372.971243770649, 3536.5756109267054, 28539.85730071357, 28769.856150719323, 28785.42429151426, 28846.567301490286, 30170.547441788392, 3379.9831000845084, 3459.6540345965454, 3472.9826350868084, 3474.722022238215, 3549.7337699672626, 252086.0, 253345.0, 254354.0, 254431.99999999814, 255259.0, 50335.0, 50549.74725126351, 50576.74711626418, 50678.239826402634, 50767.23849142266, 32567.348653027282, 33423.498647520304, 33479.66520334766, 35262.47106293408, 35315.64684353175, 13268.40292186854, 13438.529651462151, 13447.394867230998, 13485.66285842842, 13504.864951350557, 9658.661946831828, 9694.90305096954, 9695.951520242354, 9753.463559504153, 9767.0, 17185.484435466955, 17243.568910777332, 17254.827451725574, 17362.13189340528, 17409.0, 6561.835954101186, 6607.075009498674, 6683.465322774166, 6712.160979877515, 6846.178458585002, 769.9191584883619, 877.0790669796688, 895.8790563273875, 920.4339331311195, 970.2736250748048, 25747.0, 26345.604815927778, 26691.33271668185, 26738.465230695667, 26836.46327073487, 742.5693098003145, 895.5611750242334, 901.963921443148, 905.714699869539, 960.0975083421562, 14391.712165756626, 15160.0, 15260.847391526164, 15444.227788610524, 16036.358545658277, 194607.0, 196306.0, 196678.0, 197219.0, 368022.0, 50156.24765628519, 50523.48429547119, 50645.49354506481, 50712.23931641028, 50743.74628126836, 1100.7303210713267, 1143.0455569599312, 1148.190525679394, 1151.9078473722082, 1153.411760002405, 27404.177874663794, 28129.296767580974, 29167.270818229714, 29263.653699656054, 29326.0, 42022.78988605038, 42833.0, 42873.35689964715, 42890.2843886241, 42898.14203715846, 342776.0, 343225.0, 343708.0, 344451.0, 345266.0, 24868.253952381456, 24986.500269994864, 25296.367590810376, 25403.110891118722, 25422.491550168525, 40615.3907691379, 40764.0, 40855.1828963425, 41129.588704112575, 41249.79375103105, 34796.47805282872, 34847.9545613632, 34971.0, 35605.0, 35623.64376356203, 34440.383759705874, 34510.309793803484, 34553.654463455045, 35487.645123548435, 35659.108522286115, 34059.14852128716, 34209.31581368409, 36508.0, 37173.25653486861, 37233.25533489369, 30034.84982575073, 31725.0, 32788.67211327856, 32922.83538582292, 32939.50590741093, 24111.0, 24121.0, 24289.39276518101, 24871.751282486945, 24939.251822445356], "value": 16739.604202115508, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.99653003469956, 365.5832351119722, 366.30950658009647, 369.11596725841616, 389.4158761857214, 12812.679683007918, 16046.679066418665, 16060.678786424265, 16593.0, 17569.736453953203, 15874.682506349865, 16118.516444506684, 16351.83648163518, 16608.83391166088, 16701.081440520797, 5018.146915024437, 5221.190715439113, 5258.6318957672975, 5472.644278121929, 5517.668939863621, 3454.998050565333, 5543.362513310981, 5575.776968921238, 5580.804671836487, 5820.9708951455395, 6126.632402055869, 6155.230596175478, 6157.6305421674615, 6160.1375807387, 6164.506839452833, 5929.258842644669, 6049.183360246355, 6077.726502307407, 6079.787207447718, 6141.263048434194, 5422.403535611119, 5429.669730915951, 5429.864253393657, 5434.184872269191, 5437.972810135924, 12742.108052436333, 17689.646207075915, 18785.906070469697, 21153.0, 21223.5755284895, 1723.4140392266563, 1839.3930003098944, 1903.7810651775085, 1903.9528259457243, 2119.2158901206653, 9065.864012039825, 9172.312076594215, 9228.307876909192, 9289.349745517817, 9562.378445401097, 1653.1475491415774, 1663.534210421084, 1727.196853463133, 1756.771619689432, 1767.6818172728904, 47239.291410628866, 62633.373666263666, 64246.67876660633, 64705.676471617815, 72321.63839180823, 8877.467351958903, 8973.0, 9049.0, 9079.182873541413, 10070.949645251727, 11958.940205299092, 12008.519659213709, 12025.158238923366, 12030.39848007596, 12043.337616431181, 6842.794716158523, 6960.79117626472, 7036.859262814817, 7091.6454177290925, 7143.071400717873, 6790.660466976631, 6862.519623626398, 6973.965130174317, 6994.825129371807, 7032.0, 3721.6650501455, 3757.6242375762754, 3780.1494663700446, 3809.732442470635, 3911.5110611173604, 1818.7453756474104, 1865.2538984406074, 1870.925162993465, 1871.3543827379533, 1876.9155388007573, 721.5670597641373, 790.4506368074133, 855.3285670748432, 884.3632584539122, 947.990520094804, 16853.410130645614, 17172.484825455256, 17572.736408953875, 17929.7310540342, 18154.18306176199, 833.954132522705, 835.1481488881307, 844.273924424994, 845.2688424512875, 848.6435697007148, 9284.489353085644, 9436.95281523588, 9766.804663906682, 9886.110250077527, 10069.647562335284, 382308.0, 385716.0, 413689.0, 415703.0, 424944.0, 79154.0, 79183.0, 83671.0, 89846.0, 90865.0, 868.4832524647825, 911.2209061252667, 930.2046750028763, 931.8974912759727, 936.480253459323, 14948.515445366129, 15526.9223653881, 16465.094419807025, 16618.418355357506, 16715.414960476326, 38165.0, 38284.617153828105, 39490.0, 39663.20673586454, 39919.0, 50585.747071264406, 51712.74143629258, 52422.0, 52433.0, 53299.733501332244, 7699.422543309162, 7728.111267204344, 7759.2240775921955, 7875.566843823644, 8178.427510074238, 10429.582816687247, 11061.004509593853, 12049.457774400349, 12188.634340969786, 12861.871381286443, 10063.949680251844, 10138.087572118544, 10162.593496260362, 10288.742781430525, 10320.43237621908, 10567.154627629618, 10691.572337106429, 10714.678559643224, 11048.447577621248, 11184.720381990515, 9637.566309516229, 9644.903550964682, 9659.565319560495, 10209.642662506776, 11015.284006539548, 7734.0, 7859.4891332063235, 7883.290503854451, 7891.921080789119, 8103.189681032086, 7486.353002339477, 9625.51872406391, 9674.226061915171, 9728.9027109728, 10006.09945104944], "value": 8152.17240902316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1185.9881401185985, 1338.4913732781545, 1376.0, 1440.5894320118769, 1656.5692919840844, 6564.638944858031, 7415.592142432164, 7684.577348245844, 7686.192949740273, 7917.0, 7723.111842138156, 7822.530648161114, 7836.412269079813, 7837.4121940854375, 7839.608019599026, 2166.1985065525737, 2182.0, 2190.7371115466167, 2193.2214064007285, 2198.263581700124, 2150.354893531942, 2197.21998690465, 2218.234709025384, 2220.9333719988426, 2225.1766846266905, 2156.471664442206, 2178.901949412272, 2182.0, 2192.6272533669317, 2194.58302922445, 2121.352987338861, 2132.2537112010828, 2133.8506304558687, 2139.465133716571, 2140.2081229944943, 2059.8970051497513, 2119.5548934723724, 2121.5120522279963, 2125.0, 2146.162996431393, 7683.308502234826, 7691.423143264277, 7756.883646745303, 7838.137804841463, 7840.568768717718, 4320.13597280542, 4498.730076195438, 4503.774811259424, 4510.954890451087, 4512.887177820548, 2733.3576609496754, 2900.0864727610733, 2947.5726019727235, 2960.037987654021, 2961.970380296191, 883.7039591736776, 894.0478390514147, 904.841652710773, 905.5472263868066, 928.517171071046, 10717.46412679363, 10803.0, 10817.783644327148, 10821.404822734747, 10836.241463097585, 3874.1089549403796, 3999.7600143991453, 4124.484439445069, 4186.079062606222, 4260.2970509866145, 8476.27951624119, 8495.428345756054, 8496.192861678132, 8556.358273129541, 8597.226249637562, 4371.060222052274, 4372.038151606642, 4373.3877257183385, 4374.606285434263, 4375.190589740908, 3408.471686888536, 3952.3873799561115, 4034.374671925856, 4060.817263223162, 4125.1131006833675, 3352.379809735207, 3373.5614370132216, 3478.4260597001717, 3478.91302717429, 3485.72114230866, 1018.6485662446444, 1036.9533370998172, 1047.4029803012363, 1048.842673598951, 1048.8531605575226, 729.6023667101442, 839.1273076001013, 841.6507149532998, 871.5337294547387, 874.5190145419994, 5196.402413722395, 5250.921236181461, 5284.816117493474, 5390.64960777556, 5510.531604813636, 412.3093817855081, 412.4761552827892, 416.07008336368193, 418.6044188242143, 421.30695006713785, 3729.757565758217, 3797.7721336719887, 3819.8472061117245, 3822.980885095557, 3901.843926242975, 9285.0, 9732.90267097334, 9735.075167859042, 9759.853602195974, 9777.413355198569, 9460.8580871287, 9595.616175352907, 9664.323497355259, 9692.22462203022, 9754.170895473822, 7272.200057993617, 7327.340539351484, 7332.633368331562, 7373.373263272575, 7427.8143046424275, 5274.736263186748, 5275.973620131875, 5366.087765080024, 5375.865603359947, 5379.085555455504, 8763.430377025474, 8865.423747456394, 8908.331875109263, 8950.0, 9007.954960225157, 8995.460272383678, 9044.819103618023, 9147.993720690853, 9180.540972951192, 9191.03494133133, 5631.605787594829, 6159.784407545714, 6308.243010838729, 6402.6158430494315, 6408.871822563429, 7147.106611673541, 7461.664225109775, 7468.775936721907, 7476.4018878488505, 7488.0, 6516.218053833571, 6543.995641298658, 6566.343365663395, 6740.797776066725, 6744.865102698017, 6309.3690630936535, 6317.178766760292, 6489.967550162408, 6570.375814297634, 6618.271990080991, 6151.507879369729, 6218.751249949952, 6234.844128896632, 6240.188775459162, 6246.375362463899, 4659.487456379863, 4799.66402351832, 4816.686915350631, 4860.17377045896, 4893.877653058702, 4652.8138874445995, 4680.695754776065, 4717.528247175255, 4758.619310455086, 4801.685708748043], "value": 3998.5928465018155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.36922455210805, 290.4380024652297, 297.7945217799719, 300.7533822265743, 302.20670739309315, 4740.336352910586, 4889.951100488994, 4951.232558953359, 4952.380952380952, 4974.507647705687, 4704.894349827788, 4805.543473370033, 4857.202834951064, 4859.271109333602, 4861.8055277788935, 3782.2813665403623, 3793.6965042796646, 3812.637799409066, 3813.733038687286, 3823.5220597425323, 3612.313660404528, 3624.7825130492256, 3795.5065841440573, 3821.789801560913, 3826.7321287509885, 3778.622137786227, 3810.3522401191863, 3820.9808950955344, 3822.617738226169, 3826.5025546678894, 3815.923681526368, 3823.9808800956093, 3824.6175382461947, 3826.253880493305, 3837.213371258913, 3352.664733526628, 3363.327334533103, 3370.292238629866, 3371.3088816792497, 3383.204946837491, 4583.72497650142, 4705.12955103307, 4709.0, 4723.055388922229, 4824.469308376076, 4312.9137417251795, 4328.696991210617, 4335.284678028122, 4362.1275744851155, 4365.759883206422, 5034.748262586856, 5044.218146187347, 5046.0, 5050.646454748169, 5106.872328191787, 3563.1626567756557, 3611.0, 3639.4532323762296, 3666.431703086026, 3669.7798132112157, 5249.790008399659, 5282.445343238943, 5284.392294886099, 5297.5232229099565, 5367.1680889462195, 3718.163413232001, 3721.2743515014854, 3721.739478236552, 3723.888283351504, 3726.366517691945, 3766.4915236443276, 3766.981165094157, 3815.8855234343014, 3822.8149273725235, 3828.0812604974603, 4157.272477316457, 4261.083866968616, 4273.585424235297, 4288.463942007249, 4292.5707429257445, 5010.949890501121, 5032.823851165192, 5035.949640503622, 5036.32009678696, 5067.199600299775, 1240.6526172671665, 1271.8918891894293, 1273.070658419359, 1296.2999980010688, 1322.530501671912, 800.2717527050356, 821.4003777242647, 883.9337049721297, 903.7695387676232, 907.6641642592151, 4411.7573533455325, 4415.646748260131, 4423.889402764957, 4433.623142032899, 4445.333200019958, 5155.61332900034, 5172.172452407597, 5182.144946083854, 5182.585393168538, 5193.84418467439, 4314.374415709767, 4521.0, 4531.592156705912, 4573.611243044378, 4585.862424127282, 2791.581262810554, 2805.6773471050683, 2806.9017584384856, 2809.8314101153996, 2811.5801520232153, 4757.762111894392, 4985.277134815431, 4987.526185012418, 4999.975000124976, 5005.624578156653, 5251.632385733038, 5300.814471493556, 5312.707801070978, 5323.733813309319, 5369.530016192517, 4911.327416833563, 4936.555709986119, 4938.75306234694, 4957.934044180519, 5001.224810154432, 5138.353747819801, 5230.2677625131755, 5278.313819203479, 5291.708956007303, 5325.600579956596, 5156.1492353761205, 5161.380634323755, 5164.870878228075, 5172.637915345889, 5204.219367094966, 4936.753162341796, 4963.31247375894, 4968.925466118083, 4993.550580447777, 4993.650444468853, 3576.7675101118343, 3674.283514714605, 3675.0, 3682.8710995115043, 3688.723345749026, 5146.871328216675, 5187.533122019036, 5202.453742356998, 5224.50367215114, 5251.658642188246, 5037.748112594429, 5055.418626857959, 5066.620003499678, 5110.284560161506, 5135.974320128375, 4891.730954797378, 5098.745062746922, 5108.719020453762, 5121.411037730709, 5146.665466744649, 4766.761661916959, 4844.4186697596515, 4972.403311602631, 4995.700257984533, 5001.174806156943, 5097.796088156432, 5114.948850511447, 5142.151544995184, 5145.61407894402, 5185.718283955048, 5028.924566131438, 5035.446100928822, 5044.965782014605, 5059.392872855281, 5067.13858644024], "value": 3835.077476850659, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.3304051658265, 569.4021277658458, 623.3236937922354, 704.6089420371695, 716.3230746944137, 11691.532338706453, 12605.243685378884, 12663.11358204926, 12698.301593412358, 12799.104062715614, 12416.565420210294, 12553.18404303722, 12555.811662825065, 12576.937115314433, 12798.04014698899, 616.910547970544, 722.5664601239267, 745.124478737484, 746.0413368821053, 749.4678778067552, 775.1318523253935, 777.1451403456209, 777.8172129549552, 778.0857492446381, 778.3734094054284, 798.3732769775727, 799.6601444386142, 802.5265093594778, 804.9959750201241, 806.4516129032256, 626.0452809465579, 783.2519943453988, 792.3581898662073, 804.505229283992, 805.4281460163292, 596.9611975221596, 597.2385208858697, 597.310106826616, 597.3608239184075, 597.6892016151577, 12142.45358958849, 12158.0, 12162.695932601755, 12190.08574356918, 12206.633800985985, 11683.0, 12183.878161218363, 12537.686557836036, 12855.614331570068, 13087.214767114003, 11772.527769168399, 11794.410279485992, 11798.174127811057, 12310.0, 12458.81311780324, 3931.0761970936805, 3970.980145099285, 3999.3800960851113, 4048.4939382577177, 4048.635622793933, 63866.0, 64259.67870160666, 64375.67812160909, 64572.3542764571, 65342.67328663326, 9987.750306242257, 10238.12975897057, 10497.370157790558, 10560.155187584975, 10588.841167382496, 20025.297849682942, 20134.19463221484, 20189.596208075756, 20313.79686203119, 20506.487337816674, 6254.499640028786, 6320.652364120017, 6392.968035159794, 6513.348665133543, 6847.452203823682, 3463.290025544757, 3470.236547959445, 3474.652534746505, 3507.210877552581, 3526.5062891195253, 2676.130257666266, 2768.9446211075665, 2790.7209279072335, 2791.2045067155764, 2800.1599520143877, 513.0636588226502, 515.7730598536632, 516.1818517649492, 521.6869878073202, 528.5903424845699, 476.3973573429614, 502.97736601853006, 505.919052951526, 509.80882169186555, 510.9233614957786, 7339.59632220233, 7345.853082938312, 7384.852302953911, 7761.340286075634, 7932.920670793334, 412.7729748638297, 416.44404719698935, 503.1722815967786, 516.7106420404585, 526.5340173946008, 3656.780593164419, 3682.5212722345923, 3816.2367526494813, 3817.6373244541724, 3903.512060992376, 93276.0, 100366.0, 101519.49240253899, 107687.0, 111978.44010780058, 78718.60640696759, 79179.0, 79984.20015799768, 81218.18781812106, 82170.58914705388, 69393.0, 70283.64858175676, 71375.28624713686, 71505.0, 72351.2764872355, 7848.0, 7943.364530837634, 8417.326613870753, 8631.43895646781, 8661.566921653766, 42045.0, 42581.36127958021, 43274.6433106379, 43315.78342108269, 45069.0, 51896.74051629718, 62936.37063629305, 63302.36697632965, 63745.68127159335, 64565.35434645781, 10861.294015888941, 11047.668569942914, 11282.887171128184, 11318.94340528292, 11841.171118021655, 12105.636830895088, 12274.202176858476, 12364.319962402154, 12527.749445011232, 12536.874631253571, 6598.802035938929, 10942.343459392461, 11287.831765026991, 11309.321440713584, 11340.94329528347, 11333.886661133283, 11439.885601143882, 11463.426828658701, 12102.45538950767, 12103.878961210276, 9870.851937220803, 10299.897001029894, 10567.313124646873, 10903.836442453528, 10958.068564172134, 9397.453297142065, 9734.853977190489, 10069.798604028025, 10157.695269141937, 10279.640212592523, 9229.215516681157, 9649.46927918943, 9776.0, 9777.266704997011, 9784.9021509784], "value": 6385.7665328657695, "unit": "score"}], "name": "dromaeo_css", "value": 6279.800296155172, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 116.0, 116.0, 109.0, 114.0, 115.0, 114.0, 115.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 125.0, 195.0, 123.0, 127.0, 154.0, 120.0, 194.0, 127.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 163.0, 162.0, 162.0, 163.0, 163.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 113.0, 76.0, 76.0, 75.0, 76.0, 133.0, 75.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 140.0, 86.0, 86.0, 85.0, 118.0, 86.0, 86.0, 122.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 66.0, 65.0, 74.0, 67.0, 66.0, 65.0, 66.0, 66.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 90.0, 88.0, 83.0, 82.0, 81.0, 82.0, 82.0, 85.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 140.0, 132.0, 133.0, 141.0, 138.0, 132.0, 138.0, 149.0, 132.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 171.0, 172.0, 171.0, 174.0, 170.0, 170.0, 172.0, 171.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 67.0, 67.0, 66.0, 67.0, 69.0, 74.0, 67.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1553.8999999999999, "alertThreshold": 2.0}]} 00:34:09 INFO - Return code: 0 00:34:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:34:09 INFO - # TBPL SUCCESS # 00:34:09 INFO - Running post-action listener: _resource_record_post_action 00:34:09 INFO - [mozharness: 2016-08-18 07:34:09.902913Z] Finished run-tests step (success) 00:34:09 INFO - Running post-run listener: _resource_record_post_run 00:34:09 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 396455936; Read time: 16; Write time: 258092 00:34:09 INFO - TinderboxPrint: CPU usage
13.0% 00:34:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 00:34:09 INFO - TinderboxPrint: I/O write bytes / time
396,455,936 / 258,092 00:34:09 INFO - TinderboxPrint: CPU idle
8,334.3 (87.0%) 00:34:09 INFO - TinderboxPrint: CPU user
1,200.7 (12.5%) 00:34:09 INFO - TinderboxPrint: Swap in / out
0 / 0 00:34:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114352128; Read time: 0; Write time: 92300 00:34:10 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 282103808; Read time: 0; Write time: 165792 00:34:10 INFO - Running post-run listener: _upload_blobber_files 00:34:10 INFO - Blob upload gear active. 00:34:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:34:10 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 00:34:10 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'] 00:34:10 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 00:34:10 INFO - (blobuploader) - INFO - Open directory for files ... 00:34:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:34:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:34:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:34:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:34:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:34:11 INFO - (blobuploader) - INFO - Done attempting. 00:34:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:34:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:34:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:34:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:34:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:34:14 INFO - (blobuploader) - INFO - Done attempting. 00:34:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:34:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:34:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:34:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:34:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:34:15 INFO - (blobuploader) - INFO - Done attempting. 00:34:15 INFO - (blobuploader) - INFO - Iteration through files over. 00:34:15 INFO - Return code: 0 00:34:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:34:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:34:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ae1d187b579c29016db2a804b38adee4fb63a840a8566f8a5863f297ce5a2b955b8e12402843bf7ce3f8ed04ff27ba08816cf64b9b0c51db2cdd586e5fedf9f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f25671879755f728462d66bfbad05ef35c497bff0ecefd87b4bf1403253d8e65f4259056f5ab89817a7952476aee4cd2b5031a77ae14ca9a48a1aba61a237077", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a2930a928e075166d8883884c9f853395b756ec7d3ec373ae10465560fcbac69e8325c46a710f8feb1bf11efcc16a445b8f64369da4ccdc8f795aeadc104fbac"} 00:34:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:34:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:34:15 INFO - Contents: 00:34:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ae1d187b579c29016db2a804b38adee4fb63a840a8566f8a5863f297ce5a2b955b8e12402843bf7ce3f8ed04ff27ba08816cf64b9b0c51db2cdd586e5fedf9f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f25671879755f728462d66bfbad05ef35c497bff0ecefd87b4bf1403253d8e65f4259056f5ab89817a7952476aee4cd2b5031a77ae14ca9a48a1aba61a237077", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a2930a928e075166d8883884c9f853395b756ec7d3ec373ae10465560fcbac69e8325c46a710f8feb1bf11efcc16a445b8f64369da4ccdc8f795aeadc104fbac"} 00:34:15 INFO - Running post-run listener: copy_logs_to_upload_dir 00:34:15 INFO - Copying logs to upload dir... 00:34:15 INFO - mkdir: /builds/slave/test/build/upload/logs 00:34:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.379066 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-18 00:34:14.839839) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 00:34:14.843390) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794 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/ae1d187b579c29016db2a804b38adee4fb63a840a8566f8a5863f297ce5a2b955b8e12402843bf7ce3f8ed04ff27ba08816cf64b9b0c51db2cdd586e5fedf9f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f25671879755f728462d66bfbad05ef35c497bff0ecefd87b4bf1403253d8e65f4259056f5ab89817a7952476aee4cd2b5031a77ae14ca9a48a1aba61a237077", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a2930a928e075166d8883884c9f853395b756ec7d3ec373ae10465560fcbac69e8325c46a710f8feb1bf11efcc16a445b8f64369da4ccdc8f795aeadc104fbac"} build_url:https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/ZieEt-DnQDWVNDNOOkmguQ/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/ae1d187b579c29016db2a804b38adee4fb63a840a8566f8a5863f297ce5a2b955b8e12402843bf7ce3f8ed04ff27ba08816cf64b9b0c51db2cdd586e5fedf9f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f25671879755f728462d66bfbad05ef35c497bff0ecefd87b4bf1403253d8e65f4259056f5ab89817a7952476aee4cd2b5031a77ae14ca9a48a1aba61a237077", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a2930a928e075166d8883884c9f853395b756ec7d3ec373ae10465560fcbac69e8325c46a710f8feb1bf11efcc16a445b8f64369da4ccdc8f795aeadc104fbac"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 00:34:14.868922) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:34:14.869269) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1471498376.102285-890851794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:34:14.919529) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 00:34:14.920886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 00:34:14.921166) ========= ========= Total master_lag: 0.17 =========