builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1471430011.28 results: success (0) buildid: 20160816133815 builduid: a0ea22c36d5a48e5a6e847d4d0201bdc revision: bb2261b4ac8bcf7ea068e1fc765765985f851dfd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:31.277630) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:31.278107) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:31.278418) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:31.289373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:31.289659) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-17 03:33:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.5M=0s 2016-08-17 03:33:32 (24.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101916 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:31.403513) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:31.403838) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016321 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:31.453288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:31.453651) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev bb2261b4ac8bcf7ea068e1fc765765985f851dfd --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 bb2261b4ac8bcf7ea068e1fc765765985f851dfd --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=6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-17 03:33:32,276 truncating revision to first 12 chars 2016-08-17 03:33:32,277 Setting DEBUG logging. 2016-08-17 03:33:32,277 attempt 1/10 2016-08-17 03:33:32,277 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/bb2261b4ac8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 03:33:32,580 unpacking tar archive at: autoland-bb2261b4ac8b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626259 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:32.093878) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:32.094209) ========= script_repo_revision: bb2261b4ac8bcf7ea068e1fc765765985f851dfd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:32.094582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:32.094844) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 03:33:32.104590) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-17 03:33:32.104869) ========= /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=6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:33:33 INFO - MultiFileLogger online at 20160817 03:33:33 in /builds/slave/test 03:33:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 03:33:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:33 INFO - {'append_to_log': False, 03:33:33 INFO - 'base_work_dir': '/builds/slave/test', 03:33:33 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 03:33:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:33 INFO - 'branch': 'Autoland-Non-PGO', 03:33:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:33 INFO - 'config_files': ('talos/linux_config.py',), 03:33:33 INFO - 'default_actions': ('clobber', 03:33:33 INFO - 'read-buildbot-config', 03:33:33 INFO - 'download-and-extract', 03:33:33 INFO - 'populate-webroot', 03:33:33 INFO - 'create-virtualenv', 03:33:33 INFO - 'install', 03:33:33 INFO - 'run-tests'), 03:33:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:33 INFO - 'download_minidump_stackwalk': True, 03:33:33 INFO - 'download_symbols': 'ondemand', 03:33:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:33:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:33:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:33:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:33:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:33 INFO - 'installer_path': 'installer.exe', 03:33:33 INFO - 'log_level': 'info', 03:33:33 INFO - 'log_name': 'talos', 03:33:33 INFO - 'log_to_console': True, 03:33:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:33:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:33:33 INFO - 'opt_config_files': (), 03:33:33 INFO - 'pip_index': False, 03:33:33 INFO - 'sps_profile': False, 03:33:33 INFO - 'sps_profile_interval': 0, 03:33:33 INFO - 'suite': 'dromaeojs', 03:33:33 INFO - 'system_bits': '32', 03:33:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:33 INFO - 'title': 'talos-linux64-ix-023', 03:33:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:33 INFO - 'use_talos_json': True, 03:33:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:33 INFO - 'work_dir': 'build'} 03:33:33 INFO - [mozharness: 2016-08-17 10:33:33.026767Z] Running clobber step. 03:33:33 INFO - Running pre-action listener: _resource_record_pre_action 03:33:33 INFO - Running main action method: clobber 03:33:33 INFO - rmtree: /builds/slave/test/build 03:33:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:33 INFO - Running post-action listener: _resource_record_post_action 03:33:33 INFO - [mozharness: 2016-08-17 10:33:33.518215Z] Finished clobber step (success) 03:33:33 INFO - [mozharness: 2016-08-17 10:33:33.518316Z] Running read-buildbot-config step. 03:33:33 INFO - Running pre-action listener: _resource_record_pre_action 03:33:33 INFO - Running main action method: read_buildbot_config 03:33:33 INFO - Using buildbot properties: 03:33:33 INFO - { 03:33:33 INFO - "project": "", 03:33:33 INFO - "product": "firefox", 03:33:33 INFO - "script_repo_revision": "production", 03:33:33 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:33:33 INFO - "repository": "", 03:33:33 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 03:33:33 INFO - "buildid": "20160816133815", 03:33:33 INFO - "pgo_build": "False", 03:33:33 INFO - "basedir": "/builds/slave/test", 03:33:33 INFO - "buildnumber": 407, 03:33:33 INFO - "slavename": "talos-linux64-ix-023", 03:33:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:33:33 INFO - "platform": "ubuntu64_hw", 03:33:33 INFO - "scheduler": "tests-autoland-linux64-talos-7-3600", 03:33:33 INFO - "branch": "autoland", 03:33:33 INFO - "repo_path": "integration/autoland", 03:33:33 INFO - "revision": "bb2261b4ac8bcf7ea068e1fc765765985f851dfd", 03:33:33 INFO - "stage_platform": "linux64", 03:33:33 INFO - "builduid": "a0ea22c36d5a48e5a6e847d4d0201bdc", 03:33:33 INFO - "slavebuilddir": "test" 03:33:33 INFO - } 03:33:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 03:33:33 INFO - Running post-action listener: _resource_record_post_action 03:33:33 INFO - [mozharness: 2016-08-17 10:33:33.520744Z] Finished read-buildbot-config step (success) 03:33:33 INFO - [mozharness: 2016-08-17 10:33:33.520833Z] Running download-and-extract step. 03:33:33 INFO - Running pre-action listener: _resource_record_pre_action 03:33:33 INFO - Running main action method: download_and_extract 03:33:33 INFO - mkdir: /builds/slave/test/build/tests 03:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:33 INFO - trying https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:33:33 INFO - Downloading https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/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 03:33:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/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 03:33:34 INFO - Downloaded 1361 bytes. 03:33:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:33:34 INFO - Using the following test package requirements: 03:33:34 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:33:34 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:33:34 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:33:34 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:34 INFO - u'jsshell-linux-x86_64.zip'], 03:33:34 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:33:34 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:33:34 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:33:34 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:33:34 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:33:34 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:33:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:34 INFO - trying https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:33:34 INFO - Downloading https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/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 03:33:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/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 03:33:37 INFO - Downloaded 20269096 bytes. 03:33:37 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 03:33:42 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 03:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:42 INFO - trying https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:33:42 INFO - Downloading https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/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 03:33:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/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 03:33:43 INFO - Downloaded 20269096 bytes. 03:33:43 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 03:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:47 INFO - trying https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:33:47 INFO - Downloading https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/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 03:33:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/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 03:33:48 INFO - Downloaded 14413719 bytes. 03:33:48 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 03:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:48 INFO - trying https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:33:48 INFO - Downloading https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/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 03:33:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/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 03:33:49 INFO - Downloaded 55643230 bytes. 03:33:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:33:49 INFO - mkdir: /builds/slave/test/properties 03:33:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:49 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:49 INFO - Contents: 03:33:49 INFO - build_url:https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:33:50 INFO - Running post-action listener: _resource_record_post_action 03:33:50 INFO - Running post-action listener: set_extra_try_arguments 03:33:50 INFO - [mozharness: 2016-08-17 10:33:50.498700Z] Finished download-and-extract step (success) 03:33:50 INFO - [mozharness: 2016-08-17 10:33:50.498923Z] Running populate-webroot step. 03:33:50 INFO - Running pre-action listener: _resource_record_pre_action 03:33:50 INFO - Running main action method: populate_webroot 03:33:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:33:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:33:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:33:50 INFO - '--tppagecycles', 03:33:50 INFO - '7'], 03:33:50 INFO - 'tests': ['tsvgm']}}, 03:33:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:33:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:33:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:33:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:33:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:50 INFO - 'talos_options': ['--disable-e10s'], 03:33:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:50 INFO - 'talos_options': ['--disable-e10s'], 03:33:50 INFO - 'tests': ['damp', 'tps']}, 03:33:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:50 INFO - 'tests': ['damp', 'tps']}, 03:33:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:33:50 INFO - 'tests': ['dromaeo_dom']}, 03:33:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:33:50 INFO - 'tests': ['basic_compositor_video']}, 03:33:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:33:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:33:50 INFO - 'tests': ['a11yr', 03:33:50 INFO - 'ts_paint', 03:33:50 INFO - 'tpaint', 03:33:50 INFO - 'sessionrestore', 03:33:50 INFO - 'sessionrestore_no_auto_restore', 03:33:50 INFO - 'tabpaint']}, 03:33:50 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:50 INFO - 'ts_paint', 03:33:50 INFO - 'tpaint', 03:33:50 INFO - 'sessionrestore', 03:33:50 INFO - 'sessionrestore_no_auto_restore', 03:33:50 INFO - 'tabpaint']}, 03:33:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:33:50 INFO - 'ts_paint', 03:33:50 INFO - 'tpaint', 03:33:50 INFO - 'sessionrestore', 03:33:50 INFO - 'sessionrestore_no_auto_restore', 03:33:50 INFO - 'tabpaint']}, 03:33:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:33:50 INFO - 'ts_paint', 03:33:50 INFO - 'tpaint', 03:33:50 INFO - 'sessionrestore', 03:33:50 INFO - 'sessionrestore_no_auto_restore', 03:33:50 INFO - 'tabpaint']}, 03:33:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:33:50 INFO - 'tests': ['a11yr', 03:33:50 INFO - 'ts_paint', 03:33:50 INFO - 'tpaint', 03:33:50 INFO - 'sessionrestore', 03:33:50 INFO - 'sessionrestore_no_auto_restore', 03:33:50 INFO - 'tabpaint']}, 03:33:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:33:50 INFO - 'tests': ['a11yr', 03:33:50 INFO - 'ts_paint', 03:33:50 INFO - 'tpaint', 03:33:50 INFO - 'sessionrestore', 03:33:50 INFO - 'sessionrestore_no_auto_restore', 03:33:50 INFO - 'tabpaint']}, 03:33:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:33:50 INFO - 'tests': ['tsvgx', 03:33:50 INFO - 'tsvgr_opacity', 03:33:50 INFO - 'tart', 03:33:50 INFO - 'tscrollx', 03:33:50 INFO - 'cart']}, 03:33:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:50 INFO - 'tsvgr_opacity', 03:33:50 INFO - 'tart', 03:33:50 INFO - 'tscrollx', 03:33:50 INFO - 'cart']}, 03:33:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:50 INFO - 'talos_options': ['--disable-e10s'], 03:33:50 INFO - 'tests': ['tp5o']}, 03:33:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:50 INFO - 'tests': ['tp5o']}, 03:33:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:50 INFO - 'talos_options': ['--disable-e10s', 03:33:50 INFO - '--xperf_path', 03:33:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:50 INFO - 'tests': ['tp5n']}, 03:33:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:50 INFO - 'talos_options': ['--xperf_path', 03:33:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:50 INFO - 'tests': ['tp5n']}}, 03:33:50 INFO - 'talos.zip': {'path': '', 03:33:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:33:50 INFO - Running post-action listener: _resource_record_post_action 03:33:50 INFO - [mozharness: 2016-08-17 10:33:50.518857Z] Finished populate-webroot step (success) 03:33:50 INFO - [mozharness: 2016-08-17 10:33:50.518946Z] Running create-virtualenv step. 03:33:50 INFO - Running pre-action listener: _resource_record_pre_action 03:33:50 INFO - Running main action method: create_virtualenv 03:33:50 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:33:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:50 INFO - Using real prefix '/usr' 03:33:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:53 INFO - Installing pip.................done. 03:33:53 INFO - Return code: 0 03:33:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbea60a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1292230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c090>, '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 0x128f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:33: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', 'pip>=1.5'] in /builds/slave/test/build 03:33: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 pip>=1.5 03:33:53 INFO - Using env: {'DISPLAY': ':0', 03:33:53 INFO - 'HOME': '/home/cltbld', 03:33:53 INFO - 'LANG': 'en_US.UTF-8', 03:33:53 INFO - 'LANGUAGE': 'en_US:en', 03:33:53 INFO - 'LOGNAME': 'cltbld', 03:33:53 INFO - 'MAIL': '/var/mail/cltbld', 03:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:53 INFO - 'MOZ_NO_REMOTE': '1', 03:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:53 INFO - 'NO_EM_RESTART': '1', 03:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:53 INFO - 'PWD': '/builds/slave/test', 03:33:53 INFO - 'SHELL': '/bin/bash', 03:33:53 INFO - 'SHLVL': '1', 03:33:53 INFO - 'TERM': 'linux', 03:33:53 INFO - 'TMOUT': '86400', 03:33:53 INFO - 'USER': 'cltbld', 03:33:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 03:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:53 INFO - '_': '/tools/buildbot/bin/python'} 03:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:33:53 INFO - Cleaning up... 03:33:53 INFO - Return code: 0 03:33:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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', '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 0x7fbea60a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1292230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c090>, '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 0x128f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:33: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:33: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 psutil>=3.1.1 03:33:53 INFO - Using env: {'DISPLAY': ':0', 03:33:53 INFO - 'HOME': '/home/cltbld', 03:33:53 INFO - 'LANG': 'en_US.UTF-8', 03:33:53 INFO - 'LANGUAGE': 'en_US:en', 03:33:53 INFO - 'LOGNAME': 'cltbld', 03:33:53 INFO - 'MAIL': '/var/mail/cltbld', 03:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:53 INFO - 'MOZ_NO_REMOTE': '1', 03:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:53 INFO - 'NO_EM_RESTART': '1', 03:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:53 INFO - 'PWD': '/builds/slave/test', 03:33:53 INFO - 'SHELL': '/bin/bash', 03:33:53 INFO - 'SHLVL': '1', 03:33:53 INFO - 'TERM': 'linux', 03:33:53 INFO - 'TMOUT': '86400', 03:33:53 INFO - 'USER': 'cltbld', 03:33:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 03:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:53 INFO - '_': '/tools/buildbot/bin/python'} 03:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:53 INFO - Downloading/unpacking psutil>=3.1.1 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:55 INFO - Installing collected packages: psutil 03:33:55 INFO - Running setup.py install for psutil 03:33:55 INFO - building 'psutil._psutil_linux' extension 03:33:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:33:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:33:55 INFO - building 'psutil._psutil_posix' extension 03:33:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:33:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:33:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:56 INFO - Successfully installed psutil 03:33:56 INFO - Cleaning up... 03:33:56 INFO - Return code: 0 03:33:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbea60a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1292230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c090>, '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 0x128f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:33:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:33:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:33:56 INFO - Using env: {'DISPLAY': ':0', 03:33:56 INFO - 'HOME': '/home/cltbld', 03:33:56 INFO - 'LANG': 'en_US.UTF-8', 03:33:56 INFO - 'LANGUAGE': 'en_US:en', 03:33:56 INFO - 'LOGNAME': 'cltbld', 03:33:56 INFO - 'MAIL': '/var/mail/cltbld', 03:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:56 INFO - 'MOZ_NO_REMOTE': '1', 03:33:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:56 INFO - 'NO_EM_RESTART': '1', 03:33:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:56 INFO - 'PWD': '/builds/slave/test', 03:33:56 INFO - 'SHELL': '/bin/bash', 03:33:56 INFO - 'SHLVL': '1', 03:33:56 INFO - 'TERM': 'linux', 03:33:56 INFO - 'TMOUT': '86400', 03:33:56 INFO - 'USER': 'cltbld', 03:33:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 03:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:56 INFO - '_': '/tools/buildbot/bin/python'} 03:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:58 INFO - Installing collected packages: mozsystemmonitor 03:33:58 INFO - Running setup.py install for mozsystemmonitor 03:33:58 INFO - Successfully installed mozsystemmonitor 03:33:58 INFO - Cleaning up... 03:33:58 INFO - Return code: 0 03:33:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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', '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 0x7fbea60a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1292230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c090>, '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 0x128f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:33: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:33: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 jsonschema==2.5.1 03:33:58 INFO - Using env: {'DISPLAY': ':0', 03:33:58 INFO - 'HOME': '/home/cltbld', 03:33:58 INFO - 'LANG': 'en_US.UTF-8', 03:33:58 INFO - 'LANGUAGE': 'en_US:en', 03:33:58 INFO - 'LOGNAME': 'cltbld', 03:33:58 INFO - 'MAIL': '/var/mail/cltbld', 03:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:58 INFO - 'MOZ_NO_REMOTE': '1', 03:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:58 INFO - 'NO_EM_RESTART': '1', 03:33:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:58 INFO - 'PWD': '/builds/slave/test', 03:33:58 INFO - 'SHELL': '/bin/bash', 03:33:58 INFO - 'SHLVL': '1', 03:33:58 INFO - 'TERM': 'linux', 03:33:58 INFO - 'TMOUT': '86400', 03:33:58 INFO - 'USER': 'cltbld', 03:33:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 03:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:58 INFO - '_': '/tools/buildbot/bin/python'} 03:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:58 INFO - Downloading/unpacking jsonschema==2.5.1 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:34:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:00 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:00 INFO - warning: no files found matching '*.txt' 03:34:00 INFO - no previously-included directories found matching 'build' 03:34:00 INFO - no previously-included directories found matching 'dist' 03:34:00 INFO - no previously-included directories found matching '.git*' 03:34:00 INFO - Installing collected packages: jsonschema, functools32 03:34:00 INFO - Running setup.py install for functools32 03:34:00 INFO - warning: no files found matching '*.txt' 03:34:00 INFO - no previously-included directories found matching 'build' 03:34:00 INFO - no previously-included directories found matching 'dist' 03:34:00 INFO - no previously-included directories found matching '.git*' 03:34:00 INFO - Successfully installed jsonschema functools32 03:34:00 INFO - Cleaning up... 03:34:00 INFO - Return code: 0 03:34:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:00 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 0x7fbea60a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1292230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c090>, '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 0x128f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:34:00 INFO - Using env: {'DISPLAY': ':0', 03:34:00 INFO - 'HOME': '/home/cltbld', 03:34:00 INFO - 'LANG': 'en_US.UTF-8', 03:34:00 INFO - 'LANGUAGE': 'en_US:en', 03:34:00 INFO - 'LOGNAME': 'cltbld', 03:34:00 INFO - 'MAIL': '/var/mail/cltbld', 03:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:00 INFO - 'MOZ_NO_REMOTE': '1', 03:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:00 INFO - 'NO_EM_RESTART': '1', 03:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:00 INFO - 'PWD': '/builds/slave/test', 03:34:00 INFO - 'SHELL': '/bin/bash', 03:34:00 INFO - 'SHLVL': '1', 03:34:00 INFO - 'TERM': 'linux', 03:34:00 INFO - 'TMOUT': '86400', 03:34:00 INFO - 'USER': 'cltbld', 03:34:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 03:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:00 INFO - '_': '/tools/buildbot/bin/python'} 03:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:34:01 INFO - Cleaning up... 03:34:01 INFO - Return code: 0 03:34:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbea60a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1292230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c090>, '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 0x128f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:34:01 INFO - Using env: {'DISPLAY': ':0', 03:34:01 INFO - 'HOME': '/home/cltbld', 03:34:01 INFO - 'LANG': 'en_US.UTF-8', 03:34:01 INFO - 'LANGUAGE': 'en_US:en', 03:34:01 INFO - 'LOGNAME': 'cltbld', 03:34:01 INFO - 'MAIL': '/var/mail/cltbld', 03:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:01 INFO - 'MOZ_NO_REMOTE': '1', 03:34:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:01 INFO - 'NO_EM_RESTART': '1', 03:34:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:01 INFO - 'PWD': '/builds/slave/test', 03:34:01 INFO - 'SHELL': '/bin/bash', 03:34:01 INFO - 'SHLVL': '1', 03:34:01 INFO - 'TERM': 'linux', 03:34:01 INFO - 'TMOUT': '86400', 03:34:01 INFO - 'USER': 'cltbld', 03:34:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 03:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:01 INFO - '_': '/tools/buildbot/bin/python'} 03:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:03 INFO - Downloading docopt-0.6.1.tar.gz 03:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:04 INFO - Running setup.py install for blobuploader 03:34:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:04 INFO - Running setup.py install for requests 03:34:04 INFO - Running setup.py install for docopt 03:34:04 INFO - Successfully installed blobuploader requests docopt 03:34:04 INFO - Cleaning up... 03:34:04 INFO - Return code: 0 03:34:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:04 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 0x7fbea60a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1292230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c090>, '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 0x128f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:04 INFO - Using env: {'DISPLAY': ':0', 03:34:04 INFO - 'HOME': '/home/cltbld', 03:34:04 INFO - 'LANG': 'en_US.UTF-8', 03:34:04 INFO - 'LANGUAGE': 'en_US:en', 03:34:04 INFO - 'LOGNAME': 'cltbld', 03:34:04 INFO - 'MAIL': '/var/mail/cltbld', 03:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:04 INFO - 'MOZ_NO_REMOTE': '1', 03:34:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:04 INFO - 'NO_EM_RESTART': '1', 03:34:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:04 INFO - 'PWD': '/builds/slave/test', 03:34:04 INFO - 'SHELL': '/bin/bash', 03:34:04 INFO - 'SHLVL': '1', 03:34:04 INFO - 'TERM': 'linux', 03:34:04 INFO - 'TMOUT': '86400', 03:34:04 INFO - 'USER': 'cltbld', 03:34:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 03:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:04 INFO - '_': '/tools/buildbot/bin/python'} 03:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:04 INFO - Running setup.py (path:/tmp/pip-DO2EWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:04 INFO - Running setup.py (path:/tmp/pip-W1NK7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:04 INFO - Running setup.py (path:/tmp/pip-d8dWo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:05 INFO - Running setup.py (path:/tmp/pip-UusXGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:05 INFO - Running setup.py (path:/tmp/pip-4LzYpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:05 INFO - Running setup.py (path:/tmp/pip-qBfbXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:05 INFO - Running setup.py (path:/tmp/pip-Ig5r0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:05 INFO - Running setup.py (path:/tmp/pip-y_arqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:05 INFO - Running setup.py (path:/tmp/pip-JRp8rH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:05 INFO - Running setup.py (path:/tmp/pip-TwbinS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:05 INFO - Running setup.py (path:/tmp/pip-L7_QxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:05 INFO - Running setup.py (path:/tmp/pip-qEes6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:05 INFO - Running setup.py (path:/tmp/pip-0x2siI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:05 INFO - Running setup.py (path:/tmp/pip-94bzUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:05 INFO - Running setup.py (path:/tmp/pip-Zzu2FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:05 INFO - Running setup.py (path:/tmp/pip-FxE6dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:05 INFO - Running setup.py (path:/tmp/pip-6tjZ6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:06 INFO - Running setup.py install for manifestparser 03:34:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:06 INFO - Running setup.py install for mozcrash 03:34:06 INFO - Running setup.py install for mozdebug 03:34:06 INFO - Running setup.py install for mozdevice 03:34:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:34:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:06 INFO - Running setup.py install for mozfile 03:34:06 INFO - Running setup.py install for mozhttpd 03:34:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:06 INFO - Running setup.py install for mozinfo 03:34:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:06 INFO - Running setup.py install for mozInstall 03:34:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:06 INFO - Running setup.py install for mozleak 03:34:06 INFO - Running setup.py install for mozlog 03:34:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:07 INFO - Running setup.py install for moznetwork 03:34:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:07 INFO - Running setup.py install for mozprocess 03:34:07 INFO - Running setup.py install for mozprofile 03:34:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:07 INFO - Running setup.py install for mozrunner 03:34:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:07 INFO - Running setup.py install for mozscreenshot 03:34:07 INFO - Running setup.py install for moztest 03:34:07 INFO - Running setup.py install for mozversion 03:34:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:07 INFO - Cleaning up... 03:34:07 INFO - Return code: 0 03:34:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:07 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 0x7fbea60a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1292230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c090>, '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 0x128f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:07 INFO - Using env: {'DISPLAY': ':0', 03:34:07 INFO - 'HOME': '/home/cltbld', 03:34:07 INFO - 'LANG': 'en_US.UTF-8', 03:34:07 INFO - 'LANGUAGE': 'en_US:en', 03:34:07 INFO - 'LOGNAME': 'cltbld', 03:34:07 INFO - 'MAIL': '/var/mail/cltbld', 03:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:07 INFO - 'MOZ_NO_REMOTE': '1', 03:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:07 INFO - 'NO_EM_RESTART': '1', 03:34:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:07 INFO - 'PWD': '/builds/slave/test', 03:34:07 INFO - 'SHELL': '/bin/bash', 03:34:07 INFO - 'SHLVL': '1', 03:34:07 INFO - 'TERM': 'linux', 03:34:07 INFO - 'TMOUT': '86400', 03:34:07 INFO - 'USER': 'cltbld', 03:34:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 03:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:07 INFO - '_': '/tools/buildbot/bin/python'} 03:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:08 INFO - Running setup.py (path:/tmp/pip-35NMYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:08 INFO - Running setup.py (path:/tmp/pip-hjEnDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:08 INFO - Running setup.py (path:/tmp/pip-skaDqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:08 INFO - Running setup.py (path:/tmp/pip-wm9MMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:08 INFO - Running setup.py (path:/tmp/pip-Y_AoAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:08 INFO - Running setup.py (path:/tmp/pip-L7IylU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:08 INFO - Running setup.py (path:/tmp/pip-jmxrYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:08 INFO - Running setup.py (path:/tmp/pip-vkC0U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:08 INFO - Running setup.py (path:/tmp/pip-5LdAK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:08 INFO - Running setup.py (path:/tmp/pip-Q1H9hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:08 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)) 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:08 INFO - Running setup.py (path:/tmp/pip-FZFPNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:08 INFO - Running setup.py (path:/tmp/pip-87E80k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:08 INFO - Running setup.py (path:/tmp/pip-s0NUfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:09 INFO - Running setup.py (path:/tmp/pip-OL1p73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:09 INFO - Running setup.py (path:/tmp/pip-SEyxuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:09 INFO - Running setup.py (path:/tmp/pip-z2V3xN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:09 INFO - Running setup.py (path:/tmp/pip-dk5mUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:11 INFO - Downloading blessings-1.6.tar.gz 03:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:11 INFO - Installing collected packages: blessings 03:34:11 INFO - Running setup.py install for blessings 03:34:11 INFO - Successfully installed blessings 03:34:11 INFO - Cleaning up... 03:34:11 INFO - Return code: 0 03:34:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:11 INFO - Reading from file tmpfile_stdout 03:34:11 INFO - Current package versions: 03:34:11 INFO - argparse == 1.2.1 03:34:11 INFO - blessings == 1.6 03:34:11 INFO - blobuploader == 1.2.4 03:34:11 INFO - docopt == 0.6.1 03:34:11 INFO - functools32 == 3.2.3-2 03:34:11 INFO - jsonschema == 2.5.1 03:34:11 INFO - manifestparser == 1.1 03:34:11 INFO - mozInstall == 1.12 03:34:11 INFO - mozcrash == 0.17 03:34:11 INFO - mozdebug == 0.1 03:34:11 INFO - mozdevice == 0.48 03:34:11 INFO - mozfile == 1.2 03:34:11 INFO - mozhttpd == 0.7 03:34:11 INFO - mozinfo == 0.9 03:34:11 INFO - mozleak == 0.1 03:34:11 INFO - mozlog == 3.3 03:34:11 INFO - moznetwork == 0.27 03:34:11 INFO - mozprocess == 0.23 03:34:11 INFO - mozprofile == 0.28 03:34:11 INFO - mozrunner == 6.12 03:34:11 INFO - mozscreenshot == 0.1 03:34:11 INFO - mozsystemmonitor == 0.3 03:34:11 INFO - moztest == 0.7 03:34:11 INFO - mozversion == 1.4 03:34:11 INFO - psutil == 3.1.1 03:34:11 INFO - requests == 1.2.3 03:34:11 INFO - wsgiref == 0.1.2 03:34:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:11 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 0x7fbea60a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1292230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c090>, '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 0x128f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:11 INFO - Using env: {'DISPLAY': ':0', 03:34:11 INFO - 'HOME': '/home/cltbld', 03:34:11 INFO - 'LANG': 'en_US.UTF-8', 03:34:11 INFO - 'LANGUAGE': 'en_US:en', 03:34:11 INFO - 'LOGNAME': 'cltbld', 03:34:11 INFO - 'MAIL': '/var/mail/cltbld', 03:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:11 INFO - 'MOZ_NO_REMOTE': '1', 03:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:11 INFO - 'NO_EM_RESTART': '1', 03:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:11 INFO - 'PWD': '/builds/slave/test', 03:34:11 INFO - 'SHELL': '/bin/bash', 03:34:11 INFO - 'SHLVL': '1', 03:34:11 INFO - 'TERM': 'linux', 03:34:11 INFO - 'TMOUT': '86400', 03:34:11 INFO - 'USER': 'cltbld', 03:34:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 03:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:11 INFO - '_': '/tools/buildbot/bin/python'} 03:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:34:11 INFO - Cleaning up... 03:34:11 INFO - Return code: 0 03:34:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:11 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 0x7fbea60a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1292230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c090>, '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 0x128f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:34:11 INFO - Using env: {'DISPLAY': ':0', 03:34:11 INFO - 'HOME': '/home/cltbld', 03:34:11 INFO - 'LANG': 'en_US.UTF-8', 03:34:11 INFO - 'LANGUAGE': 'en_US:en', 03:34:11 INFO - 'LOGNAME': 'cltbld', 03:34:11 INFO - 'MAIL': '/var/mail/cltbld', 03:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:11 INFO - 'MOZ_NO_REMOTE': '1', 03:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:11 INFO - 'NO_EM_RESTART': '1', 03:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:11 INFO - 'PWD': '/builds/slave/test', 03:34:11 INFO - 'SHELL': '/bin/bash', 03:34:11 INFO - 'SHLVL': '1', 03:34:11 INFO - 'TERM': 'linux', 03:34:11 INFO - 'TMOUT': '86400', 03:34:11 INFO - 'USER': 'cltbld', 03:34:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 03:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:11 INFO - '_': '/tools/buildbot/bin/python'} 03:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:12 INFO - Cleaning up... 03:34:12 INFO - Return code: 0 03:34:12 INFO - Running post-action listener: _resource_record_post_action 03:34:12 INFO - Running post-action listener: _start_resource_monitoring 03:34:12 INFO - Starting resource monitoring. 03:34:12 INFO - [mozharness: 2016-08-17 10:34:12.150479Z] Finished create-virtualenv step (success) 03:34:12 INFO - [mozharness: 2016-08-17 10:34:12.150943Z] Running install step. 03:34:12 INFO - Running pre-action listener: _resource_record_pre_action 03:34:12 INFO - Running main action method: install 03:34:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:12 INFO - Reading from file tmpfile_stdout 03:34:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:12 INFO - Reading from file tmpfile_stdout 03:34:12 INFO - Output received: 03:34:12 INFO - Usage: mozinstall [options] installer 03:34:12 INFO - Options: 03:34:12 INFO - -h, --help show this help message and exit 03:34:12 INFO - -d DEST, --destination=DEST 03:34:12 INFO - Directory to install application into. [default: 03:34:12 INFO - "/builds/slave/test"] 03:34:12 INFO - --app=APP Application being installed. [default: firefox] 03:34:12 INFO - mkdir: /builds/slave/test/build/application 03:34:12 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'] 03:34:12 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 03:34:28 INFO - Reading from file tmpfile_stdout 03:34:28 INFO - Output received: 03:34:28 INFO - /builds/slave/test/build/application/firefox/firefox 03:34:28 INFO - Running post-action listener: _resource_record_post_action 03:34:28 INFO - [mozharness: 2016-08-17 10:34:28.500770Z] Finished install step (success) 03:34:28 INFO - [mozharness: 2016-08-17 10:34:28.501019Z] Running run-tests step. 03:34:28 INFO - Running pre-action listener: _resource_record_pre_action 03:34:28 INFO - Running main action method: run_tests 03:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:34:28 INFO - Python 2.7.3 03:34:28 INFO - Return code: 0 03:34:28 INFO - grabbing minidump binary from tooltool 03:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:28 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 0x128c090>, '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 0x128f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128fe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:34:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:34:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:34:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:34:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:34:28 INFO - Return code: 0 03:34:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:34:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:34:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:34:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:34:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:34:28 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/bxEpLMzKTJqm7EGJBdTTsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:34:28 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/bxEpLMzKTJqm7EGJBdTTsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:34:28 INFO - Using env: {'DISPLAY': ':0', 03:34:28 INFO - 'HOME': '/home/cltbld', 03:34:28 INFO - 'LANG': 'en_US.UTF-8', 03:34:28 INFO - 'LANGUAGE': 'en_US:en', 03:34:28 INFO - 'LOGNAME': 'cltbld', 03:34:28 INFO - 'MAIL': '/var/mail/cltbld', 03:34:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:28 INFO - 'MOZ_NO_REMOTE': '1', 03:34:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:28 INFO - 'NO_EM_RESTART': '1', 03:34:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:28 INFO - 'PWD': '/builds/slave/test', 03:34:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:28 INFO - 'SHELL': '/bin/bash', 03:34:28 INFO - 'SHLVL': '1', 03:34:28 INFO - 'TERM': 'linux', 03:34:28 INFO - 'TMOUT': '86400', 03:34:28 INFO - 'USER': 'cltbld', 03:34:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520', 03:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:28 INFO - '_': '/tools/buildbot/bin/python'} 03:34:28 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/bxEpLMzKTJqm7EGJBdTTsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:34:28 INFO - mozversion application_buildid: 20160816133815 03:34:28 INFO - mozversion application_changeset: bb2261b4ac8bcf7ea068e1fc765765985f851dfd 03:34:28 INFO - mozversion application_display_name: Nightly 03:34:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:34:28 INFO - mozversion application_name: Firefox 03:34:28 INFO - mozversion application_remotingname: firefox 03:34:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:34:28 INFO - mozversion application_vendor: Mozilla 03:34:28 INFO - mozversion application_version: 51.0a1 03:34:28 INFO - mozversion platform_buildid: 20160816133815 03:34:28 INFO - mozversion platform_changeset: bb2261b4ac8bcf7ea068e1fc765765985f851dfd 03:34:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:34:28 INFO - mozversion platform_version: 51.0a1 03:34:28 INFO - using testdate: 1471430068 03:34:28 INFO - actual date: 1471430068 03:34:28 INFO - starting webserver on 'localhost:45355' 03:34:28 INFO - SUITE-START | Running 2 tests 03:34:28 INFO - TEST-START | dromaeo_css 03:34:28 INFO - operating with platform_type : linux_ 03:34:28 INFO - Initialising browser for dromaeo_css test... 03:34:28 INFO - TEST-INFO | started process 10035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKvAyuO/profile http://localhost:45355/getInfo.html) 03:34:32 INFO - PROCESS | 10035 | __metrics Screen width/height:1600/1200 03:34:32 INFO - PROCESS | 10035 | colorDepth:24 03:34:32 INFO - PROCESS | 10035 | Browser inner width/height: 1024/697 03:34:32 INFO - PROCESS | 10035 | __metrics 03:34:33 INFO - PROCESS | 10035 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:34:33 INFO - PROCESS | 10035 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:34:34 INFO - TEST-INFO | 10035: exit 0 03:34:34 INFO - Browser initialized. 03:34:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:34 INFO - TEST-INFO | started process 10118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKvAyuO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:46 INFO - PROCESS | 10118 | RSS: Main: 157401088 03:34:46 INFO - PROCESS | 10118 | 03:35:38 INFO - PROCESS | 10118 | 1471430138177 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:37:51 INFO - PROCESS | 10118 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45355/tests/dromaeo/cssquery-ext.html) 03:37:52 INFO - PROCESS | 10118 | RSS: Main: 276508672 03:37:52 INFO - PROCESS | 10118 | 03:40:55 INFO - PROCESS | 10118 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-ext.html (next: http://localhost:45355/tests/dromaeo/cssquery-jquery.html) 03:40:55 INFO - PROCESS | 10118 | RSS: Main: 244678656 03:40:55 INFO - PROCESS | 10118 | 03:43:58 INFO - PROCESS | 10118 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45355/tests/dromaeo/cssquery-mootools.html) 03:43:58 INFO - PROCESS | 10118 | RSS: Main: 190091264 03:43:58 INFO - PROCESS | 10118 | 03:47:01 INFO - PROCESS | 10118 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45355/tests/dromaeo/cssquery-prototype.html) 03:47:01 INFO - PROCESS | 10118 | RSS: Main: 189067264 03:47:01 INFO - PROCESS | 10118 | 03:50:04 INFO - PROCESS | 10118 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45355/tests/dromaeo/cssquery-yui.html) 03:50:05 INFO - PROCESS | 10118 | RSS: Main: 190373888 03:50:05 INFO - PROCESS | 10118 | 03:53:08 INFO - PROCESS | 10118 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-yui.html (next: http://localhost:45355/tests/dromaeo/cssquery-dojo.html) 03:53:08 INFO - PROCESS | 10118 | RSS: Main: 278192128 03:53:08 INFO - PROCESS | 10118 | 03:53:08 INFO - PROCESS | 10118 | __start_tp_report 03:53:08 INFO - PROCESS | 10118 | _x_x_mozilla_page_load 03:53:08 INFO - PROCESS | 10118 | _x_x_mozilla_page_load_details 03:53:08 INFO - PROCESS | 10118 | |i|pagename|runs| 03:53:08 INFO - PROCESS | 10118 | |0;dojo.html;2650.191691534082;2665.680118385794;2681.8390896546207;2698.9055383061595;2700.3654141276797;4610.262358022717;4652.883677908049;4674.252119660855;4684.414448193976;4725.40932383452;4698.318743782158;4700.36545066416;4735.5974742146955;4745.122152401799;4759.976200119003;4293.162833247518;4334;4377.737335759849;4428.756418396987;4497.730136191823;4368.082702632451;4408.14041261954;4442.800073996662;4452.975815562422;4465.307877279027;4219.43037689914;4254.298040823261;4265.402843601898;4327.805248763813;4331.328644060176;4312.913741725148;4320.1143765527995;4320.4599425071865;4323.265044942367;4323.567643235683;4297.892552686177;4298.333758267474;4299.591538803808;4302.397664326997;4321.65426765858;4596.885077873047;4612.446506419217;4626.9074618507775;4645.442546894361;4647.34937108805;4966.6771659842;4967.90064198714;4978.103941290567;5020.422651395063;5029.874253143701;5082.288479612857;5108.106081435771;5111.309973153614;5113.616478764107;5113.974430127862;4568.588827005586;4680.204365257914;4707.976460117678;4730.053989202173;4732.053589282157;5198.038362902875;5198.142306519458;5251.396089449762;5253.737313134328;5254.2118682197215;5033.6224783141415;5035.169197082514;5039.899202015939;5040.647154699136;5043.571296439771;4921.7785199666105;4995.675281106716;5049.596032317406;5051.419086804991;5123.052235336475;5039.042581909425;5040.2691609716385;5047.116754567936;5047.722375269322;5058.570021548209;5026.045051440215;5032.572231360302;5033.597312215014;5034.672746271481;5073.188289873677;4159.833606655699;4196.580341965779;4202.978985105055;4251.404803327537;4254.042840360956;3747.7938713371027;3785.7539259948016;3788.318102741533;3791.8104094795704;3794.4687743715904;4364.956350436519;4392.824287028547;4405.405270288534;4458.888527786767;4465.218586747306;5093.516115968977;5096.872578185575;5100.132977393852;5103.540681338697;5103.668261562986;4421.071574969293;4424.690271680952;4426.18115648606;4427.6236519896165;4469.307257375112;4433.645308375322;4464.308032255006;4495.842645507391;4496.100779844044;4548.226801443762;4743.881402964885;4758.476567577494;4760.262159365304;4761.2382018876815;4802.063597598435;4992.725400102884;5019.146745053423;5056.6713163644245;5061.089003979319;5098.5411312982005;4611.33135695329;4725.456572494207;4755.453122890912;4771.284307353786;4835.468098509091;4980.402351717817;5007.649464537593;5008.6744361616375;5010.799568017239;5055.51972562606;5068.6451948363265;5078.97460512695;5079.441261461162;5079.554791962381;5080.644354895269;4681.578657920803;4851.078295123915;4874;4904.043711476371;4954.256861470808;4914.92627610579;4921.97539012317;4922.704637721748;4925;4967.677100988424;4855.174620314484;4864.051509955525;4908.337374454403;4908.901821963612;4913.975430122827;4763.166445872028;4765.5949244314625;4802.7838747255755;4873.049755297825;4879.268109783561;4760.500147484603;4797.976010119927;4842.685225460334;4848.8302909398;4917.58200552957 03:53:08 INFO - PROCESS | 10118 | |1;ext.html;551.9116941289393;554.6866020698308;559.4629156010228;560.0563051258632;560.5543592843688;28490.715092849066;38483.422748658755;39669;39927.60072399275;43068.56931430685;40516;41077.58922410775;41079;41092.58907410925;41172.38241426374;7302.1967583565765;7600.809979750496;7733.304002639761;7740.690372385126;7742.496737712031;7382.372498337648;7475.476716629838;7483.4013278937555;9638.518074096268;9858.802823943517;9697.95151024244;9738.756531086708;9742.123208911196;9745.805083898318;9747.317687761824;9918.404895706244;9977.451240181786;9986.350887192382;10003.449810260432;10004.649837255698;9684;9756.317057805956;9760.707178784647;9763.072508111718;9766.316357854954;37707.24585508274;37817.62182378169;37991.43012854809;37999.43000854989;38014.80992595047;2917.6644685861183;3033.7876348655604;3202.9679703203137;3275.754318426104;3335.5663763710804;28572.142835714963;28596;29002.854985725146;29132.27169320763;30656.233594160323;3402.6767457091537;3448.6378930212218;3449.344624521333;3467.081223475781;3504.632013638582;181834;182152;182231;182551;182904;50667.49332506628;50749.23876141861;50948;51018.23472647913;51034.23448648273;31169.22076948049;32289;32326.19184520406;33957;33966.32067358639;11952.760944781056;12107.394630268627;12113.697157570956;12246.877531224753;12250.877491224974;8938.955305223562;9020.639174433081;9021.819563608691;9023.368364214442;9031.322650801085;15499;17020.404285849934;17499.38752143669;17561.385351512636;17805.821941780676;6473;6640.703015777949;6746.730130794714;6810.38706516406;6833.300846165736;812.9065157506844;845.2139510255521;964.9469279189711;1004.9095581397563;1026.825439675257;27747.974654674872;27974.44051119007;28768.568471472943;28792.712072879003;28932;944.2681921510747;954.0221273194892;958.6021800952666;993.9254555908336;1046.1839764983324;14617.269136543344;14989.475368362055;15021.924890375696;15054.774178387333;15159.621009474631;405434;406320;409120;409147;409230;47858;48220.5177948216;48548.757256213496;48570;48638.756806215744;1045.9529321180564;1101.752105776194;1126.69016020595;1142.994285028586;1173.9413029348498;26965.865170674806;28575.42849143047;29145.02944318865;29300;29325.560116598695;40493.797531012155;40803.7959810199;40906;40918.79540602278;40969.59030409658;309943;311167;311456;313077;313266;24624.813781657518;25008.249752507454;25449.491010180063;25499.107531236317;34506.47896336574;36101.81949090238;39968.4004739935;41359.586404136775;41409.37885931653;45625.77187114043;35547.82226088853;35579;35763.10592235215;35959.64040359563;36492.45261321135;35553.644463555036;35689.28621427505;35874.64125358713;36183.45724814183;36400.27199456049;34820;35217.47173792344;35698.8215058923;35941.64058359383;36113;30907;32444.762501118617;32503.349933001682;32717;32802.67197327996;24873.875630621733;25121.87439062793;25391.98584502549;25527.6170857441;25724.614130788428 03:53:08 INFO - PROCESS | 10118 | |2;jquery.html;348.51034296812986;351.1887539783101;356.6059504247806;367.2361488104742;370.97217708671855;15754.13352265625;16847.494575162735;17138.22877970491;17226;17256.137193140323;15478.535643930672;16711;17194.656106877854;17330;17350.392736254234;4958.652894297401;5186.611004174702;5188.766505507242;5189.195674670432;5198.792048318062;3708.962910370889;3886.3393223152134;5056.949430505685;5801.361850196475;6048.092786082101;6053;6055.455009049185;6057.3336932937345;6113.969430152843;6120.081987701836;5735.627184233012;5820.097884827858;5845.88308233833;5852.473277405054;5869.178315035899;5083.796648134107;5136.178211486144;5184.248283998837;5195.636305458619;5200.609954253408;20711.792882071288;20761.377158685264;20877.225435837972;20899.68650470244;21075.5784884303;1962.3720409468976;2005.989970050155;2014.2849288502664;2015.536426621885;2026.0781344488223;13139.14595551286;13235.205887646773;13349.799753003712;13574.59276221715;13727.382267797973;1801.3425099838596;1818.6271814278173;1822.6396816123151;1842.9354972575895;1856.5915498590289;66708.6664566679;68022.65988670074;68085.9999999995;68534;70190;9108.316876234308;9170.862437063315;9266.44401335922;9384.95307523458;9634.614615415305;12645.683857903627;12653.051021173265;12660.240385576895;12660.81008784869;12672.556460523838;6391.005325013724;6487.124238227779;6572.572782769104;6574.145361103122;6699.933000670028;5875.089361149029;6032.426919442646;6075.3924607539775;6263.279722831932;6287.874242515216;5834.620749651344;5931.466168044896;5940;5999.880002399927;6110.908336374958;1508.4871143811156;1624.7237969545206;1631.6328826014053;1718.905460199676;1752.4217008387202;826.6032304493876;840.2815592668303;847.6863560482537;915.3638221436171;927.4157280912982;16581.170941452878;16717.582060448585;17092.2308496118;17439;17967.910160449115;829.7386323308139;840.983180336402;847.0470720439506;876.2814492116403;945.9810803784023;9544.284178686627;10196.592136314464;10205.693829185137;10211.285210035227;10228;375015;377182;382395;382411;385937;64864.675676621315;65009.67495162494;65428.67285663637;65663;66075;823.3001948343859;862.5385418800911;896.4486840592988;909.0863681999548;915.5834095486671;15373.923130384277;15835.762463562825;16079.67840643204;16828.66342673164;17119.57201069983;34607.30785384228;34884.47673284852;36338.63661363458;36721;36767.26465470622;47111.29333059938;47278;48436.757816210695;48684.26973595328;53759;7171.784846454615;7630.847383052419;7721.343685786771;7902.510709126606;8091.109977902308;10144.239182061227;12166.939165304117;12286.139970202357;12499.875001249871;12511.160935733084;10483.947580262049;10509.421981791074;10603.840942386025;10863.333383188234;11384.203105782846;10646.095081918123;10781;10855.294405863593;11043.337399756041;11257.71855703614;10593.417362044853;10823.51294191779;10824.512896919816;10894.836577451186;11582.94208528952;7732.38140948734;7835.255650713173;7960.681572737258;7984.441089123706;8095.757127286191;9490.905090949002;10145.28982971185;10302.124319432933;10631.149508039493;11089.112870970142 03:53:08 INFO - PROCESS | 10118 | |3;mootools.html;1295.9481620735173;1350.8108864758935;1366.7471517769213;1615.576635047429;1623.91068491233;7280.12638483382;7886.921130788691;7898.052233731953;7901.881471777928;7919.406044546653;6709.5303328767;6914.481413893953;6929.029935808978;7099.254578269285;7763.883541746878;2097.538541520863;2182.6180418426793;2189.3322536626324;2193.583219188357;2200.7909248621436;2197.6703494475796;2201;2223.144089525528;2227.521082967162;2227.944301392462;2191.024993877725;2192.6053310404122;2198.362474882282;2199.7250343707037;2205.9669104963436;2132.4562236629636;2158;2175.3256490487997;2175.575762726269;2179.052112331141;2098.821600163988;2100.0444797617047;2126.9468263293543;2150.4301360139575;2159.1903036361364;7637;7737.651805668758;7741.032370953631;7742.303192712683;7751.418643601696;4329.848455304081;4459.331100334944;4471.128130014648;4472.08322293929;4477.462704475452;2762.5303698371326;2866.4410439964217;2888.176869592156;2943.867525961337;2949.2626843289177;888.2671795768517;919.4804935211585;926.5506229478698;942.4910548303908;946.3753922411175;10448.52981615829;10498.422586757726;10517.263791534595;10517.421541815198;10527.420991845522;3927.8821635350987;4016.3373043447505;4170.687198460128;4181.644560212355;4186.162767446523;9038.457692538468;9039.954800225956;9051.864222036675;9063.13900179495;9064.456132632064;4335.414719012956;4347.913041739211;4355.303151495746;4356.956430435718;4357.9128417431475;3568.6252943441086;3892.552356479041;3892.9805350973065;3900.2004589059175;3906.2187562487616;3073.969260307413;3604.4593311003036;3636.7999760013454;3690.151265208963;3696.131409118855;1175.3183153770792;1182.3733421286731;1184.5084290019545;1197.820326950947;1201.7055821323656;608.7869245763948;648.8994205898093;719.6689522819457;725;731.0715391452825;4689.742064186503;4704.129735998851;4723.220668589713;4762.761861906891;5123.462036486189;794.6225542867091;844.1134065363907;844.1853611265159;851.6891334662804;855.6962278391206;3290.588676415448;3294.5058241264;3326.600807903019;3377.9493307600405;3451.240727040047;9091.54542272897;9481.857772133424;9583.904160958302;9584.472853993097;9609.231261499064;9149.54252287383;9476.857847132298;9487.383320084311;9545.761355966017;9665.90334096664;7237.63811809418;7297.197308296083;7302.233265507151;7304.5252058616015;7311.268873112753;4674.555917187861;4680.134175177603;4742.383490146259;5157.452764170659;5214.243934629533;8544.102869198645;8592.527410992456;8638.093000234885;8672.219500245008;8720.345974052098;8462.619182136941;8671.21959023691;8751.212390884852;8761.29909607217;8788.16512431318;5993;6360.618362898241;6627.37039981201;6656.833579160366;6780.593164410151;7443.36731377839;7468.402527797872;7523.586202758901;7530.6611202497115;7539.509931854412;6612.90080648781;6627.569208001464;6666.666666666744;6693.1298931138645;6812.14848143982;6497.707603157774;6576.934230657824;6607.53747237708;6626.6686665667485;6631.237407698177;5896;5915.645061296336;5946.821595352147;5974.2233509643465;5975.043992961106;4187.5184353799705;4361.476622805284;4374.212641724393;4377.606015458624;4406.625436837777;4152.875413737593;4330.870073897788;4336.111097224998;4351.021020270414;4380.167768124046 03:53:08 INFO - PROCESS | 10118 | |4;prototype.html;290.8763775395456;296.4057065583505;297.4170625573875;298.05070849344827;303.8181474065884;4801.90396192076;4816.97591512042;4818.397700287464;4831.275308703692;4835.734034628094;4738.9052218955685;4752.833650822222;4758.428988521382;4761.785794588656;4763.571278584926;3555.2178520725465;3667.7982710950887;3688.5389326334207;3713.424419215026;3736.308782875177;3731.253749250161;3742.158014446755;3743.86896458624;3751.911945535805;3772;3710.777353358807;3711.647393497627;3714;3715.3312403767313;3728.459373390857;3597.748157628967;3638.7089032877307;3717.944230836526;3723.454766272021;3735.4210097434943;3285.8192799396024;3294.8187849668257;3304.4469099523426;3313.2710803623163;3318.3197444523817;4645;4650.51169627191;4657.720536767771;4674.69614475058;4684.484706682262;4124.061691005223;4278.893027674302;4299.462567179103;4300.419443375167;4320.13597280542;4968.329275547827;4972.881101752077;4979.47715489872;4988.426330971948;5015.39815222172;3660.158163622355;3661.340958627446;3666.7616604920863;3666.7983260920637;3667.8716244931566;5075.264086707443;5213.452587478336;5261.684298942076;5264.657512334368;5271.314729085233;3656.670899619047;3673.1918977824835;3685.2913108864964;3685.447182922583;3702.4816525686424;3736.8878933632036;3745.5318085239346;3747.5690295616355;3758.9060273492832;3770.905727356838;4252.638525725286;4262.637675797592;4267;4289.6702022373165;4291.249031419489;4797.88137710484;5012.245714000071;5016.749162541858;5070.442251352349;5071.163258062378;1288.9548865789652;1302.726427450246;1303.2766814417898;1303.452549929032;1304.9804252936024;809.9676012959416;826.7974346285079;847.737201467547;858.5449711652709;861.1775754154767;4364.432623758955;4478.865634030984;4511.390962220058;4527.298268768346;4536.6824322297125;5095.184770436712;5147.816002319488;5158.200478925773;5178.300929374486;5187.342923239107;4465.129299786576;4488.147252022105;4497.88755281114;4507.143642707875;4511.503734589192;2566.4482136340775;2717.320669832542;2744.890204391842;2747.5603903375363;2753.931151721223;4863;4887.584555312767;4891.1685013547785;4901.142300097468;4931.18635425158;5047.268146118866;5310.548603368757;5322.296865003239;5342.8325905793545;5344.3853956795465;4835.782389792468;4912.1158191525865;4919.385076865392;4920.384951880943;4929.975350123298;5165.251038599457;5201.973990130025;5217.9478205217465;5219.425863155126;5226.425093239664;4909.386326709161;5081.0854046272025;5101.51535604117;5160.303359046481;5174.560162386088;4888.242322440027;4891.486393928729;4921.286413469955;4927.581155601814;4935.777889994887;3619.3666108431444;3627.927441451209;3650.8904732858055;3663.6519530644546;3665.1020499977676;4928.457869634266;5241.240020197126;5245.291885595549;5258.947410525846;5281.181416880389;4980.701157930535;4992.878026838652;5021.648484606042;5027.597792176544;5029.622778291569;5002.449730529712;5049.626675462527;5049.84850454487;5083.542481176712;5086.618503612318;4844.95155048445;4980.651354405157;5014.147594908802;5014.874628134326;5031.874203144951;4859.687884271298;4902.607791376753;5033.748312584429;5062.443131255485;5072.163093089599;4924.212126059813;4934.210526315772;4940.975295123501;4947.134251506044;4955.157623204136 03:53:08 INFO - PROCESS | 10118 | |5;yui.html;631.3875540725495;652.3150691773639;653.0824192010224;725.3616817200863;757.3903008078495;12320.753584928296;13276.7344653107;13304.733905321888;13314.999999999987;13317.933410332958;13398;13585.320733963312;13589.32053397331;13600.047996640214;13608.11547249428;615.9414855588711;731.3125661877845;739.9001134846781;749.1497150733929;752.319151168191;763.1567118334244;764.7896828372186;765.5406755946416;765.6057130577757;765.9617019149048;795.2921899509412;802.4062193976474;802.9076656184556;803.04036676172;803.7227156630953;636.11897521932;654.4502617801022;657.999840242833;659.4625380315028;796.3151689547013;575.2291928815407;580.5529742098603;582.6882617799457;583.1660725163015;585.8301092683117;12913.483460661562;12929.418176182095;12966.80549791754;13097.672558186121;13106.80339794904;11849.822252666218;12603;12613.873861261454;12916.741665166644;13146.21122732639;11475;11535.365554894477;11654.242474239147;11790.941045294805;12304.81542776859;3953.3476976298875;4006.8797936061965;4061.695372847019;4062.309407400749;4095.8361665533344;58555.12167317536;59236.40763592395;59388.40611593915;59447.40552594462;59537.70231148817;10396.948015259875;10515.52680129396;10612.25714200014;10915.454227288605;10972.396518191417;18787.718184227248;18788.342408015655;18832.90583547101;18890.055497225083;19921.302754403525;6865.347791959756;6865.862682746317;6893.931060689329;6989.720411183597;7083.114610673666;3736;3761.6238376162714;3769.849206031728;3849.6920246380223;3934.881953541398;2744.986275068612;2825.110090321542;2827.222513808678;2832.957505637417;2840.332521857362;479.1208133075775;482.98792530186324;486.47946697033836;490.9729964851896;498.53138050232667;407.5979422239798;421.2081287180143;433.3672837656993;445.32088564938726;485.61393692014934;7310.4151667866445;7692.615369231516;7733.729319473791;7754.457187996899;7770.572618505923;413.6298013278099;457.75052596335075;503.0743432084908;517.7928828468642;546.6037123085731;3440.8451619677176;3670.2292518570866;3708.4808126862263;3878.7672739635714;3894.5910679378826;54769.72615136899;74158.6292068547;76964.61517692376;77692.2230777685;88452.5577372109;84992;87276.56361718151;88235;88433;88829.55585222032;42983.14033719308;43414.914627134574;68291;74090.25909740942;75010;6790.83022924411;6982.441404687511;7050.682719277543;8068;8346.165383461605;39983.60016399799;40676.59323406728;40853.79573102116;41605.58394416017;44557.88605284764;61208;61295;61784;62150;64647;10753.139748820233;10972.506237219184;10997.560097596006;11010.834837477605;11298.265612735146;12456.937715311728;12713.42789574453;12716.745665086832;12786.041046921331;13380.464781409024;10917.23579349438;11046.171537134587;11133.944330278297;11590.710232243924;11709.76580468403;10867.945660271647;10940.452977350942;11005.449727513753;11012.39431831257;11713.472893719632;10536.57853685844;10640.53064053058;10757;10980;11385.203035787416;9467.715968520955;9519.952400238231;9665.9033409665;9863.556139973574;9941.30410871232;9637.469939153134;9815.85276220843;9901.801963960825;9912.996841666021;9927.652532161628 03:53:08 INFO - PROCESS | 10118 | __end_tp_report 03:53:08 INFO - PROCESS | 10118 | __start_cc_report 03:53:08 INFO - PROCESS | 10118 | _x_x_mozilla_cycle_collect,1161 03:53:08 INFO - PROCESS | 10118 | __end_cc_report 03:53:08 INFO - PROCESS | 10118 | __startTimestamp1471431188600__endTimestamp 03:53:08 INFO - PROCESS | 10118 | 03:53:08 INFO - PROCESS | 10118 | ------- Summary: start ------- 03:53:08 INFO - PROCESS | 10118 | Number of tests: 6 03:53:08 INFO - PROCESS | 10118 | 03:53:08 INFO - PROCESS | 10118 | [#0] dojo.html Cycles:165 Average:4666.19 Median:4760.50 stddev:484.14 (10.2%) stddev-sans-first:459.07 03:53:08 INFO - PROCESS | 10118 | Values: 2650.2 2665.7 2681.8 2698.9 2700.4 4610.3 4652.9 4674.3 4684.4 4725.4 4698.3 4700.4 4735.6 4745.1 4760.0 4293.2 4334.0 4377.7 4428.8 4497.7 4368.1 4408.1 4442.8 4453.0 4465.3 4219.4 4254.3 4265.4 4327.8 4331.3 4312.9 4320.1 4320.5 4323.3 4323.6 4297.9 4298.3 4299.6 4302.4 4321.7 4596.9 4612.4 4626.9 4645.4 4647.3 4966.7 4967.9 4978.1 5020.4 5029.9 5082.3 5108.1 5111.3 5113.6 5114.0 4568.6 4680.2 4708.0 4730.1 4732.1 5198.0 5198.1 5251.4 5253.7 5254.2 5033.6 5035.2 5039.9 5040.6 5043.6 4921.8 4995.7 5049.6 5051.4 5123.1 5039.0 5040.3 5047.1 5047.7 5058.6 5026.0 5032.6 5033.6 5034.7 5073.2 4159.8 4196.6 4203.0 4251.4 4254.0 3747.8 3785.8 3788.3 3791.8 3794.5 4365.0 4392.8 4405.4 4458.9 4465.2 5093.5 5096.9 5100.1 5103.5 5103.7 4421.1 4424.7 4426.2 4427.6 4469.3 4433.6 4464.3 4495.8 4496.1 4548.2 4743.9 4758.5 4760.3 4761.2 4802.1 4992.7 5019.1 5056.7 5061.1 5098.5 4611.3 4725.5 4755.5 4771.3 4835.5 4980.4 5007.6 5008.7 5010.8 5055.5 5068.6 5079.0 5079.4 5079.6 5080.6 4681.6 4851.1 4874.0 4904.0 4954.3 4914.9 4922.0 4922.7 4925.0 4967.7 4855.2 4864.1 4908.3 4908.9 4914.0 4763.2 4765.6 4802.8 4873.0 4879.3 4760.5 4798.0 4842.7 4848.8 4917.6 03:53:08 INFO - PROCESS | 10118 | 03:53:08 INFO - PROCESS | 10118 | [#1] ext.html Cycles:180 Average:45175.23 Median:35950.64 stddev:83104.83 (231.2%) stddev-sans-first:83270.42 03:53:08 INFO - PROCESS | 10118 | Values: 551.9 554.7 559.5 560.1 560.6 28490.7 38483.4 39669.0 39927.6 43068.6 40516.0 41077.6 41079.0 41092.6 41172.4 7302.2 7600.8 7733.3 7740.7 7742.5 7382.4 7475.5 7483.4 9638.5 9858.8 9698.0 9738.8 9742.1 9745.8 9747.3 9918.4 9977.5 9986.4 10003.4 10004.6 9684.0 9756.3 9760.7 9763.1 9766.3 37707.2 37817.6 37991.4 37999.4 38014.8 2917.7 3033.8 3203.0 3275.8 3335.6 28572.1 28596.0 29002.9 29132.3 30656.2 3402.7 3448.6 3449.3 3467.1 3504.6 181834.0 182152.0 182231.0 182551.0 182904.0 50667.5 50749.2 50948.0 51018.2 51034.2 31169.2 32289.0 32326.2 33957.0 33966.3 11952.8 12107.4 12113.7 12246.9 12250.9 8939.0 9020.6 9021.8 9023.4 9031.3 15499.0 17020.4 17499.4 17561.4 17805.8 6473.0 6640.7 6746.7 6810.4 6833.3 812.9 845.2 964.9 1004.9 1026.8 27748.0 27974.4 28768.6 28792.7 28932.0 944.3 954.0 958.6 993.9 1046.2 14617.3 14989.5 15021.9 15054.8 15159.6 405434.0 406320.0 409120.0 409147.0 409230.0 47858.0 48220.5 48548.8 48570.0 48638.8 1046.0 1101.8 1126.7 1143.0 1173.9 26965.9 28575.4 29145.0 29300.0 29325.6 40493.8 40803.8 40906.0 40918.8 40969.6 309943.0 311167.0 311456.0 313077.0 313266.0 24624.8 25008.2 25449.5 25499.1 34506.5 36101.8 39968.4 41359.6 41409.4 45625.8 35547.8 35579.0 35763.1 35959.6 36492.5 35553.6 35689.3 35874.6 36183.5 36400.3 34820.0 35217.5 35698.8 35941.6 36113.0 30907.0 32444.8 32503.3 32717.0 32802.7 24873.9 25121.9 25392.0 25527.6 25724.6 03:53:08 INFO - PROCESS | 10118 | 03:53:08 INFO - PROCESS | 10118 | [#2] jquery.html Cycles:180 Average:23813.85 Median:379788.50 stddev:62576.61 (16.5%) stddev-sans-first:62727.35 03:53:08 INFO - PROCESS | 10118 | Values: 348.5 351.2 356.6 367.2 371.0 15754.1 16847.5 17138.2 17226.0 17256.1 15478.5 16711.0 17194.7 17330.0 17350.4 4958.7 5186.6 5188.8 5189.2 5198.8 3709.0 3886.3 5056.9 5801.4 6048.1 6053.0 6055.5 6057.3 6114.0 6120.1 5735.6 5820.1 5845.9 5852.5 5869.2 5083.8 5136.2 5184.2 5195.6 5200.6 20711.8 20761.4 20877.2 20899.7 21075.6 1962.4 2006.0 2014.3 2015.5 2026.1 13139.1 13235.2 13349.8 13574.6 13727.4 1801.3 1818.6 1822.6 1842.9 1856.6 66708.7 68022.7 68086.0 68534.0 70190.0 9108.3 9170.9 9266.4 9385.0 9634.6 12645.7 12653.1 12660.2 12660.8 12672.6 6391.0 6487.1 6572.6 6574.1 6699.9 5875.1 6032.4 6075.4 6263.3 6287.9 5834.6 5931.5 5940.0 5999.9 6110.9 1508.5 1624.7 1631.6 1718.9 1752.4 826.6 840.3 847.7 915.4 927.4 16581.2 16717.6 17092.2 17439.0 17967.9 829.7 841.0 847.0 876.3 946.0 9544.3 10196.6 10205.7 10211.3 10228.0 375015.0 377182.0 382395.0 382411.0 385937.0 64864.7 65009.7 65428.7 65663.0 66075.0 823.3 862.5 896.4 909.1 915.6 15373.9 15835.8 16079.7 16828.7 17119.6 34607.3 34884.5 36338.6 36721.0 36767.3 47111.3 47278.0 48436.8 48684.3 53759.0 7171.8 7630.8 7721.3 7902.5 8091.1 10144.2 12166.9 12286.1 12499.9 12511.2 10483.9 10509.4 10603.8 10863.3 11384.2 10646.1 10781.0 10855.3 11043.3 11257.7 10593.4 10823.5 10824.5 10894.8 11582.9 7732.4 7835.3 7960.7 7984.4 8095.8 9490.9 10145.3 10302.1 10631.1 11089.1 03:53:08 INFO - PROCESS | 10118 | 03:53:08 INFO - PROCESS | 10118 | [#3] mootools.html Cycles:180 Average:4991.17 Median:4752.57 stddev:2827.28 (59.5%) stddev-sans-first:2821.57 03:53:08 INFO - PROCESS | 10118 | Values: 1295.9 1350.8 1366.7 1615.6 1623.9 7280.1 7886.9 7898.1 7901.9 7919.4 6709.5 6914.5 6929.0 7099.3 7763.9 2097.5 2182.6 2189.3 2193.6 2200.8 2197.7 2201.0 2223.1 2227.5 2227.9 2191.0 2192.6 2198.4 2199.7 2206.0 2132.5 2158.0 2175.3 2175.6 2179.1 2098.8 2100.0 2126.9 2150.4 2159.2 7637.0 7737.7 7741.0 7742.3 7751.4 4329.8 4459.3 4471.1 4472.1 4477.5 2762.5 2866.4 2888.2 2943.9 2949.3 888.3 919.5 926.6 942.5 946.4 10448.5 10498.4 10517.3 10517.4 10527.4 3927.9 4016.3 4170.7 4181.6 4186.2 9038.5 9040.0 9051.9 9063.1 9064.5 4335.4 4347.9 4355.3 4357.0 4357.9 3568.6 3892.6 3893.0 3900.2 3906.2 3074.0 3604.5 3636.8 3690.2 3696.1 1175.3 1182.4 1184.5 1197.8 1201.7 608.8 648.9 719.7 725.0 731.1 4689.7 4704.1 4723.2 4762.8 5123.5 794.6 844.1 844.2 851.7 855.7 3290.6 3294.5 3326.6 3377.9 3451.2 9091.5 9481.9 9583.9 9584.5 9609.2 9149.5 9476.9 9487.4 9545.8 9665.9 7237.6 7297.2 7302.2 7304.5 7311.3 4674.6 4680.1 4742.4 5157.5 5214.2 8544.1 8592.5 8638.1 8672.2 8720.3 8462.6 8671.2 8751.2 8761.3 8788.2 5993.0 6360.6 6627.4 6656.8 6780.6 7443.4 7468.4 7523.6 7530.7 7539.5 6612.9 6627.6 6666.7 6693.1 6812.1 6497.7 6576.9 6607.5 6626.7 6631.2 5896.0 5915.6 5946.8 5974.2 5975.0 4187.5 4361.5 4374.2 4377.6 4406.6 4152.9 4330.9 4336.1 4351.0 4380.2 03:53:08 INFO - PROCESS | 10118 | 03:53:08 INFO - PROCESS | 10118 | [#4] prototype.html Cycles:180 Average:4181.90 Median:4799.89 stddev:1216.02 (25.3%) stddev-sans-first:1183.85 03:53:08 INFO - PROCESS | 10118 | Values: 290.9 296.4 297.4 298.1 303.8 4801.9 4817.0 4818.4 4831.3 4835.7 4738.9 4752.8 4758.4 4761.8 4763.6 3555.2 3667.8 3688.5 3713.4 3736.3 3731.3 3742.2 3743.9 3751.9 3772.0 3710.8 3711.6 3714.0 3715.3 3728.5 3597.7 3638.7 3717.9 3723.5 3735.4 3285.8 3294.8 3304.4 3313.3 3318.3 4645.0 4650.5 4657.7 4674.7 4684.5 4124.1 4278.9 4299.5 4300.4 4320.1 4968.3 4972.9 4979.5 4988.4 5015.4 3660.2 3661.3 3666.8 3666.8 3667.9 5075.3 5213.5 5261.7 5264.7 5271.3 3656.7 3673.2 3685.3 3685.4 3702.5 3736.9 3745.5 3747.6 3758.9 3770.9 4252.6 4262.6 4267.0 4289.7 4291.2 4797.9 5012.2 5016.7 5070.4 5071.2 1289.0 1302.7 1303.3 1303.5 1305.0 810.0 826.8 847.7 858.5 861.2 4364.4 4478.9 4511.4 4527.3 4536.7 5095.2 5147.8 5158.2 5178.3 5187.3 4465.1 4488.1 4497.9 4507.1 4511.5 2566.4 2717.3 2744.9 2747.6 2753.9 4863.0 4887.6 4891.2 4901.1 4931.2 5047.3 5310.5 5322.3 5342.8 5344.4 4835.8 4912.1 4919.4 4920.4 4930.0 5165.3 5202.0 5217.9 5219.4 5226.4 4909.4 5081.1 5101.5 5160.3 5174.6 4888.2 4891.5 4921.3 4927.6 4935.8 3619.4 3627.9 3650.9 3663.7 3665.1 4928.5 5241.2 5245.3 5258.9 5281.2 4980.7 4992.9 5021.6 5027.6 5029.6 5002.4 5049.6 5049.8 5083.5 5086.6 4845.0 4980.7 5014.1 5014.9 5031.9 4859.7 4902.6 5033.7 5062.4 5072.2 4924.2 4934.2 4941.0 4947.1 4955.2 03:53:08 INFO - PROCESS | 10118 | 03:53:08 INFO - PROCESS | 10118 | [#5] yui.html Cycles:180 Average:16614.81 Median:22501.60 stddev:22892.16 (101.7%) stddev-sans-first:22924.92 03:53:08 INFO - PROCESS | 10118 | Values: 631.4 652.3 653.1 725.4 757.4 12320.8 13276.7 13304.7 13315.0 13317.9 13398.0 13585.3 13589.3 13600.0 13608.1 615.9 731.3 739.9 749.1 752.3 763.2 764.8 765.5 765.6 766.0 795.3 802.4 802.9 803.0 803.7 636.1 654.5 658.0 659.5 796.3 575.2 580.6 582.7 583.2 585.8 12913.5 12929.4 12966.8 13097.7 13106.8 11849.8 12603.0 12613.9 12916.7 13146.2 11475.0 11535.4 11654.2 11790.9 12304.8 3953.3 4006.9 4061.7 4062.3 4095.8 58555.1 59236.4 59388.4 59447.4 59537.7 10396.9 10515.5 10612.3 10915.5 10972.4 18787.7 18788.3 18832.9 18890.1 19921.3 6865.3 6865.9 6893.9 6989.7 7083.1 3736.0 3761.6 3769.8 3849.7 3934.9 2745.0 2825.1 2827.2 2833.0 2840.3 479.1 483.0 486.5 491.0 498.5 407.6 421.2 433.4 445.3 485.6 7310.4 7692.6 7733.7 7754.5 7770.6 413.6 457.8 503.1 517.8 546.6 3440.8 3670.2 3708.5 3878.8 3894.6 54769.7 74158.6 76964.6 77692.2 88452.6 84992.0 87276.6 88235.0 88433.0 88829.6 42983.1 43414.9 68291.0 74090.3 75010.0 6790.8 6982.4 7050.7 8068.0 8346.2 39983.6 40676.6 40853.8 41605.6 44557.9 61208.0 61295.0 61784.0 62150.0 64647.0 10753.1 10972.5 10997.6 11010.8 11298.3 12456.9 12713.4 12716.7 12786.0 13380.5 10917.2 11046.2 11133.9 11590.7 11709.8 10867.9 10940.5 11005.4 11012.4 11713.5 10536.6 10640.5 10757.0 10980.0 11385.2 9467.7 9520.0 9665.9 9863.6 9941.3 9637.5 9815.9 9901.8 9913.0 9927.7 03:53:08 INFO - PROCESS | 10118 | -------- Summary: end -------- 03:53:08 INFO - PROCESS | 10118 | 03:53:09 INFO - TEST-INFO | 10118: exit 0 03:53:09 INFO - TEST-OK | dromaeo_css | took 1120665ms 03:53:09 INFO - TEST-START | kraken 03:53:09 INFO - operating with platform_type : linux_ 03:53:09 INFO - Initialising browser for kraken test... 03:53:09 INFO - TEST-INFO | started process 10414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa_W08Z/profile http://localhost:45355/getInfo.html) 03:53:13 INFO - PROCESS | 10414 | __metrics Screen width/height:1600/1200 03:53:13 INFO - PROCESS | 10414 | colorDepth:24 03:53:13 INFO - PROCESS | 10414 | Browser inner width/height: 1024/697 03:53:13 INFO - PROCESS | 10414 | __metrics 03:53:14 INFO - PROCESS | 10414 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:53:14 INFO - PROCESS | 10414 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:53:15 INFO - TEST-INFO | 10414: exit 0 03:53:15 INFO - Browser initialized. 03:53:15 INFO - Running cycle 1/1 for kraken test... 03:53:15 INFO - TEST-INFO | started process 10494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa_W08Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:27 INFO - PROCESS | 10494 | RSS: Main: 156819456 03:53:27 INFO - PROCESS | 10494 | 03:53:30 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45355/tests/kraken/driver.html?testName=audio-beat-detection) 03:53:31 INFO - PROCESS | 10494 | RSS: Main: 204718080 03:53:31 INFO - PROCESS | 10494 | 03:53:33 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45355/tests/kraken/driver.html?testName=audio-dft) 03:53:34 INFO - PROCESS | 10494 | RSS: Main: 196304896 03:53:34 INFO - PROCESS | 10494 | 03:53:37 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45355/tests/kraken/driver.html?testName=audio-fft) 03:53:38 INFO - PROCESS | 10494 | RSS: Main: 277196800 03:53:38 INFO - PROCESS | 10494 | 03:53:40 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45355/tests/kraken/driver.html?testName=audio-oscillator) 03:53:41 INFO - PROCESS | 10494 | RSS: Main: 187375616 03:53:41 INFO - PROCESS | 10494 | 03:53:43 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45355/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:43 INFO - PROCESS | 10494 | RSS: Main: 192200704 03:53:43 INFO - PROCESS | 10494 | 03:53:47 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45355/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:47 INFO - PROCESS | 10494 | RSS: Main: 227905536 03:53:47 INFO - PROCESS | 10494 | 03:53:51 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45355/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:51 INFO - PROCESS | 10494 | RSS: Main: 222715904 03:53:51 INFO - PROCESS | 10494 | 03:53:54 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45355/tests/kraken/driver.html?testName=json-parse-financial) 03:53:55 INFO - PROCESS | 10494 | RSS: Main: 225325056 03:53:55 INFO - PROCESS | 10494 | 03:53:57 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45355/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:57 INFO - PROCESS | 10494 | RSS: Main: 188727296 03:53:57 INFO - PROCESS | 10494 | 03:53:59 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:00 INFO - PROCESS | 10494 | RSS: Main: 196308992 03:54:00 INFO - PROCESS | 10494 | 03:54:02 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:03 INFO - PROCESS | 10494 | RSS: Main: 193429504 03:54:03 INFO - PROCESS | 10494 | 03:54:05 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:06 INFO - PROCESS | 10494 | RSS: Main: 188186624 03:54:06 INFO - PROCESS | 10494 | 03:54:09 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:10 INFO - PROCESS | 10494 | RSS: Main: 191811584 03:54:10 INFO - PROCESS | 10494 | 03:54:11 INFO - PROCESS | 10494 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45355/tests/kraken/driver.html?testName=ai-astar) 03:54:12 INFO - PROCESS | 10494 | RSS: Main: 242135040 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | __start_tp_report 03:54:12 INFO - PROCESS | 10494 | _x_x_mozilla_page_load 03:54:12 INFO - PROCESS | 10494 | _x_x_mozilla_page_load_details 03:54:12 INFO - PROCESS | 10494 | |i|pagename|runs| 03:54:12 INFO - PROCESS | 10494 | |0;ai-astar;105;113;114;115;109;114;115;114;115;116 03:54:12 INFO - PROCESS | 10494 | |1;audio-beat-detection;143;122;124;196;122;125;146;123;158;122 03:54:12 INFO - PROCESS | 10494 | |2;audio-dft;160;160;161;158;161;161;161;162;162;161 03:54:12 INFO - PROCESS | 10494 | |3;audio-fft;75;77;76;108;76;78;75;75;111;76 03:54:12 INFO - PROCESS | 10494 | |4;audio-oscillator;85;86;125;86;86;87;123;87;85;127 03:54:12 INFO - PROCESS | 10494 | |5;imaging-gaussian-blur;118;117;117;117;116;117;117;116;116;116 03:54:12 INFO - PROCESS | 10494 | |6;imaging-darkroom;146;147;148;148;146;146;146;146;147;145 03:54:12 INFO - PROCESS | 10494 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;94;95 03:54:12 INFO - PROCESS | 10494 | |8;json-parse-financial;66;64;68;65;65;66;73;65;68;65 03:54:12 INFO - PROCESS | 10494 | |9;json-stringify-tinderbox;66;66;67;66;66;66;66;66;67;65 03:54:12 INFO - PROCESS | 10494 | |10;stanford-crypto-aes;82;82;83;83;83;83;82;84;82;82 03:54:12 INFO - PROCESS | 10494 | |11;stanford-crypto-ccm;135;135;133;133;131;130;140;149;147;130 03:54:12 INFO - PROCESS | 10494 | |12;stanford-crypto-pbkdf2;170;173;173;172;172;177;170;168;168;169 03:54:12 INFO - PROCESS | 10494 | |13;stanford-crypto-sha256-iterative;68;67;67;68;67;71;66;69;66;66 03:54:12 INFO - PROCESS | 10494 | __end_tp_report 03:54:12 INFO - PROCESS | 10494 | __start_cc_report 03:54:12 INFO - PROCESS | 10494 | _x_x_mozilla_cycle_collect,1942 03:54:12 INFO - PROCESS | 10494 | __end_cc_report 03:54:12 INFO - PROCESS | 10494 | __startTimestamp1471431252052__endTimestamp 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | ------- Summary: start ------- 03:54:12 INFO - PROCESS | 10494 | Number of tests: 14 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.50 stddev:3.40 (3.0%) stddev-sans-first:2.03 03:54:12 INFO - PROCESS | 10494 | Values: 105.0 113.0 114.0 115.0 109.0 114.0 115.0 114.0 115.0 116.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:134.00 stddev:24.06 (18.0%) stddev-sans-first:25.46 03:54:12 INFO - PROCESS | 10494 | Values: 143.0 122.0 124.0 196.0 122.0 125.0 146.0 123.0 158.0 122.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 03:54:12 INFO - PROCESS | 10494 | Values: 160.0 160.0 161.0 158.0 161.0 161.0 161.0 162.0 162.0 161.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:14.17 (18.6%) stddev-sans-first:14.76 03:54:12 INFO - PROCESS | 10494 | Values: 75.0 77.0 76.0 108.0 76.0 78.0 75.0 75.0 111.0 76.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:86.00 stddev:18.87 (21.9%) stddev-sans-first:19.45 03:54:12 INFO - PROCESS | 10494 | Values: 85.0 86.0 125.0 86.0 86.0 87.0 123.0 87.0 85.0 127.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 03:54:12 INFO - PROCESS | 10494 | Values: 118.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 03:54:12 INFO - PROCESS | 10494 | Values: 146.0 147.0 148.0 148.0 146.0 146.0 146.0 146.0 147.0 145.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:54:12 INFO - PROCESS | 10494 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.00 stddev:2.64 (4.0%) stddev-sans-first:2.79 03:54:12 INFO - PROCESS | 10494 | Values: 66.0 64.0 68.0 65.0 65.0 66.0 73.0 65.0 68.0 65.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 03:54:12 INFO - PROCESS | 10494 | Values: 66.0 66.0 67.0 66.0 66.0 66.0 66.0 66.0 67.0 65.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 03:54:12 INFO - PROCESS | 10494 | Values: 82.0 82.0 83.0 83.0 83.0 83.0 82.0 84.0 82.0 82.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:135.00 stddev:6.85 (5.1%) stddev-sans-first:7.25 03:54:12 INFO - PROCESS | 10494 | Values: 135.0 135.0 133.0 133.0 131.0 130.0 140.0 149.0 147.0 130.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:172.00 stddev:2.78 (1.6%) stddev-sans-first:2.92 03:54:12 INFO - PROCESS | 10494 | Values: 170.0 173.0 173.0 172.0 172.0 177.0 170.0 168.0 168.0 169.0 03:54:12 INFO - PROCESS | 10494 | 03:54:12 INFO - PROCESS | 10494 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.58 (2.3%) stddev-sans-first:1.67 03:54:12 INFO - PROCESS | 10494 | Values: 68.0 67.0 67.0 68.0 67.0 71.0 66.0 69.0 66.0 66.0 03:54:12 INFO - PROCESS | 10494 | -------- Summary: end -------- 03:54:12 INFO - PROCESS | 10494 | 03:54:13 INFO - TEST-INFO | 10494: exit 0 03:54:13 INFO - TEST-OK | kraken | took 63714ms 03:54:13 INFO - SUITE-END | took 1184s 03:54:13 INFO - Completed test suite (00:19:44) 03:54:13 INFO - javascript benchmark 03:54:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.191691534082, 2665.680118385794, 2681.8390896546207, 2698.9055383061595, 2700.3654141276797, 4610.262358022717, 4652.883677908049, 4674.252119660855, 4684.414448193976, 4725.40932383452, 4698.318743782158, 4700.36545066416, 4735.5974742146955, 4745.122152401799, 4759.976200119003, 4293.162833247518, 4334.0, 4377.737335759849, 4428.756418396987, 4497.730136191823, 4368.082702632451, 4408.14041261954, 4442.800073996662, 4452.975815562422, 4465.307877279027, 4219.43037689914, 4254.298040823261, 4265.402843601898, 4327.805248763813, 4331.328644060176, 4312.913741725148, 4320.1143765527995, 4320.4599425071865, 4323.265044942367, 4323.567643235683, 4297.892552686177, 4298.333758267474, 4299.591538803808, 4302.397664326997, 4321.65426765858, 4596.885077873047, 4612.446506419217, 4626.9074618507775, 4645.442546894361, 4647.34937108805, 4966.6771659842, 4967.90064198714, 4978.103941290567, 5020.422651395063, 5029.874253143701, 5082.288479612857, 5108.106081435771, 5111.309973153614, 5113.616478764107, 5113.974430127862, 4568.588827005586, 4680.204365257914, 4707.976460117678, 4730.053989202173, 4732.053589282157, 5198.038362902875, 5198.142306519458, 5251.396089449762, 5253.737313134328, 5254.2118682197215, 5033.6224783141415, 5035.169197082514, 5039.899202015939, 5040.647154699136, 5043.571296439771, 4921.7785199666105, 4995.675281106716, 5049.596032317406, 5051.419086804991, 5123.052235336475, 5039.042581909425, 5040.2691609716385, 5047.116754567936, 5047.722375269322, 5058.570021548209, 5026.045051440215, 5032.572231360302, 5033.597312215014, 5034.672746271481, 5073.188289873677, 4159.833606655699, 4196.580341965779, 4202.978985105055, 4251.404803327537, 4254.042840360956, 3747.7938713371027, 3785.7539259948016, 3788.318102741533, 3791.8104094795704, 3794.4687743715904, 4364.956350436519, 4392.824287028547, 4405.405270288534, 4458.888527786767, 4465.218586747306, 5093.516115968977, 5096.872578185575, 5100.132977393852, 5103.540681338697, 5103.668261562986, 4421.071574969293, 4424.690271680952, 4426.18115648606, 4427.6236519896165, 4469.307257375112, 4433.645308375322, 4464.308032255006, 4495.842645507391, 4496.100779844044, 4548.226801443762, 4743.881402964885, 4758.476567577494, 4760.262159365304, 4761.2382018876815, 4802.063597598435, 4992.725400102884, 5019.146745053423, 5056.6713163644245, 5061.089003979319, 5098.5411312982005, 4611.33135695329, 4725.456572494207, 4755.453122890912, 4771.284307353786, 4835.468098509091, 4980.402351717817, 5007.649464537593, 5008.6744361616375, 5010.799568017239, 5055.51972562606, 5068.6451948363265, 5078.97460512695, 5079.441261461162, 5079.554791962381, 5080.644354895269, 4681.578657920803, 4851.078295123915, 4874.0, 4904.043711476371, 4954.256861470808, 4914.92627610579, 4921.97539012317, 4922.704637721748, 4925.0, 4967.677100988424, 4855.174620314484, 4864.051509955525, 4908.337374454403, 4908.901821963612, 4913.975430122827, 4763.166445872028, 4765.5949244314625, 4802.7838747255755, 4873.049755297825, 4879.268109783561, 4760.500147484603, 4797.976010119927, 4842.685225460334, 4848.8302909398, 4917.58200552957], "value": 4635.8922119769595, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.9116941289393, 554.6866020698308, 559.4629156010228, 560.0563051258632, 560.5543592843688, 28490.715092849066, 38483.422748658755, 39669.0, 39927.60072399275, 43068.56931430685, 40516.0, 41077.58922410775, 41079.0, 41092.58907410925, 41172.38241426374, 7302.1967583565765, 7600.809979750496, 7733.304002639761, 7740.690372385126, 7742.496737712031, 7382.372498337648, 7475.476716629838, 7483.4013278937555, 9638.518074096268, 9858.802823943517, 9697.95151024244, 9738.756531086708, 9742.123208911196, 9745.805083898318, 9747.317687761824, 9918.404895706244, 9977.451240181786, 9986.350887192382, 10003.449810260432, 10004.649837255698, 9684.0, 9756.317057805956, 9760.707178784647, 9763.072508111718, 9766.316357854954, 37707.24585508274, 37817.62182378169, 37991.43012854809, 37999.43000854989, 38014.80992595047, 2917.6644685861183, 3033.7876348655604, 3202.9679703203137, 3275.754318426104, 3335.5663763710804, 28572.142835714963, 28596.0, 29002.854985725146, 29132.27169320763, 30656.233594160323, 3402.6767457091537, 3448.6378930212218, 3449.344624521333, 3467.081223475781, 3504.632013638582, 181834.0, 182152.0, 182231.0, 182551.0, 182904.0, 50667.49332506628, 50749.23876141861, 50948.0, 51018.23472647913, 51034.23448648273, 31169.22076948049, 32289.0, 32326.19184520406, 33957.0, 33966.32067358639, 11952.760944781056, 12107.394630268627, 12113.697157570956, 12246.877531224753, 12250.877491224974, 8938.955305223562, 9020.639174433081, 9021.819563608691, 9023.368364214442, 9031.322650801085, 15499.0, 17020.404285849934, 17499.38752143669, 17561.385351512636, 17805.821941780676, 6473.0, 6640.703015777949, 6746.730130794714, 6810.38706516406, 6833.300846165736, 812.9065157506844, 845.2139510255521, 964.9469279189711, 1004.9095581397563, 1026.825439675257, 27747.974654674872, 27974.44051119007, 28768.568471472943, 28792.712072879003, 28932.0, 944.2681921510747, 954.0221273194892, 958.6021800952666, 993.9254555908336, 1046.1839764983324, 14617.269136543344, 14989.475368362055, 15021.924890375696, 15054.774178387333, 15159.621009474631, 405434.0, 406320.0, 409120.0, 409147.0, 409230.0, 47858.0, 48220.5177948216, 48548.757256213496, 48570.0, 48638.756806215744, 1045.9529321180564, 1101.752105776194, 1126.69016020595, 1142.994285028586, 1173.9413029348498, 26965.865170674806, 28575.42849143047, 29145.02944318865, 29300.0, 29325.560116598695, 40493.797531012155, 40803.7959810199, 40906.0, 40918.79540602278, 40969.59030409658, 309943.0, 311167.0, 311456.0, 313077.0, 313266.0, 24624.813781657518, 25008.249752507454, 25449.491010180063, 25499.107531236317, 34506.47896336574, 36101.81949090238, 39968.4004739935, 41359.586404136775, 41409.37885931653, 45625.77187114043, 35547.82226088853, 35579.0, 35763.10592235215, 35959.64040359563, 36492.45261321135, 35553.644463555036, 35689.28621427505, 35874.64125358713, 36183.45724814183, 36400.27199456049, 34820.0, 35217.47173792344, 35698.8215058923, 35941.64058359383, 36113.0, 30907.0, 32444.762501118617, 32503.349933001682, 32717.0, 32802.67197327996, 24873.875630621733, 25121.87439062793, 25391.98584502549, 25527.6170857441, 25724.614130788428], "value": 17215.65189664462, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.51034296812986, 351.1887539783101, 356.6059504247806, 367.2361488104742, 370.97217708671855, 15754.13352265625, 16847.494575162735, 17138.22877970491, 17226.0, 17256.137193140323, 15478.535643930672, 16711.0, 17194.656106877854, 17330.0, 17350.392736254234, 4958.652894297401, 5186.611004174702, 5188.766505507242, 5189.195674670432, 5198.792048318062, 3708.962910370889, 3886.3393223152134, 5056.949430505685, 5801.361850196475, 6048.092786082101, 6053.0, 6055.455009049185, 6057.3336932937345, 6113.969430152843, 6120.081987701836, 5735.627184233012, 5820.097884827858, 5845.88308233833, 5852.473277405054, 5869.178315035899, 5083.796648134107, 5136.178211486144, 5184.248283998837, 5195.636305458619, 5200.609954253408, 20711.792882071288, 20761.377158685264, 20877.225435837972, 20899.68650470244, 21075.5784884303, 1962.3720409468976, 2005.989970050155, 2014.2849288502664, 2015.536426621885, 2026.0781344488223, 13139.14595551286, 13235.205887646773, 13349.799753003712, 13574.59276221715, 13727.382267797973, 1801.3425099838596, 1818.6271814278173, 1822.6396816123151, 1842.9354972575895, 1856.5915498590289, 66708.6664566679, 68022.65988670074, 68085.9999999995, 68534.0, 70190.0, 9108.316876234308, 9170.862437063315, 9266.44401335922, 9384.95307523458, 9634.614615415305, 12645.683857903627, 12653.051021173265, 12660.240385576895, 12660.81008784869, 12672.556460523838, 6391.005325013724, 6487.124238227779, 6572.572782769104, 6574.145361103122, 6699.933000670028, 5875.089361149029, 6032.426919442646, 6075.3924607539775, 6263.279722831932, 6287.874242515216, 5834.620749651344, 5931.466168044896, 5940.0, 5999.880002399927, 6110.908336374958, 1508.4871143811156, 1624.7237969545206, 1631.6328826014053, 1718.905460199676, 1752.4217008387202, 826.6032304493876, 840.2815592668303, 847.6863560482537, 915.3638221436171, 927.4157280912982, 16581.170941452878, 16717.582060448585, 17092.2308496118, 17439.0, 17967.910160449115, 829.7386323308139, 840.983180336402, 847.0470720439506, 876.2814492116403, 945.9810803784023, 9544.284178686627, 10196.592136314464, 10205.693829185137, 10211.285210035227, 10228.0, 375015.0, 377182.0, 382395.0, 382411.0, 385937.0, 64864.675676621315, 65009.67495162494, 65428.67285663637, 65663.0, 66075.0, 823.3001948343859, 862.5385418800911, 896.4486840592988, 909.0863681999548, 915.5834095486671, 15373.923130384277, 15835.762463562825, 16079.67840643204, 16828.66342673164, 17119.57201069983, 34607.30785384228, 34884.47673284852, 36338.63661363458, 36721.0, 36767.26465470622, 47111.29333059938, 47278.0, 48436.757816210695, 48684.26973595328, 53759.0, 7171.784846454615, 7630.847383052419, 7721.343685786771, 7902.510709126606, 8091.109977902308, 10144.239182061227, 12166.939165304117, 12286.139970202357, 12499.875001249871, 12511.160935733084, 10483.947580262049, 10509.421981791074, 10603.840942386025, 10863.333383188234, 11384.203105782846, 10646.095081918123, 10781.0, 10855.294405863593, 11043.337399756041, 11257.71855703614, 10593.417362044853, 10823.51294191779, 10824.512896919816, 10894.836577451186, 11582.94208528952, 7732.38140948734, 7835.255650713173, 7960.681572737258, 7984.441089123706, 8095.757127286191, 9490.905090949002, 10145.28982971185, 10302.124319432933, 10631.149508039493, 11089.112870970142], "value": 8298.21631703186, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.9481620735173, 1350.8108864758935, 1366.7471517769213, 1615.576635047429, 1623.91068491233, 7280.12638483382, 7886.921130788691, 7898.052233731953, 7901.881471777928, 7919.406044546653, 6709.5303328767, 6914.481413893953, 6929.029935808978, 7099.254578269285, 7763.883541746878, 2097.538541520863, 2182.6180418426793, 2189.3322536626324, 2193.583219188357, 2200.7909248621436, 2197.6703494475796, 2201.0, 2223.144089525528, 2227.521082967162, 2227.944301392462, 2191.024993877725, 2192.6053310404122, 2198.362474882282, 2199.7250343707037, 2205.9669104963436, 2132.4562236629636, 2158.0, 2175.3256490487997, 2175.575762726269, 2179.052112331141, 2098.821600163988, 2100.0444797617047, 2126.9468263293543, 2150.4301360139575, 2159.1903036361364, 7637.0, 7737.651805668758, 7741.032370953631, 7742.303192712683, 7751.418643601696, 4329.848455304081, 4459.331100334944, 4471.128130014648, 4472.08322293929, 4477.462704475452, 2762.5303698371326, 2866.4410439964217, 2888.176869592156, 2943.867525961337, 2949.2626843289177, 888.2671795768517, 919.4804935211585, 926.5506229478698, 942.4910548303908, 946.3753922411175, 10448.52981615829, 10498.422586757726, 10517.263791534595, 10517.421541815198, 10527.420991845522, 3927.8821635350987, 4016.3373043447505, 4170.687198460128, 4181.644560212355, 4186.162767446523, 9038.457692538468, 9039.954800225956, 9051.864222036675, 9063.13900179495, 9064.456132632064, 4335.414719012956, 4347.913041739211, 4355.303151495746, 4356.956430435718, 4357.9128417431475, 3568.6252943441086, 3892.552356479041, 3892.9805350973065, 3900.2004589059175, 3906.2187562487616, 3073.969260307413, 3604.4593311003036, 3636.7999760013454, 3690.151265208963, 3696.131409118855, 1175.3183153770792, 1182.3733421286731, 1184.5084290019545, 1197.820326950947, 1201.7055821323656, 608.7869245763948, 648.8994205898093, 719.6689522819457, 725.0, 731.0715391452825, 4689.742064186503, 4704.129735998851, 4723.220668589713, 4762.761861906891, 5123.462036486189, 794.6225542867091, 844.1134065363907, 844.1853611265159, 851.6891334662804, 855.6962278391206, 3290.588676415448, 3294.5058241264, 3326.600807903019, 3377.9493307600405, 3451.240727040047, 9091.54542272897, 9481.857772133424, 9583.904160958302, 9584.472853993097, 9609.231261499064, 9149.54252287383, 9476.857847132298, 9487.383320084311, 9545.761355966017, 9665.90334096664, 7237.63811809418, 7297.197308296083, 7302.233265507151, 7304.5252058616015, 7311.268873112753, 4674.555917187861, 4680.134175177603, 4742.383490146259, 5157.452764170659, 5214.243934629533, 8544.102869198645, 8592.527410992456, 8638.093000234885, 8672.219500245008, 8720.345974052098, 8462.619182136941, 8671.21959023691, 8751.212390884852, 8761.29909607217, 8788.16512431318, 5993.0, 6360.618362898241, 6627.37039981201, 6656.833579160366, 6780.593164410151, 7443.36731377839, 7468.402527797872, 7523.586202758901, 7530.6611202497115, 7539.509931854412, 6612.90080648781, 6627.569208001464, 6666.666666666744, 6693.1298931138645, 6812.14848143982, 6497.707603157774, 6576.934230657824, 6607.53747237708, 6626.6686665667485, 6631.237407698177, 5896.0, 5915.645061296336, 5946.821595352147, 5974.2233509643465, 5975.043992961106, 4187.5184353799705, 4361.476622805284, 4374.212641724393, 4377.606015458624, 4406.625436837777, 4152.875413737593, 4330.870073897788, 4336.111097224998, 4351.021020270414, 4380.167768124046], "value": 4009.595260746209, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.8763775395456, 296.4057065583505, 297.4170625573875, 298.05070849344827, 303.8181474065884, 4801.90396192076, 4816.97591512042, 4818.397700287464, 4831.275308703692, 4835.734034628094, 4738.9052218955685, 4752.833650822222, 4758.428988521382, 4761.785794588656, 4763.571278584926, 3555.2178520725465, 3667.7982710950887, 3688.5389326334207, 3713.424419215026, 3736.308782875177, 3731.253749250161, 3742.158014446755, 3743.86896458624, 3751.911945535805, 3772.0, 3710.777353358807, 3711.647393497627, 3714.0, 3715.3312403767313, 3728.459373390857, 3597.748157628967, 3638.7089032877307, 3717.944230836526, 3723.454766272021, 3735.4210097434943, 3285.8192799396024, 3294.8187849668257, 3304.4469099523426, 3313.2710803623163, 3318.3197444523817, 4645.0, 4650.51169627191, 4657.720536767771, 4674.69614475058, 4684.484706682262, 4124.061691005223, 4278.893027674302, 4299.462567179103, 4300.419443375167, 4320.13597280542, 4968.329275547827, 4972.881101752077, 4979.47715489872, 4988.426330971948, 5015.39815222172, 3660.158163622355, 3661.340958627446, 3666.7616604920863, 3666.7983260920637, 3667.8716244931566, 5075.264086707443, 5213.452587478336, 5261.684298942076, 5264.657512334368, 5271.314729085233, 3656.670899619047, 3673.1918977824835, 3685.2913108864964, 3685.447182922583, 3702.4816525686424, 3736.8878933632036, 3745.5318085239346, 3747.5690295616355, 3758.9060273492832, 3770.905727356838, 4252.638525725286, 4262.637675797592, 4267.0, 4289.6702022373165, 4291.249031419489, 4797.88137710484, 5012.245714000071, 5016.749162541858, 5070.442251352349, 5071.163258062378, 1288.9548865789652, 1302.726427450246, 1303.2766814417898, 1303.452549929032, 1304.9804252936024, 809.9676012959416, 826.7974346285079, 847.737201467547, 858.5449711652709, 861.1775754154767, 4364.432623758955, 4478.865634030984, 4511.390962220058, 4527.298268768346, 4536.6824322297125, 5095.184770436712, 5147.816002319488, 5158.200478925773, 5178.300929374486, 5187.342923239107, 4465.129299786576, 4488.147252022105, 4497.88755281114, 4507.143642707875, 4511.503734589192, 2566.4482136340775, 2717.320669832542, 2744.890204391842, 2747.5603903375363, 2753.931151721223, 4863.0, 4887.584555312767, 4891.1685013547785, 4901.142300097468, 4931.18635425158, 5047.268146118866, 5310.548603368757, 5322.296865003239, 5342.8325905793545, 5344.3853956795465, 4835.782389792468, 4912.1158191525865, 4919.385076865392, 4920.384951880943, 4929.975350123298, 5165.251038599457, 5201.973990130025, 5217.9478205217465, 5219.425863155126, 5226.425093239664, 4909.386326709161, 5081.0854046272025, 5101.51535604117, 5160.303359046481, 5174.560162386088, 4888.242322440027, 4891.486393928729, 4921.286413469955, 4927.581155601814, 4935.777889994887, 3619.3666108431444, 3627.927441451209, 3650.8904732858055, 3663.6519530644546, 3665.1020499977676, 4928.457869634266, 5241.240020197126, 5245.291885595549, 5258.947410525846, 5281.181416880389, 4980.701157930535, 4992.878026838652, 5021.648484606042, 5027.597792176544, 5029.622778291569, 5002.449730529712, 5049.626675462527, 5049.84850454487, 5083.542481176712, 5086.618503612318, 4844.95155048445, 4980.651354405157, 5014.147594908802, 5014.874628134326, 5031.874203144951, 4859.687884271298, 4902.607791376753, 5033.748312584429, 5062.443131255485, 5072.163093089599, 4924.212126059813, 4934.210526315772, 4940.975295123501, 4947.134251506044, 4955.157623204136], "value": 3794.3635744487997, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.3875540725495, 652.3150691773639, 653.0824192010224, 725.3616817200863, 757.3903008078495, 12320.753584928296, 13276.7344653107, 13304.733905321888, 13314.999999999987, 13317.933410332958, 13398.0, 13585.320733963312, 13589.32053397331, 13600.047996640214, 13608.11547249428, 615.9414855588711, 731.3125661877845, 739.9001134846781, 749.1497150733929, 752.319151168191, 763.1567118334244, 764.7896828372186, 765.5406755946416, 765.6057130577757, 765.9617019149048, 795.2921899509412, 802.4062193976474, 802.9076656184556, 803.04036676172, 803.7227156630953, 636.11897521932, 654.4502617801022, 657.999840242833, 659.4625380315028, 796.3151689547013, 575.2291928815407, 580.5529742098603, 582.6882617799457, 583.1660725163015, 585.8301092683117, 12913.483460661562, 12929.418176182095, 12966.80549791754, 13097.672558186121, 13106.80339794904, 11849.822252666218, 12603.0, 12613.873861261454, 12916.741665166644, 13146.21122732639, 11475.0, 11535.365554894477, 11654.242474239147, 11790.941045294805, 12304.81542776859, 3953.3476976298875, 4006.8797936061965, 4061.695372847019, 4062.309407400749, 4095.8361665533344, 58555.12167317536, 59236.40763592395, 59388.40611593915, 59447.40552594462, 59537.70231148817, 10396.948015259875, 10515.52680129396, 10612.25714200014, 10915.454227288605, 10972.396518191417, 18787.718184227248, 18788.342408015655, 18832.90583547101, 18890.055497225083, 19921.302754403525, 6865.347791959756, 6865.862682746317, 6893.931060689329, 6989.720411183597, 7083.114610673666, 3736.0, 3761.6238376162714, 3769.849206031728, 3849.6920246380223, 3934.881953541398, 2744.986275068612, 2825.110090321542, 2827.222513808678, 2832.957505637417, 2840.332521857362, 479.1208133075775, 482.98792530186324, 486.47946697033836, 490.9729964851896, 498.53138050232667, 407.5979422239798, 421.2081287180143, 433.3672837656993, 445.32088564938726, 485.61393692014934, 7310.4151667866445, 7692.615369231516, 7733.729319473791, 7754.457187996899, 7770.572618505923, 413.6298013278099, 457.75052596335075, 503.0743432084908, 517.7928828468642, 546.6037123085731, 3440.8451619677176, 3670.2292518570866, 3708.4808126862263, 3878.7672739635714, 3894.5910679378826, 54769.72615136899, 74158.6292068547, 76964.61517692376, 77692.2230777685, 88452.5577372109, 84992.0, 87276.56361718151, 88235.0, 88433.0, 88829.55585222032, 42983.14033719308, 43414.914627134574, 68291.0, 74090.25909740942, 75010.0, 6790.83022924411, 6982.441404687511, 7050.682719277543, 8068.0, 8346.165383461605, 39983.60016399799, 40676.59323406728, 40853.79573102116, 41605.58394416017, 44557.88605284764, 61208.0, 61295.0, 61784.0, 62150.0, 64647.0, 10753.139748820233, 10972.506237219184, 10997.560097596006, 11010.834837477605, 11298.265612735146, 12456.937715311728, 12713.42789574453, 12716.745665086832, 12786.041046921331, 13380.464781409024, 10917.23579349438, 11046.171537134587, 11133.944330278297, 11590.710232243924, 11709.76580468403, 10867.945660271647, 10940.452977350942, 11005.449727513753, 11012.39431831257, 11713.472893719632, 10536.57853685844, 10640.53064053058, 10757.0, 10980.0, 11385.203035787416, 9467.715968520955, 9519.952400238231, 9665.9033409665, 9863.556139973574, 9941.30410871232, 9637.469939153134, 9815.85276220843, 9901.801963960825, 9912.996841666021, 9927.652532161628], "value": 6306.243535958672, "unit": "score"}], "name": "dromaeo_css", "value": 6317.089410950603, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 114.0, 115.0, 109.0, 114.0, 115.0, 114.0, 115.0, 116.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 122.0, 124.0, 196.0, 122.0, 125.0, 146.0, 123.0, 158.0, 122.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 158.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 108.0, 76.0, 78.0, 75.0, 75.0, 111.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 125.0, 86.0, 86.0, 87.0, 123.0, 87.0, 85.0, 127.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 68.0, 65.0, 65.0, 66.0, 73.0, 65.0, 68.0, 65.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 83.0, 83.0, 83.0, 82.0, 84.0, 82.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 133.0, 133.0, 131.0, 130.0, 140.0, 149.0, 147.0, 130.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 173.0, 172.0, 172.0, 177.0, 170.0, 168.0, 168.0, 169.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 71.0, 66.0, 69.0, 66.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1540.3999999999999, "alertThreshold": 2.0}]} 03:54:13 INFO - Return code: 0 03:54:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:13 INFO - # TBPL SUCCESS # 03:54:13 INFO - Running post-action listener: _resource_record_post_action 03:54:13 INFO - [mozharness: 2016-08-17 10:54:13.347193Z] Finished run-tests step (success) 03:54:13 INFO - Running post-run listener: _resource_record_post_run 03:54:13 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 397053952; Read time: 0; Write time: 262996 03:54:13 INFO - TinderboxPrint: CPU usage
13.0% 03:54:13 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:54:13 INFO - TinderboxPrint: I/O write bytes / time
397,053,952 / 262,996 03:54:13 INFO - TinderboxPrint: CPU idle
8,343.3 (87.0%) 03:54:13 INFO - TinderboxPrint: CPU user
1,199.9 (12.5%) 03:54:13 INFO - TinderboxPrint: Swap in / out
0 / 0 03:54:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113418240; Read time: 0; Write time: 83480 03:54:13 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 282619904; Read time: 0; Write time: 179468 03:54:13 INFO - Running post-run listener: _upload_blobber_files 03:54:13 INFO - Blob upload gear active. 03:54:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:54:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:54:14 INFO - (blobuploader) - INFO - Open directory for files ... 03:54:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:54:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:54:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:15 INFO - (blobuploader) - INFO - Done attempting. 03:54:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:54:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:54:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:15 INFO - (blobuploader) - INFO - Done attempting. 03:54:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:54:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:54:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:19 INFO - (blobuploader) - INFO - Done attempting. 03:54:19 INFO - (blobuploader) - INFO - Iteration through files over. 03:54:19 INFO - Return code: 0 03:54:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:54:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:54:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7a51dbef4030bf74607a413b1fec7b1d5705d69afa75f8580df4416d0b06f2796ea0e41580af5e627d3ddf08005b44430be8fcf06a6a1d2fb3dc9db04a5a0d73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e519bf69456f577e822ddbe914bb31e330072b2fe4c0bf29a32e9569093187eb9c1edc4743d193ae2d03e427a8fe5dc1e50a980a7b0f1e1aa5aa536fcb73a241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0844a616348c8b09e6cbd50a7d2a330e4160103c7bce35ad2a23660fa67d08d9656227b30a636facf0d89698d61ad8d91bf5b6cd10602fe2904f65cc7e71155e"} 03:54:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:54:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:54:19 INFO - Contents: 03:54:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7a51dbef4030bf74607a413b1fec7b1d5705d69afa75f8580df4416d0b06f2796ea0e41580af5e627d3ddf08005b44430be8fcf06a6a1d2fb3dc9db04a5a0d73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e519bf69456f577e822ddbe914bb31e330072b2fe4c0bf29a32e9569093187eb9c1edc4743d193ae2d03e427a8fe5dc1e50a980a7b0f1e1aa5aa536fcb73a241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0844a616348c8b09e6cbd50a7d2a330e4160103c7bce35ad2a23660fa67d08d9656227b30a636facf0d89698d61ad8d91bf5b6cd10602fe2904f65cc7e71155e"} 03:54:19 INFO - Running post-run listener: copy_logs_to_upload_dir 03:54:19 INFO - Copying logs to upload dir... 03:54:19 INFO - mkdir: /builds/slave/test/build/upload/logs 03:54:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.867385 ========= master_lag: 1.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-17 03:54:20.027434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 03:54:20.030595) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520 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/7a51dbef4030bf74607a413b1fec7b1d5705d69afa75f8580df4416d0b06f2796ea0e41580af5e627d3ddf08005b44430be8fcf06a6a1d2fb3dc9db04a5a0d73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e519bf69456f577e822ddbe914bb31e330072b2fe4c0bf29a32e9569093187eb9c1edc4743d193ae2d03e427a8fe5dc1e50a980a7b0f1e1aa5aa536fcb73a241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0844a616348c8b09e6cbd50a7d2a330e4160103c7bce35ad2a23660fa67d08d9656227b30a636facf0d89698d61ad8d91bf5b6cd10602fe2904f65cc7e71155e"} build_url:https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/bxEpLMzKTJqm7EGJBdTTsg/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/7a51dbef4030bf74607a413b1fec7b1d5705d69afa75f8580df4416d0b06f2796ea0e41580af5e627d3ddf08005b44430be8fcf06a6a1d2fb3dc9db04a5a0d73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e519bf69456f577e822ddbe914bb31e330072b2fe4c0bf29a32e9569093187eb9c1edc4743d193ae2d03e427a8fe5dc1e50a980a7b0f1e1aa5aa536fcb73a241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0844a616348c8b09e6cbd50a7d2a330e4160103c7bce35ad2a23660fa67d08d9656227b30a636facf0d89698d61ad8d91bf5b6cd10602fe2904f65cc7e71155e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 03:54:20.063870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:54:20.064289) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471430011.356227-989683520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:54:20.336847) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 03:54:20.340213) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 03:54:20.340635) ========= ========= Total master_lag: 1.40 =========