builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1471870224.41 results: success (0) buildid: 20160822051814 builduid: 8bbb730db49f4ddf9a36b1237b0ab0c1 revision: 662270014cb72f82af415385f2f0bef5b135ec04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 05:50:24.415214) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 05:50:24.415887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 05:50:24.416329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 05:50:24.433628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 05:50:24.434059) ========= 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=652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 05:50:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2016-08-22 05:50:24 (42.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113722 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 05:50:24.562227) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 05:50:24.562562) ========= 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=652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015041 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 05:50:24.612974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 05:50:24.613346) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 662270014cb72f82af415385f2f0bef5b135ec04 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 662270014cb72f82af415385f2f0bef5b135ec04 --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=652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 05:50:24,850 truncating revision to first 12 chars 2016-08-22 05:50:24,850 Setting DEBUG logging. 2016-08-22 05:50:24,851 attempt 1/10 2016-08-22 05:50:24,851 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/662270014cb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 05:50:26,212 unpacking tar archive at: fx-team-662270014cb7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.677611 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 05:50:26.306636) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 05:50:26.307490) ========= script_repo_revision: 662270014cb72f82af415385f2f0bef5b135ec04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 05:50:26.308539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 05:50:26.308873) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 05:50:26.319380) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-22 05:50:26.320007) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:50:26 INFO - MultiFileLogger online at 20160822 05:50:26 in /builds/slave/test 05:50:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:50:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:50:26 INFO - {'append_to_log': False, 05:50:26 INFO - 'base_work_dir': '/builds/slave/test', 05:50:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:50:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:50:26 INFO - 'branch': 'Fx-Team-Non-PGO', 05:50:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:50:26 INFO - 'config_files': ('talos/linux_config.py',), 05:50:26 INFO - 'default_actions': ('clobber', 05:50:26 INFO - 'read-buildbot-config', 05:50:26 INFO - 'download-and-extract', 05:50:26 INFO - 'populate-webroot', 05:50:26 INFO - 'create-virtualenv', 05:50:26 INFO - 'install', 05:50:26 INFO - 'run-tests'), 05:50:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:50:26 INFO - 'download_minidump_stackwalk': True, 05:50:26 INFO - 'download_symbols': 'ondemand', 05:50:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:50:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:50:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:50:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:50:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:50:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:50:26 INFO - 'installer_path': 'installer.exe', 05:50:26 INFO - 'log_level': 'info', 05:50:26 INFO - 'log_name': 'talos', 05:50:26 INFO - 'log_to_console': True, 05:50:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:50:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:50:26 INFO - 'opt_config_files': (), 05:50:26 INFO - 'pip_index': False, 05:50:26 INFO - 'sps_profile': False, 05:50:26 INFO - 'sps_profile_interval': 0, 05:50:26 INFO - 'suite': 'dromaeojs', 05:50:26 INFO - 'system_bits': '32', 05:50:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:50:26 INFO - 'title': 'talos-linux64-ix-046', 05:50:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:50:26 INFO - 'use_talos_json': True, 05:50:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:50:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:50:26 INFO - 'work_dir': 'build'} 05:50:26 INFO - [mozharness: 2016-08-22 12:50:26.653991Z] Running clobber step. 05:50:26 INFO - Running pre-action listener: _resource_record_pre_action 05:50:26 INFO - Running main action method: clobber 05:50:26 INFO - rmtree: /builds/slave/test/build 05:50:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:50:27 INFO - Running post-action listener: _resource_record_post_action 05:50:27 INFO - [mozharness: 2016-08-22 12:50:27.627755Z] Finished clobber step (success) 05:50:27 INFO - [mozharness: 2016-08-22 12:50:27.627854Z] Running read-buildbot-config step. 05:50:27 INFO - Running pre-action listener: _resource_record_pre_action 05:50:27 INFO - Running main action method: read_buildbot_config 05:50:27 INFO - Using buildbot properties: 05:50:27 INFO - { 05:50:27 INFO - "project": "", 05:50:27 INFO - "product": "firefox", 05:50:27 INFO - "script_repo_revision": "production", 05:50:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:50:27 INFO - "repository": "", 05:50:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:50:27 INFO - "buildid": "20160822051814", 05:50:27 INFO - "pgo_build": "False", 05:50:27 INFO - "basedir": "/builds/slave/test", 05:50:27 INFO - "buildnumber": 2107, 05:50:27 INFO - "slavename": "talos-linux64-ix-046", 05:50:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:50:27 INFO - "platform": "ubuntu64_hw", 05:50:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:50:27 INFO - "branch": "fx-team", 05:50:27 INFO - "repo_path": "integration/fx-team", 05:50:27 INFO - "revision": "662270014cb72f82af415385f2f0bef5b135ec04", 05:50:27 INFO - "stage_platform": "linux64", 05:50:27 INFO - "builduid": "8bbb730db49f4ddf9a36b1237b0ab0c1", 05:50:27 INFO - "slavebuilddir": "test" 05:50:27 INFO - } 05:50:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:50:27 INFO - Running post-action listener: _resource_record_post_action 05:50:27 INFO - [mozharness: 2016-08-22 12:50:27.630253Z] Finished read-buildbot-config step (success) 05:50:27 INFO - [mozharness: 2016-08-22 12:50:27.630340Z] Running download-and-extract step. 05:50:27 INFO - Running pre-action listener: _resource_record_pre_action 05:50:27 INFO - Running main action method: download_and_extract 05:50:27 INFO - mkdir: /builds/slave/test/build/tests 05:50:27 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')]} 05:50:27 INFO - trying https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:50:27 INFO - Downloading https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/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 05:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/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 05:50:28 INFO - Downloaded 1361 bytes. 05:50:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:50:28 INFO - Using the following test package requirements: 05:50:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:50:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:50:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:28 INFO - u'jsshell-linux-x86_64.zip'], 05:50:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:50:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:50:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:50:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:50:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:50:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:50: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')]} 05:50:28 INFO - trying https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:50:28 INFO - Downloading https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/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 05:50:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/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 05:50:29 INFO - Downloaded 20330325 bytes. 05:50:29 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 05:50:33 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 05:50: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')]} 05:50:33 INFO - trying https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:50:33 INFO - Downloading https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/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 05:50:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/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 05:50:34 INFO - Downloaded 20330325 bytes. 05:50:34 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 05:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:39 INFO - trying https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:39 INFO - Downloading https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/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 05:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/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 05:50:39 INFO - Downloaded 14413981 bytes. 05:50:39 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 05:50:40 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')]} 05:50:40 INFO - trying https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:50:40 INFO - Downloading https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/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 05:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/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 05:50:41 INFO - Downloaded 55779086 bytes. 05:50:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:50:41 INFO - mkdir: /builds/slave/test/properties 05:50:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:50:41 INFO - Writing to file /builds/slave/test/properties/build_url 05:50:41 INFO - Contents: 05:50:41 INFO - build_url:https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:50:41 INFO - Running post-action listener: _resource_record_post_action 05:50:41 INFO - Running post-action listener: set_extra_try_arguments 05:50:41 INFO - [mozharness: 2016-08-22 12:50:41.980630Z] Finished download-and-extract step (success) 05:50:41 INFO - [mozharness: 2016-08-22 12:50:41.980852Z] Running populate-webroot step. 05:50:41 INFO - Running pre-action listener: _resource_record_pre_action 05:50:41 INFO - Running main action method: populate_webroot 05:50:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:50:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:50:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:50:41 INFO - '--tppagecycles', 05:50:41 INFO - '7'], 05:50:41 INFO - 'tests': ['tsvgm']}}, 05:50:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:50:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:50:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:50:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:50:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:50:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:50:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:41 INFO - 'talos_options': ['--disable-e10s'], 05:50:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:41 INFO - 'talos_options': ['--disable-e10s'], 05:50:41 INFO - 'tests': ['damp', 'tps']}, 05:50:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:41 INFO - 'tests': ['damp', 'tps']}, 05:50:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:50:41 INFO - 'tests': ['dromaeo_dom']}, 05:50:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:50:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:50:41 INFO - 'tests': ['basic_compositor_video']}, 05:50:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:50:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:50:41 INFO - 'tests': ['a11yr', 05:50:41 INFO - 'ts_paint', 05:50:41 INFO - 'tpaint', 05:50:41 INFO - 'sessionrestore', 05:50:41 INFO - 'sessionrestore_no_auto_restore', 05:50:41 INFO - 'tabpaint']}, 05:50:41 INFO - 'other-e10s': {'tests': ['a11yr', 05:50:41 INFO - 'ts_paint', 05:50:41 INFO - 'tpaint', 05:50:41 INFO - 'sessionrestore', 05:50:41 INFO - 'sessionrestore_no_auto_restore', 05:50:41 INFO - 'tabpaint']}, 05:50:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:50:41 INFO - 'ts_paint', 05:50:41 INFO - 'tpaint', 05:50:41 INFO - 'sessionrestore', 05:50:41 INFO - 'sessionrestore_no_auto_restore', 05:50:41 INFO - 'tabpaint']}, 05:50:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:50:41 INFO - 'ts_paint', 05:50:41 INFO - 'tpaint', 05:50:41 INFO - 'sessionrestore', 05:50:41 INFO - 'sessionrestore_no_auto_restore', 05:50:41 INFO - 'tabpaint']}, 05:50:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:50:41 INFO - 'tests': ['a11yr', 05:50:41 INFO - 'ts_paint', 05:50:41 INFO - 'tpaint', 05:50:41 INFO - 'sessionrestore', 05:50:41 INFO - 'sessionrestore_no_auto_restore', 05:50:41 INFO - 'tabpaint']}, 05:50:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:50:41 INFO - 'tests': ['a11yr', 05:50:41 INFO - 'ts_paint', 05:50:41 INFO - 'tpaint', 05:50:41 INFO - 'sessionrestore', 05:50:41 INFO - 'sessionrestore_no_auto_restore', 05:50:41 INFO - 'tabpaint']}, 05:50:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:50:41 INFO - 'tests': ['tsvgx', 05:50:41 INFO - 'tsvgr_opacity', 05:50:41 INFO - 'tart', 05:50:41 INFO - 'tscrollx', 05:50:41 INFO - 'cart']}, 05:50:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:50:41 INFO - 'tsvgr_opacity', 05:50:41 INFO - 'tart', 05:50:41 INFO - 'tscrollx', 05:50:41 INFO - 'cart']}, 05:50:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:41 INFO - 'talos_options': ['--disable-e10s'], 05:50:41 INFO - 'tests': ['tp5o']}, 05:50:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:41 INFO - 'tests': ['tp5o']}, 05:50:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:41 INFO - 'talos_options': ['--disable-e10s', 05:50:41 INFO - '--xperf_path', 05:50:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:41 INFO - 'tests': ['tp5n']}, 05:50:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:41 INFO - 'talos_options': ['--xperf_path', 05:50:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:41 INFO - 'tests': ['tp5n']}}, 05:50:41 INFO - 'talos.zip': {'path': '', 05:50:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:50:41 INFO - Running post-action listener: _resource_record_post_action 05:50:41 INFO - [mozharness: 2016-08-22 12:50:41.998988Z] Finished populate-webroot step (success) 05:50:41 INFO - [mozharness: 2016-08-22 12:50:41.999076Z] Running create-virtualenv step. 05:50:41 INFO - Running pre-action listener: _resource_record_pre_action 05:50:41 INFO - Running main action method: create_virtualenv 05:50:41 INFO - Creating virtualenv /builds/slave/test/build/venv 05:50:41 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 05:50:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:50:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:50:42 INFO - Using real prefix '/usr' 05:50:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:50:42 INFO - Installing distribute.............................................................................................................................................................................................done. 05:50:44 INFO - Installing pip.................done. 05:50:44 INFO - Return code: 0 05:50:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:44 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 0x7f3e1482bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6090>, '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 0x13b99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9e40>, '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': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', '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 05:50:44 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 05:50:44 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 05:50:44 INFO - Using env: {'DISPLAY': ':0', 05:50:44 INFO - 'HOME': '/home/cltbld', 05:50:44 INFO - 'LANG': 'en_US.UTF-8', 05:50:44 INFO - 'LANGUAGE': 'en_US:en', 05:50:44 INFO - 'LOGNAME': 'cltbld', 05:50:44 INFO - 'MAIL': '/var/mail/cltbld', 05:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:44 INFO - 'MOZ_NO_REMOTE': '1', 05:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:44 INFO - 'NO_EM_RESTART': '1', 05:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:44 INFO - 'PWD': '/builds/slave/test', 05:50:44 INFO - 'SHELL': '/bin/bash', 05:50:44 INFO - 'SHLVL': '1', 05:50:44 INFO - 'TERM': 'linux', 05:50:44 INFO - 'TMOUT': '86400', 05:50:44 INFO - 'USER': 'cltbld', 05:50:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', 05:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:44 INFO - '_': '/tools/buildbot/bin/python'} 05:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:44 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 05:50:44 INFO - Cleaning up... 05:50:44 INFO - Return code: 0 05:50:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:44 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 0x7f3e1482bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6090>, '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 0x13b99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9e40>, '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': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', '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 05:50:44 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 05:50:44 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 05:50:44 INFO - Using env: {'DISPLAY': ':0', 05:50:44 INFO - 'HOME': '/home/cltbld', 05:50:44 INFO - 'LANG': 'en_US.UTF-8', 05:50:44 INFO - 'LANGUAGE': 'en_US:en', 05:50:44 INFO - 'LOGNAME': 'cltbld', 05:50:44 INFO - 'MAIL': '/var/mail/cltbld', 05:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:44 INFO - 'MOZ_NO_REMOTE': '1', 05:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:44 INFO - 'NO_EM_RESTART': '1', 05:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:44 INFO - 'PWD': '/builds/slave/test', 05:50:44 INFO - 'SHELL': '/bin/bash', 05:50:44 INFO - 'SHLVL': '1', 05:50:44 INFO - 'TERM': 'linux', 05:50:44 INFO - 'TMOUT': '86400', 05:50:44 INFO - 'USER': 'cltbld', 05:50:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', 05:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:44 INFO - '_': '/tools/buildbot/bin/python'} 05:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:45 INFO - Downloading/unpacking psutil>=3.1.1 05:50:45 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 05:50:45 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 05:50:45 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 05:50:45 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 05:50:45 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 05:50:45 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 05:50:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:50:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:47 INFO - Installing collected packages: psutil 05:50:47 INFO - Running setup.py install for psutil 05:50:47 INFO - building 'psutil._psutil_linux' extension 05:50:47 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 05:50:47 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 05:50:47 INFO - building 'psutil._psutil_posix' extension 05:50:47 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 05:50:47 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 05:50:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:47 INFO - Successfully installed psutil 05:50:47 INFO - Cleaning up... 05:50:47 INFO - Return code: 0 05:50:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:47 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 0x7f3e1482bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6090>, '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 0x13b99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9e40>, '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': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', '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 05:50:47 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 05:50:47 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 05:50:47 INFO - Using env: {'DISPLAY': ':0', 05:50:47 INFO - 'HOME': '/home/cltbld', 05:50:47 INFO - 'LANG': 'en_US.UTF-8', 05:50:47 INFO - 'LANGUAGE': 'en_US:en', 05:50:47 INFO - 'LOGNAME': 'cltbld', 05:50:47 INFO - 'MAIL': '/var/mail/cltbld', 05:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:47 INFO - 'MOZ_NO_REMOTE': '1', 05:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:47 INFO - 'NO_EM_RESTART': '1', 05:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:47 INFO - 'PWD': '/builds/slave/test', 05:50:47 INFO - 'SHELL': '/bin/bash', 05:50:47 INFO - 'SHLVL': '1', 05:50:47 INFO - 'TERM': 'linux', 05:50:47 INFO - 'TMOUT': '86400', 05:50:47 INFO - 'USER': 'cltbld', 05:50:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', 05:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:47 INFO - '_': '/tools/buildbot/bin/python'} 05:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:50:47 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 05:50:47 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 05:50:47 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 05:50:47 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 05:50:47 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 05:50:47 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 05:50:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:50:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:50:49 INFO - Installing collected packages: mozsystemmonitor 05:50:49 INFO - Running setup.py install for mozsystemmonitor 05:50:49 INFO - Successfully installed mozsystemmonitor 05:50:49 INFO - Cleaning up... 05:50:49 INFO - Return code: 0 05:50:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e1482bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6090>, '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 0x13b99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9e40>, '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': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', '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 05:50:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:50:49 INFO - Using env: {'DISPLAY': ':0', 05:50:49 INFO - 'HOME': '/home/cltbld', 05:50:49 INFO - 'LANG': 'en_US.UTF-8', 05:50:49 INFO - 'LANGUAGE': 'en_US:en', 05:50:49 INFO - 'LOGNAME': 'cltbld', 05:50:49 INFO - 'MAIL': '/var/mail/cltbld', 05:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:49 INFO - 'MOZ_NO_REMOTE': '1', 05:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:49 INFO - 'NO_EM_RESTART': '1', 05:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:49 INFO - 'PWD': '/builds/slave/test', 05:50:49 INFO - 'SHELL': '/bin/bash', 05:50:49 INFO - 'SHLVL': '1', 05:50:49 INFO - 'TERM': 'linux', 05:50:49 INFO - 'TMOUT': '86400', 05:50:49 INFO - 'USER': 'cltbld', 05:50:49 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', 05:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:49 INFO - '_': '/tools/buildbot/bin/python'} 05:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:50 INFO - Downloading/unpacking jsonschema==2.5.1 05:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:50:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:52 INFO - Downloading functools32-3.2.3-2.tar.gz 05:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:50:52 INFO - warning: no files found matching '*.txt' 05:50:52 INFO - no previously-included directories found matching 'build' 05:50:52 INFO - no previously-included directories found matching 'dist' 05:50:52 INFO - no previously-included directories found matching '.git*' 05:50:52 INFO - Installing collected packages: jsonschema, functools32 05:50:52 INFO - Running setup.py install for functools32 05:50:52 INFO - warning: no files found matching '*.txt' 05:50:52 INFO - no previously-included directories found matching 'build' 05:50:52 INFO - no previously-included directories found matching 'dist' 05:50:52 INFO - no previously-included directories found matching '.git*' 05:50:52 INFO - Successfully installed jsonschema functools32 05:50:52 INFO - Cleaning up... 05:50:52 INFO - Return code: 0 05:50:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:50:52 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')]} 05:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:52 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')]} 05:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:52 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 0x7f3e1482bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6090>, '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 0x13b99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9e40>, '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': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', '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 05:50:52 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 05:50:52 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 05:50:52 INFO - Using env: {'DISPLAY': ':0', 05:50:52 INFO - 'HOME': '/home/cltbld', 05:50:52 INFO - 'LANG': 'en_US.UTF-8', 05:50:52 INFO - 'LANGUAGE': 'en_US:en', 05:50:52 INFO - 'LOGNAME': 'cltbld', 05:50:52 INFO - 'MAIL': '/var/mail/cltbld', 05:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:52 INFO - 'MOZ_NO_REMOTE': '1', 05:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:52 INFO - 'NO_EM_RESTART': '1', 05:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:52 INFO - 'PWD': '/builds/slave/test', 05:50:52 INFO - 'SHELL': '/bin/bash', 05:50:52 INFO - 'SHLVL': '1', 05:50:52 INFO - 'TERM': 'linux', 05:50:52 INFO - 'TMOUT': '86400', 05:50:52 INFO - 'USER': 'cltbld', 05:50:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', 05:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:52 INFO - '_': '/tools/buildbot/bin/python'} 05:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:50:52 INFO - Cleaning up... 05:50:52 INFO - Return code: 0 05:50:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:50:52 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')]} 05:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:52 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')]} 05:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:52 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 0x7f3e1482bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6090>, '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 0x13b99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9e40>, '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': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', '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 05:50:52 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 05:50:52 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 05:50:52 INFO - Using env: {'DISPLAY': ':0', 05:50:52 INFO - 'HOME': '/home/cltbld', 05:50:52 INFO - 'LANG': 'en_US.UTF-8', 05:50:52 INFO - 'LANGUAGE': 'en_US:en', 05:50:52 INFO - 'LOGNAME': 'cltbld', 05:50:52 INFO - 'MAIL': '/var/mail/cltbld', 05:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:52 INFO - 'MOZ_NO_REMOTE': '1', 05:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:52 INFO - 'NO_EM_RESTART': '1', 05:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:52 INFO - 'PWD': '/builds/slave/test', 05:50:52 INFO - 'SHELL': '/bin/bash', 05:50:52 INFO - 'SHLVL': '1', 05:50:52 INFO - 'TERM': 'linux', 05:50:52 INFO - 'TMOUT': '86400', 05:50:52 INFO - 'USER': 'cltbld', 05:50:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', 05:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:52 INFO - '_': '/tools/buildbot/bin/python'} 05:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:50:52 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 05:50:52 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 05:50:52 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 05:50:52 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 05:50:52 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 05:50:52 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 05:50:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:50:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:50:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:55 INFO - Downloading docopt-0.6.1.tar.gz 05:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:50:55 INFO - Installing collected packages: blobuploader, requests, docopt 05:50:55 INFO - Running setup.py install for blobuploader 05:50:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:50:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:50:55 INFO - Running setup.py install for requests 05:50:55 INFO - Running setup.py install for docopt 05:50:55 INFO - Successfully installed blobuploader requests docopt 05:50:55 INFO - Cleaning up... 05:50:56 INFO - Return code: 0 05:50:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:56 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 0x7f3e1482bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6090>, '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 0x13b99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9e40>, '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': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', '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 05:50:56 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 05:50:56 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 05:50:56 INFO - Using env: {'DISPLAY': ':0', 05:50:56 INFO - 'HOME': '/home/cltbld', 05:50:56 INFO - 'LANG': 'en_US.UTF-8', 05:50:56 INFO - 'LANGUAGE': 'en_US:en', 05:50:56 INFO - 'LOGNAME': 'cltbld', 05:50:56 INFO - 'MAIL': '/var/mail/cltbld', 05:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:56 INFO - 'MOZ_NO_REMOTE': '1', 05:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:56 INFO - 'NO_EM_RESTART': '1', 05:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:56 INFO - 'PWD': '/builds/slave/test', 05:50:56 INFO - 'SHELL': '/bin/bash', 05:50:56 INFO - 'SHLVL': '1', 05:50:56 INFO - 'TERM': 'linux', 05:50:56 INFO - 'TMOUT': '86400', 05:50:56 INFO - 'USER': 'cltbld', 05:50:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', 05:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:56 INFO - '_': '/tools/buildbot/bin/python'} 05:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:56 INFO - Running setup.py (path:/tmp/pip-KR8ADd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:56 INFO - Running setup.py (path:/tmp/pip-huyU6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:56 INFO - Running setup.py (path:/tmp/pip-h41xMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:56 INFO - Running setup.py (path:/tmp/pip-Vh1NEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:56 INFO - Running setup.py (path:/tmp/pip-vcF31q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:56 INFO - Running setup.py (path:/tmp/pip-4HCL1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:56 INFO - Running setup.py (path:/tmp/pip-Q9HmRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:56 INFO - Running setup.py (path:/tmp/pip-kDeA57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:56 INFO - Running setup.py (path:/tmp/pip-I_nWOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:56 INFO - Running setup.py (path:/tmp/pip-6_F4O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:56 INFO - Running setup.py (path:/tmp/pip-M7E38g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:57 INFO - Running setup.py (path:/tmp/pip-GhDUCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:57 INFO - Running setup.py (path:/tmp/pip-8uqZ6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:57 INFO - Running setup.py (path:/tmp/pip-Z3ZcCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:57 INFO - Running setup.py (path:/tmp/pip-UtKGhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:57 INFO - Running setup.py (path:/tmp/pip-3fyh0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:57 INFO - Running setup.py (path:/tmp/pip-C1iTlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:50:57 INFO - Running setup.py install for manifestparser 05:50:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:50:57 INFO - Running setup.py install for mozcrash 05:50:57 INFO - Running setup.py install for mozdebug 05:50:57 INFO - Running setup.py install for mozdevice 05:50:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:50:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:50:57 INFO - Running setup.py install for mozfile 05:50:57 INFO - Running setup.py install for mozhttpd 05:50:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Running setup.py install for mozinfo 05:50:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Running setup.py install for mozInstall 05:50:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Running setup.py install for mozleak 05:50:58 INFO - Running setup.py install for mozlog 05:50:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Running setup.py install for moznetwork 05:50:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Running setup.py install for mozprocess 05:50:58 INFO - Running setup.py install for mozprofile 05:50:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Running setup.py install for mozrunner 05:50:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Running setup.py install for mozscreenshot 05:50:59 INFO - Running setup.py install for moztest 05:50:59 INFO - Running setup.py install for mozversion 05:50:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:50:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:50:59 INFO - Cleaning up... 05:50:59 INFO - Return code: 0 05:50:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:59 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 0x7f3e1482bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6090>, '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 0x13b99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9e40>, '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': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', '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 05:50:59 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 05:50:59 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 05:50:59 INFO - Using env: {'DISPLAY': ':0', 05:50:59 INFO - 'HOME': '/home/cltbld', 05:50:59 INFO - 'LANG': 'en_US.UTF-8', 05:50:59 INFO - 'LANGUAGE': 'en_US:en', 05:50:59 INFO - 'LOGNAME': 'cltbld', 05:50:59 INFO - 'MAIL': '/var/mail/cltbld', 05:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:59 INFO - 'MOZ_NO_REMOTE': '1', 05:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:59 INFO - 'NO_EM_RESTART': '1', 05:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:59 INFO - 'PWD': '/builds/slave/test', 05:50:59 INFO - 'SHELL': '/bin/bash', 05:50:59 INFO - 'SHLVL': '1', 05:50:59 INFO - 'TERM': 'linux', 05:50:59 INFO - 'TMOUT': '86400', 05:50:59 INFO - 'USER': 'cltbld', 05:50:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', 05:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:59 INFO - '_': '/tools/buildbot/bin/python'} 05:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:59 INFO - Running setup.py (path:/tmp/pip-1WiyY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:59 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)) 05:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:59 INFO - Running setup.py (path:/tmp/pip-Iy_Zl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:59 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)) 05:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:59 INFO - Running setup.py (path:/tmp/pip-akuT9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:59 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)) 05:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:59 INFO - Running setup.py (path:/tmp/pip-A2e9Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:59 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)) 05:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:59 INFO - Running setup.py (path:/tmp/pip-OOMoMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:59 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)) 05:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:59 INFO - Running setup.py (path:/tmp/pip-J6zlkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:59 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)) 05:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:59 INFO - Running setup.py (path:/tmp/pip-HMiJTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:59 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)) 05:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:59 INFO - Running setup.py (path:/tmp/pip-oBGR4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:00 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)) 05:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:00 INFO - Running setup.py (path:/tmp/pip-xMBURc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:00 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)) 05:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:00 INFO - Running setup.py (path:/tmp/pip-vCMmyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:00 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)) 05:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:00 INFO - Running setup.py (path:/tmp/pip-P6wSOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:00 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)) 05:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:00 INFO - Running setup.py (path:/tmp/pip-qksaTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:00 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)) 05:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:00 INFO - Running setup.py (path:/tmp/pip-KpSkGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:00 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)) 05:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:00 INFO - Running setup.py (path:/tmp/pip-L05rxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:00 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)) 05:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:00 INFO - Running setup.py (path:/tmp/pip-HP7Ol3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:00 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)) 05:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:00 INFO - Running setup.py (path:/tmp/pip-fVJuEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:00 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)) 05:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:00 INFO - Running setup.py (path:/tmp/pip-It_mnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:00 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)) 05:51:00 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)) 05:51:00 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)) 05:51:00 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)) 05:51:00 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)) 05:51:00 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)) 05:51:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:02 INFO - Downloading blessings-1.6.tar.gz 05:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:51:02 INFO - Installing collected packages: blessings 05:51:02 INFO - Running setup.py install for blessings 05:51:02 INFO - Successfully installed blessings 05:51:02 INFO - Cleaning up... 05:51:02 INFO - Return code: 0 05:51:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:51:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:03 INFO - Reading from file tmpfile_stdout 05:51:03 INFO - Current package versions: 05:51:03 INFO - argparse == 1.2.1 05:51:03 INFO - blessings == 1.6 05:51:03 INFO - blobuploader == 1.2.4 05:51:03 INFO - docopt == 0.6.1 05:51:03 INFO - functools32 == 3.2.3-2 05:51:03 INFO - jsonschema == 2.5.1 05:51:03 INFO - manifestparser == 1.1 05:51:03 INFO - mozInstall == 1.12 05:51:03 INFO - mozcrash == 0.17 05:51:03 INFO - mozdebug == 0.1 05:51:03 INFO - mozdevice == 0.48 05:51:03 INFO - mozfile == 1.2 05:51:03 INFO - mozhttpd == 0.7 05:51:03 INFO - mozinfo == 0.9 05:51:03 INFO - mozleak == 0.1 05:51:03 INFO - mozlog == 3.3 05:51:03 INFO - moznetwork == 0.27 05:51:03 INFO - mozprocess == 0.23 05:51:03 INFO - mozprofile == 0.28 05:51:03 INFO - mozrunner == 6.12 05:51:03 INFO - mozscreenshot == 0.1 05:51:03 INFO - mozsystemmonitor == 0.3 05:51:03 INFO - moztest == 0.7 05:51:03 INFO - mozversion == 1.4 05:51:03 INFO - psutil == 3.1.1 05:51:03 INFO - requests == 1.2.3 05:51:03 INFO - wsgiref == 0.1.2 05:51:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:03 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 0x7f3e1482bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6090>, '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 0x13b99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9e40>, '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': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', '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 05:51:03 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 05:51:03 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 05:51:03 INFO - Using env: {'DISPLAY': ':0', 05:51:03 INFO - 'HOME': '/home/cltbld', 05:51:03 INFO - 'LANG': 'en_US.UTF-8', 05:51:03 INFO - 'LANGUAGE': 'en_US:en', 05:51:03 INFO - 'LOGNAME': 'cltbld', 05:51:03 INFO - 'MAIL': '/var/mail/cltbld', 05:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:03 INFO - 'MOZ_NO_REMOTE': '1', 05:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:03 INFO - 'NO_EM_RESTART': '1', 05:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:03 INFO - 'PWD': '/builds/slave/test', 05:51:03 INFO - 'SHELL': '/bin/bash', 05:51:03 INFO - 'SHLVL': '1', 05:51:03 INFO - 'TERM': 'linux', 05:51:03 INFO - 'TMOUT': '86400', 05:51:03 INFO - 'USER': 'cltbld', 05:51:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', 05:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:03 INFO - '_': '/tools/buildbot/bin/python'} 05:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:03 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)) 05:51:03 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)) 05:51:03 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)) 05:51:03 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)) 05:51:03 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)) 05:51:03 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)) 05:51:03 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)) 05:51:03 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)) 05:51:03 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)) 05:51:03 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)) 05:51:03 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)) 05:51:03 INFO - Cleaning up... 05:51:03 INFO - Return code: 0 05:51:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e1482bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6090>, '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 0x13b99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9e40>, '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': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', '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 05:51:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:51:03 INFO - Using env: {'DISPLAY': ':0', 05:51:03 INFO - 'HOME': '/home/cltbld', 05:51:03 INFO - 'LANG': 'en_US.UTF-8', 05:51:03 INFO - 'LANGUAGE': 'en_US:en', 05:51:03 INFO - 'LOGNAME': 'cltbld', 05:51:03 INFO - 'MAIL': '/var/mail/cltbld', 05:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:03 INFO - 'MOZ_NO_REMOTE': '1', 05:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:03 INFO - 'NO_EM_RESTART': '1', 05:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:03 INFO - 'PWD': '/builds/slave/test', 05:51:03 INFO - 'SHELL': '/bin/bash', 05:51:03 INFO - 'SHLVL': '1', 05:51:03 INFO - 'TERM': 'linux', 05:51:03 INFO - 'TMOUT': '86400', 05:51:03 INFO - 'USER': 'cltbld', 05:51:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', 05:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:03 INFO - '_': '/tools/buildbot/bin/python'} 05:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:51:03 INFO - Cleaning up... 05:51:03 INFO - Return code: 0 05:51:03 INFO - Running post-action listener: _resource_record_post_action 05:51:03 INFO - Running post-action listener: _start_resource_monitoring 05:51:03 INFO - Starting resource monitoring. 05:51:03 INFO - [mozharness: 2016-08-22 12:51:03.496814Z] Finished create-virtualenv step (success) 05:51:03 INFO - [mozharness: 2016-08-22 12:51:03.497333Z] Running install step. 05:51:03 INFO - Running pre-action listener: _resource_record_pre_action 05:51:03 INFO - Running main action method: install 05:51:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:03 INFO - Reading from file tmpfile_stdout 05:51:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:51:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:51:03 INFO - Reading from file tmpfile_stdout 05:51:03 INFO - Output received: 05:51:03 INFO - Usage: mozinstall [options] installer 05:51:03 INFO - Options: 05:51:03 INFO - -h, --help show this help message and exit 05:51:03 INFO - -d DEST, --destination=DEST 05:51:03 INFO - Directory to install application into. [default: 05:51:03 INFO - "/builds/slave/test"] 05:51:03 INFO - --app=APP Application being installed. [default: firefox] 05:51:03 INFO - mkdir: /builds/slave/test/build/application 05:51:03 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'] 05:51:03 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 05:51:19 INFO - Reading from file tmpfile_stdout 05:51:19 INFO - Output received: 05:51:19 INFO - /builds/slave/test/build/application/firefox/firefox 05:51:19 INFO - Running post-action listener: _resource_record_post_action 05:51:19 INFO - [mozharness: 2016-08-22 12:51:19.881190Z] Finished install step (success) 05:51:19 INFO - [mozharness: 2016-08-22 12:51:19.881435Z] Running run-tests step. 05:51:19 INFO - Running pre-action listener: _resource_record_pre_action 05:51:19 INFO - Running main action method: run_tests 05:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:51:19 INFO - Python 2.7.3 05:51:19 INFO - Return code: 0 05:51:19 INFO - grabbing minidump binary from tooltool 05:51:19 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')]} 05:51:19 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 0x13b6090>, '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 0x13b99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:51:19 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 05:51:19 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 05:51:19 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 05:51:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:19 INFO - Return code: 0 05:51:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:51:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:51:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:51:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:51:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 05:51:19 INFO - Using env: {'DISPLAY': ':0', 05:51:19 INFO - 'HOME': '/home/cltbld', 05:51:19 INFO - 'LANG': 'en_US.UTF-8', 05:51:19 INFO - 'LANGUAGE': 'en_US:en', 05:51:19 INFO - 'LOGNAME': 'cltbld', 05:51:19 INFO - 'MAIL': '/var/mail/cltbld', 05:51:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:19 INFO - 'MOZ_NO_REMOTE': '1', 05:51:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:19 INFO - 'NO_EM_RESTART': '1', 05:51:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:19 INFO - 'PWD': '/builds/slave/test', 05:51:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:19 INFO - 'SHELL': '/bin/bash', 05:51:19 INFO - 'SHLVL': '1', 05:51:19 INFO - 'TERM': 'linux', 05:51:19 INFO - 'TMOUT': '86400', 05:51:19 INFO - 'USER': 'cltbld', 05:51:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929', 05:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:19 INFO - '_': '/tools/buildbot/bin/python'} 05:51:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:51:20 INFO - mozversion application_buildid: 20160822051814 05:51:20 INFO - mozversion application_changeset: 662270014cb72f82af415385f2f0bef5b135ec04 05:51:20 INFO - mozversion application_display_name: Nightly 05:51:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:20 INFO - mozversion application_name: Firefox 05:51:20 INFO - mozversion application_remotingname: firefox 05:51:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:51:20 INFO - mozversion application_vendor: Mozilla 05:51:20 INFO - mozversion application_version: 51.0a1 05:51:20 INFO - mozversion platform_buildid: 20160822051814 05:51:20 INFO - mozversion platform_changeset: 662270014cb72f82af415385f2f0bef5b135ec04 05:51:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:51:20 INFO - mozversion platform_version: 51.0a1 05:51:20 INFO - using testdate: 1471870280 05:51:20 INFO - actual date: 1471870280 05:51:20 INFO - starting webserver on 'localhost:40588' 05:51:20 INFO - SUITE-START | Running 2 tests 05:51:20 INFO - TEST-START | dromaeo_css 05:51:20 INFO - operating with platform_type : linux_ 05:51:20 INFO - Initialising browser for dromaeo_css test... 05:51:20 INFO - TEST-INFO | started process 29605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdfnY18/profile http://localhost:40588/getInfo.html) 05:51:24 INFO - PROCESS | 29605 | __metrics Screen width/height:1600/1200 05:51:24 INFO - PROCESS | 29605 | colorDepth:24 05:51:24 INFO - PROCESS | 29605 | Browser inner width/height: 1024/697 05:51:24 INFO - PROCESS | 29605 | __metrics 05:51:25 INFO - PROCESS | 29605 | 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" 05:51:25 INFO - PROCESS | 29605 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:25 INFO - PROCESS | 29605 | console.error: PushService: 05:51:25 INFO - PROCESS | 29605 | stateChangeProcessEnqueue: Error transitioning state 05:51:25 INFO - PROCESS | 29605 | UnknownError 05:51:26 INFO - TEST-INFO | 29605: exit 0 05:51:26 INFO - Browser initialized. 05:51:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:51:26 INFO - TEST-INFO | started process 29688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdfnY18/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:38 INFO - PROCESS | 29688 | RSS: Main: 177594368 05:51:38 INFO - PROCESS | 29688 | 05:52:29 INFO - PROCESS | 29688 | 1471870349833 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] 05:54:43 INFO - PROCESS | 29688 | Cycle 1(1): loaded http://localhost:40588/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40588/tests/dromaeo/cssquery-ext.html) 05:54:44 INFO - PROCESS | 29688 | RSS: Main: 254963712 05:54:44 INFO - PROCESS | 29688 | 05:57:47 INFO - PROCESS | 29688 | Cycle 1(1): loaded http://localhost:40588/tests/dromaeo/cssquery-ext.html (next: http://localhost:40588/tests/dromaeo/cssquery-jquery.html) 05:57:47 INFO - PROCESS | 29688 | RSS: Main: 273727488 05:57:47 INFO - PROCESS | 29688 | 06:00:49 INFO - PROCESS | 29688 | Cycle 1(1): loaded http://localhost:40588/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40588/tests/dromaeo/cssquery-mootools.html) 06:00:50 INFO - PROCESS | 29688 | RSS: Main: 258555904 06:00:50 INFO - PROCESS | 29688 | 06:03:52 INFO - PROCESS | 29688 | Cycle 1(1): loaded http://localhost:40588/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40588/tests/dromaeo/cssquery-prototype.html) 06:03:53 INFO - PROCESS | 29688 | RSS: Main: 216670208 06:03:53 INFO - PROCESS | 29688 | 06:06:56 INFO - PROCESS | 29688 | Cycle 1(1): loaded http://localhost:40588/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40588/tests/dromaeo/cssquery-yui.html) 06:06:57 INFO - PROCESS | 29688 | RSS: Main: 216858624 06:06:57 INFO - PROCESS | 29688 | 06:10:00 INFO - PROCESS | 29688 | Cycle 1(1): loaded http://localhost:40588/tests/dromaeo/cssquery-yui.html (next: http://localhost:40588/tests/dromaeo/cssquery-dojo.html) 06:10:00 INFO - PROCESS | 29688 | RSS: Main: 306454528 06:10:00 INFO - PROCESS | 29688 | 06:10:00 INFO - PROCESS | 29688 | __start_tp_report 06:10:00 INFO - PROCESS | 29688 | _x_x_mozilla_page_load 06:10:00 INFO - PROCESS | 29688 | _x_x_mozilla_page_load_details 06:10:00 INFO - PROCESS | 29688 | |i|pagename|runs| 06:10:00 INFO - PROCESS | 29688 | |0;dojo.html;2580.8709564521773;2626.0677459501862;2631.46055058713;2637.2352017914804;2650.2711754267584;4612.884677883055;4694.577488026077;4726.62187025038;4786.928196077058;4792.7603619819;4695.483496815347;4713.83501577444;4713.9057218855605;4725.456572494156;4775.116603428368;4314.439122914033;4372.169287835317;4374.846880359188;4392.3631073494325;4396.6043056124945;4331.566843315659;4385.276429389163;4431.468223813147;4449.911001779962;4490.865274041784;4472.08322293929;4475.351074094255;4478.596926276635;4487.46150461945;4494.887627809315;4218.1985422769885;4256.382824490463;4302.763348015857;4387.714798538117;4399;4315.072259464199;4323.762193079379;4335.436393268855;4345.630621397185;4405.537418571036;4764.2615394613895;4793.880152996168;4807.134715751164;4810.687305325143;4818.301346304766;4879.560839524424;4977.552020318152;5015.648904576681;5139.58883289336;5147.536721695028;4982.701037937735;5062.670926389773;5064.645474816764;5068.898622027539;5068.923966140511;4665.066986602693;4688.742119183477;4708.717476951394;4712.552307530779;4712.740799256074;5009.348784658044;5019.974900125549;5049.040682270357;5055.317532133188;5142.2029585413575;4894.1679914414635;4911.877203069952;4916.70499770015;4917.1149193144865;4917.729524876167;4981.352424184833;4984.800607975641;4991.051700176955;5002.049610574052;5010.824621138316;4890.266460030953;4937.728424936591;4952.975235123873;4953.90092198154;4975.527324904128;4987.202047672355;5011.348524691767;5024.547790698854;5025.698458092526;5033.672811267256;4261.616454519108;4271;4276.5295817460055;4277.743335399886;4278.914421711548;3649.94525082124;3670.3209906167444;3692.8892133236045;3739.1026153723456;3771.189194323179;4340.65274778017;4381.737095774264;4383.62739167168;4395.802188901507;4396.736195828196;5063.620228482879;5086.287919691246;5095.490450954949;5106.693598384109;5107.208382700687;4243.787810609457;4270.743755374688;4388.166248412791;4394.2749446340995;4395.604395604411;4452.220861349251;4482.484514280834;4494.887627809331;4498.752568608693;4501.41481607389;4725.716457012591;4758.333833263277;4765.189917713928;4766.261229509431;4768.165571024987;4831.855044348676;5002.499750024968;5010.574101201439;5022.924656130234;5046.6719663221775;4743.810247590058;4780.737059461763;4799.352087468287;4817.301491283674;4818.325434439112;5014.42334131565;5018.774155162953;5021.974890125673;5023.522765337287;5029.371328583927;4895.04546613407;4980.128477516492;5100.515451032146;5107.642465027412;5116.334876466036;4902.803887844446;4909.116359055404;4917.065757506062;4928.310036594808;4938.2839488273285;4901.3383193268455;4908.460069392293;4910.042541704333;4912;4915.066137433876;4728.59806916416;4799.136155492045;4802.447718512416;4831.73425461603;4854.417469903493;4953.801847926043;5041.521055499722;5053.67151135175;5054.949450505448;5060.898782024413;4922.8769280768265;4925.310456536159;4927.655064145475;4928.408590969107;4931.334269873521 06:10:00 INFO - PROCESS | 29688 | |1;ext.html;559.169633094854;573.3807487913055;585.8242527241827;587.9323877754057;613.3498491598908;34477.31045379091;38167.80916095416;38276.23447531048;38327;38422.80788596053;38948.80525597368;39400.408993865116;39418.80290598543;39445.21109577814;39492.60507394925;7524.172341042495;7654.11977622575;7669.961650191769;7680.078390593108;7681.385489160882;7502;7522.9247707523045;7530.849383012336;7535.5478671279625;7537.924620753777;7543.245675432468;7550.169481357047;7555.622218889061;7566.735164269252;7567.886481702752;7532.284432978859;7542.924570754304;7571.280728330799;7572.242775722439;7575.166731659513;7568.621568921532;7633.198514156044;7633.770986870402;7634.809129771745;7650.1967293433945;36717.81641091804;37109.62890371116;37174.44238336427;37231.25537489235;37241.81379093087;2922.8538573071473;2938.074506530436;3008.17275249306;3268.754843386732;3644.817759112034;28258;28645;28830.567541486686;28875.133745987652;28959.855200724072;3371.7302615790923;3496.7552271341015;3569.1790888095884;3635.4001589737663;3638.599754027055;188257;188649;189091;189866;190036.0498197514;28428.57357139603;51361.74319128455;51691.22463163055;51760.48239517557;51827.22259166116;30406.54390184149;32220.83889580584;32283.51574726381;32290.515642265385;32310.515342269886;11683.766324673628;11726.237794543327;11836.230645008047;11846.526138954518;11921.284722916653;9508.239340852853;9541;9546;9560;9563.713088607354;7770.650320735581;7784.922150778533;7842.098158711821;7891.053073631201;7927.920720792834;3044.8173109613494;3074.7540196784203;3125.093722820402;3129.1225264840914;3181.2683082891062;809.4455298120806;864.5849992003873;897.0670502677273;915.4187091197005;960.6061514779046;27389.45221095567;27618;27843.303917401823;28370;28401.43197136087;919.090100800203;951.8001219743793;954.9427034377959;984.9162821160281;1056.292284169593;14910.627234319012;14967.700645987019;15174.848251517564;15250.694986100216;15407.768883466757;413954;416269;416395;416974;420010;49288.50711492839;50198.498015020115;50202.74898625483;50255.497445025816;50263;1095.0637205189607;1156.5662876421343;1176.253079294654;1220.8229806677982;1222.7615614954998;27968.160955171377;28976.565351519323;29406.264843379086;30252.394952101276;30255;42775.5722442784;43280.78359608182;43314.350284745124;43355;43362.78318608387;312555;313112;313281;313570;314024;21219.7878021224;21667.891660542227;25264.115755948453;25314.74685253124;25608.23175304744;41533;42285.1542969145;42489.150216994865;42568.36147457852;42658.78670606627;36150.27699445944;36409.27181456409;36557.634423656484;36643;37309.4403583941;36595.085122872144;37011.81494092512;37301.6269837309;37469;38265.23469530649;34974;35462.82268588641;35978;36141.45787813237;36256.55562721537;30415.847920761138;33023.50464743079;33228.33543329168;33383.33233335368;33549.47730488264;24381.26856194317;25121.371965701004;25379;25594.360140996625;25941.870290648425 06:10:00 INFO - PROCESS | 29688 | |2;jquery.html;358.84569635056914;359.10582649203485;363.3097115480587;379.45737595238796;391.69252137072385;16078.517644470656;17090.401835935743;17738.822611773878;17924.10379481027;17931.372401965902;16684.33262669492;16703;16787.74818377722;17039.14804259788;17244.655106897855;4967.180415231483;5201.609879259052;5204.505571970676;5205.16717325228;5209.1404918188455;3784.829682664287;3964.2864284428792;5034.219695947134;5731.226284451587;5984.611000284989;6070.423309785563;6076.058210977306;6076.392360763933;6083.665398403086;6089.299730530979;5824.301083869942;5950.077737950603;5981.850453738648;5994.100884867261;6002.8499287517725;4592.563706447882;5248.0553500369915;5250.7637156328055;5256.9737151314;5260.894782104375;12275.140740148194;13627.250501222428;19151.712724309145;20805.791942080537;20843.270485532932;1894.9242030318771;1921.3179321340863;1927.4506765571746;1956.3739603326942;2000.1599328282011;13691.520796772065;14052.508162214273;14830.777538336934;15369.687368499131;15557.766633500507;1828.9542761430937;1842.4933143385542;1891.517662995941;1914.425672298305;1930.6524825531399;74052.88920666194;80410.59794701048;81655.591722041;82069.9999999994;85181.50049743267;14068.226247556482;15536.223188840513;16955.813093083365;17430.47708568745;17514;28782.856085719857;28811.56782648262;28932.85533572361;28960.710392895802;28995.275118122216;8377.329813614897;8623.31013518917;8829.779255518664;9017.458952462874;9087.318451116193;7083.256258092929;7166.964165179245;7274.4907856449545;7341.192468828424;7382.815429614303;8331.458455200393;8512.787180320418;8601.61292741828;8640.30877529796;8740.475571465733;2700.338417087826;3187.474066779002;3257.657945915692;3275.623303320101;3406.1654894550993;760.3385055002184;861.9914699801247;900.7256676890903;914.4741773480275;946.5787724462548;16628.750568741478;16701;17229.483115506555;17341.7398739019;17359;824.583585289425;846.1876598465542;861.1356413364995;873.9169778870997;914.0356923445696;9141.88615123184;9880.851787223197;9901.752456188653;9912.256580756472;9982.251331150048;293412;296069.8340641027;400780;402883;403087;82425.58787206025;83043.58478207691;84339;84763.57618211869;85277;853.5561508015797;891.919727224553;892.9374943754004;893.2005854760083;895.1004240738016;15109.622259443602;16089.839101608834;16587.419440319532;16622.16889155513;16853.831461685717;36697;37748.81125594355;38025;38339.6166038336;38977;48627.270590940454;52733;54213;55345;55566.72216638891;7664.195259497896;7702.030254776936;7780.2219778021745;7800.102988156208;8002.439829211899;6259.624422534663;7567.810804729926;11081.50133244022;12153.29853820448;12582.559610413591;10053.547590358598;10142.949285253526;10551.208659350734;10927.45362731876;10939.945300273448;4396.890077748082;10244.538995745359;10434.634787782392;11004;11101.111911046935;10743.958647856882;10764.569417223223;10819.945900270448;10868.934902368524;11276.32342059479;7621.361407297458;7656.736638454593;7720.7683769487;7785.143634200347;7967.282944534788;10214.182865370902;10428.634997775041;10463.581456741646;10766.73083172927;11041.503132358903 06:10:00 INFO - PROCESS | 29688 | |3;mootools.html;1349.9325033748314;1383.2668685596634;1437;1601.10338210602;1638.5330180898438;6956.408705260053;7560;7581.203973582763;7583.50707204032;7587.696492140321;6412.775552855651;7082;7288.453365997545;7309.524880882739;7401.333879950804;2157.1048015073725;2180.433087397272;2180.5420861619077;2184.9344519664355;2194.681771143183;2129.233475948657;2141.796529329711;2172.967405488911;2175.630142875707;2177.140029688272;2150.086213359316;2150.3441450357636;2160.1899287767087;2161.740591129059;2185.366243789307;2116.6347705729872;2121.0561300221407;2124.4370241885913;2124.479502521884;2124.8300135989084;2091.518950641346;2139.3261122746285;2139.689744986984;2140.047678782942;2155.644318687415;7168.498205125643;7316.743913963039;7319.451041171933;7326.560406375635;7332.743353982585;4221.219074471202;4384.276594361926;4395.318725597537;4397.648188144973;4422.601965823092;2720.7007229204773;2891.161563146685;2894.7394734473996;2903.11455006223;2907.941841163186;922.4419226368018;968.2399316536555;985.522021819417;987.5605355616754;997.5261750668446;9855.55649995752;9909.950450247703;9910.306278560503;9974.800503989953;10025.348352357074;3901.804909754501;4100.794960251976;4228.9788551057045;4251.149770046003;4339.240632889232;8549.957250213709;8568.143185681507;8573.74278771638;8576.1423857615;8653.39426240157;4534.410526631516;4536.5236650151255;4537.0925814837165;4540.091981603692;4541.046380260183;3444.362792883325;4032.2943484890616;4117.3206420940805;4147;4200.075983283673;3584.6415358464465;3588.659077387644;3747.6439738224826;3750.0812300985885;3753.6621704046765;1189.827475016118;1198.8861058199457;1203.9819402708965;1209;1209.661294837447;691.865086308165;854.0775961961191;861.4486728493769;869.9260562852102;880.6081293824315;5041.143005689041;5108.514691104339;5137.255098010843;5142.588592912558;5250.921236181461;412.84518305635385;419.7313719219702;427.8310067523373;430.1955343507661;436.8252698920457;3542.0613537412605;3582.373084710165;3601.85592576294;3609.657082577151;3793.639604237593;8736.781580460412;9252.167304942453;9264.953675231716;9273.026332235153;9278.164965153168;9141.725748227564;9150.359474836698;9150.816983660423;9155.22180614642;9169.128932751511;6355.904661430175;7010.509264351446;7079.115110611174;7082.043924070287;7085.92914070863;5236.476352364733;5251.894962100813;5343.62594618373;5367.221752845893;5547.972260138674;8420.368472364475;8489.4481858679;8554.486730795923;8630.223279904587;8658.826823463622;8463.407561470638;8490.15098490146;8523;8703.91296087031;8771.122887711177;5989.850253743692;6408.807735767934;6555.770548030987;6670.366315200048;6675.566088204251;7141.85716285661;7315.122185337794;7349.081364829396;7354.301341372561;7354.485186036926;6436.9034464484;6464.709088091141;6595.109660196004;6645.468362530889;6784.93215067843;6192;6247.219097612799;6270.310265870842;6435.935640643534;6508.837279068061;6127.908081378694;6231.875362492816;6233.563650544418;6242.3133455320785;6260.780872669435;4493.168763778712;4514.074614704044;4583.862484125481;4584.839530616412;4619.983603607201;4355.477342718894;4425.545475367789;4510.526394728507;4580.88547786308;4599.747013914133 06:10:00 INFO - PROCESS | 29688 | |4;prototype.html;291.8453219793509;294.75977078680876;299.7841554081061;302.09522480171887;302.3544731997186;4701.7649117544115;4745.738984355855;4756.8572942811725;4764.284857451315;4812.446568644598;4713.077891707147;4716.740579268139;4747.8338258160975;4755.334253204554;4759.167145749498;3548.9112772180642;3655.8903232903053;3668.0279725872533;3669.3945498992634;3686.2996030754207;3657.3965295726307;3661.7802931824044;3731.0112820102695;3759.7556158849725;3802.9809850950705;3732;3737;3768.9647590301206;3785.9810700946455;3787.0532366908274;3509.1928856362924;3661.4690869823726;3756.2908876461142;3768.6244520749865;3771.4154306082464;3240.2223466368137;3240.7245384142375;3242.8001639393574;3249.675032496755;3273.247153154764;4620.283856002325;4623.352730617717;4627.652926030528;4636.794433447294;4651.674382793206;4072.429859819628;4166.937495937564;4200.978995105035;4210.789460526992;4259.850905218303;4910.288008238786;4913.263010548446;4913.729744864031;4918.2376731606655;4918.532739389752;3535.5580552430947;3538.8230588470474;3539.7345199109914;3540.274243780019;3543.2382037861985;5016.448190699057;5135.666181698215;5195.766190521435;5200.8179713710215;5221.973890130525;3597.442396428558;3612.8735494257576;3613.0244833894703;3630.7276954228537;3635.763675361093;3684.3920753075977;3689.2252626948643;3689.6679298862696;3690.6678398943686;3693.372126738407;4167.916641667211;4185.142045880587;4200.285951388271;4215.367694845736;4234.894127646772;4643.535646435397;4892.730899800474;4914.8034078637165;4972.8508144755715;4978.228374601942;1255.598208573266;1272.4464857786893;1274.9107562470538;1275.4770544077069;1277.6678063703318;830.2569200565581;859.9011113722003;873.7160422862595;875.5272153037416;878.692457639821;4207.474065741782;4252.234597772431;4413.514513403523;4442.977785111054;4457.5988161065015;5047.4447810740785;5080.288759573663;5122.129238029469;5137.255098010843;5166.483351664803;4386.780660967002;4400.3399490076745;4414.933775993362;4422.314541246112;4427.380166776654;2601.427685909097;2665.9733402665724;2704.5943108533484;2710.254679963026;2730.7405796449702;4814.662973591815;4816.54242846936;4856.41722993236;4858.271259311132;4872.342233798392;5210.374755029421;5218.843434696965;5247.16045432729;5249.921251181236;5276.577873770089;4623.9075218495445;4819.277108433763;4862.343583616308;4871.537203965618;4875.19559272716;5092.618053645917;5124.410692770379;5154.304168937146;5154.819581314636;5175.360566111235;4836.492168322276;5035.697858128524;5051.949480505295;5054.620903432184;5056.317397151484;4832.371791667061;4833.830815921426;4857.441394239567;4867.902641947212;4911.165101932752;3681.466187402865;3725.8323375447626;3747.8313475894197;3763.868264610835;3778.074371778932;5108.948910510847;5149.9742501287255;5161.200013997836;5167.199084141964;5168.457311982338;4742.66801323904;4957.082939656175;4977.694294435215;4989.900201996013;4990.600751939909;4979.875503112451;4982.701037937735;4989;4990.176620857518;5055.646104772778;4782.736949467812;4927.334809800631;4930;4931.753412329297;4932.136876046749;4814.6870453420415;4857.975710121426;4958.8760280993265;4987.127252730685;5029.220470827027;4850.442199147144;4886.511348865085;4890.559849613552;4890.559849613552;4899.240617704261 06:10:00 INFO - PROCESS | 29688 | |5;yui.html;623.4015345268542;669.7650348815223;673.8214373191105;713.7145141943222;718.4396170986629;13024.544140955068;13902;13922.303884805757;13948.302584870766;13969.231692256948;13452.327383630829;13490.258035808027;13534.526291579798;13585.59243222705;13588.524401645944;618.3754408047881;736.3483317264233;746.6042997211473;752.6838727734337;774.9922500774976;751.8345963887963;764.1785081037879;764.3693952489191;765.0551568812513;766.4979438467784;823.6129019360891;823.6334831000207;825.0223485170093;825.6367198432671;827.1439060572309;646.6120327803327;775.8681024225895;815.0993152566417;815.4699445360504;815.6003558256471;598.35676647604;598.9670568118752;599.4604855629924;599.8680290336163;600.726669365442;12501.874981250254;12536.435860386304;12549.498020079185;12556.560520381743;12557;12180.451879665436;12496.375181240901;12503.49986000568;13030.609081727564;13108.850811966951;11829.408529573573;12204.389780510939;12272.631821045383;12296;12305.630831075083;3865.16898866745;3868.7485313454536;3879.7672139671427;3948.1511475033008;3986.382110772835;62165.68917155385;62227.68886155586;62243;62271;62340;9973.850392244121;10235.232357573212;10325.432101234353;10360.274780765274;10857.131429485622;16742.330306787837;17421.91289043572;17436.91281543584;18407.72388414175;19179.136938837786;6974.4420446364165;7040.160622611466;7109.502334836512;7163.10461192351;7211.567305961659;3509.719222462248;3567.9643203568153;3620.8913732588067;3645.4714066460747;3675.5589329280124;2873.48277310082;2972.6432828060338;2979.5679626454476;2983.3884053768925;2984.40311937609;500.2721040885503;511.1948680827711;513.3326675322066;516.3932379454202;518.9610779191576;510.56091761085435;534.7647035304453;583.7285662167112;606.1574411567924;621.3693101501979;8633.827323453495;8811.559422029;8861.556922153866;8885.244754195837;8919.42023768453;583.1311346094288;595.5622617376225;605.479287812481;611.4771870051131;613.0956838662936;3867.690584753213;3992;4029.274730548471;4084.1423301106506;4214.3678448232395;104979;105419;106737;108233.45883270534;108577.4571127155;91560.54219728858;91633;92076;92609.53695231481;94223;75222;78019.21980780234;80454.59772701099;80878.59560702159;81140.18859811327;7581.924180758342;8715;9003.14470125337;9110.90889091127;9298.95350523243;38388.54985467615;38526.229475409775;41495.9252037403;43470.56529434665;43783.78108109439;38509.807450962566;49848.252276215164;58949;59609.701951489966;60897.08654370277;11317.151213658844;11556.59551915679;11819.290842549475;11841.644750657493;12116.939415303219;13125.54060607874;13346.3326833656;13554.457821687021;14107.858921410654;14383.137011779327;11402.615087194514;11411.60059397917;11469.197156198987;11487.827682584935;11867.465964031811;12073.27560346382;12108.515659373526;12218.51125954952;12264.264144151379;12867.099303049072;11781.234219775688;12101.636950891487;12290.631281061582;12819.487220511448;12835;10373.222008349554;10455.215858810772;10646.467676615983;11119.610813621484;11205.495752691311;10120.746981325527;10707.839382409426;10857.022867941923;10879.456027198767;10904.945475272572 06:10:00 INFO - PROCESS | 29688 | __end_tp_report 06:10:00 INFO - PROCESS | 29688 | __start_cc_report 06:10:00 INFO - PROCESS | 29688 | _x_x_mozilla_cycle_collect,977 06:10:00 INFO - PROCESS | 29688 | __end_cc_report 06:10:00 INFO - PROCESS | 29688 | __startTimestamp1471871400654__endTimestamp 06:10:00 INFO - PROCESS | 29688 | 06:10:00 INFO - PROCESS | 29688 | ------- Summary: start ------- 06:10:00 INFO - PROCESS | 29688 | Number of tests: 6 06:10:00 INFO - PROCESS | 29688 | 06:10:00 INFO - PROCESS | 29688 | [#0] dojo.html Cycles:165 Average:4665.34 Median:4802.45 stddev:483.72 (10.1%) stddev-sans-first:456.73 06:10:00 INFO - PROCESS | 29688 | Values: 2580.9 2626.1 2631.5 2637.2 2650.3 4612.9 4694.6 4726.6 4786.9 4792.8 4695.5 4713.8 4713.9 4725.5 4775.1 4314.4 4372.2 4374.8 4392.4 4396.6 4331.6 4385.3 4431.5 4449.9 4490.9 4472.1 4475.4 4478.6 4487.5 4494.9 4218.2 4256.4 4302.8 4387.7 4399.0 4315.1 4323.8 4335.4 4345.6 4405.5 4764.3 4793.9 4807.1 4810.7 4818.3 4879.6 4977.6 5015.6 5139.6 5147.5 4982.7 5062.7 5064.6 5068.9 5068.9 4665.1 4688.7 4708.7 4712.6 4712.7 5009.3 5020.0 5049.0 5055.3 5142.2 4894.2 4911.9 4916.7 4917.1 4917.7 4981.4 4984.8 4991.1 5002.0 5010.8 4890.3 4937.7 4953.0 4953.9 4975.5 4987.2 5011.3 5024.5 5025.7 5033.7 4261.6 4271.0 4276.5 4277.7 4278.9 3649.9 3670.3 3692.9 3739.1 3771.2 4340.7 4381.7 4383.6 4395.8 4396.7 5063.6 5086.3 5095.5 5106.7 5107.2 4243.8 4270.7 4388.2 4394.3 4395.6 4452.2 4482.5 4494.9 4498.8 4501.4 4725.7 4758.3 4765.2 4766.3 4768.2 4831.9 5002.5 5010.6 5022.9 5046.7 4743.8 4780.7 4799.4 4817.3 4818.3 5014.4 5018.8 5022.0 5023.5 5029.4 4895.0 4980.1 5100.5 5107.6 5116.3 4902.8 4909.1 4917.1 4928.3 4938.3 4901.3 4908.5 4910.0 4912.0 4915.1 4728.6 4799.1 4802.4 4831.7 4854.4 4953.8 5041.5 5053.7 5054.9 5060.9 4922.9 4925.3 4927.7 4928.4 4931.3 06:10:00 INFO - PROCESS | 29688 | 06:10:00 INFO - PROCESS | 29688 | [#1] ext.html Cycles:180 Average:45024.04 Median:37142.04 stddev:84901.22 (228.6%) stddev-sans-first:85073.75 06:10:00 INFO - PROCESS | 29688 | Values: 559.2 573.4 585.8 587.9 613.3 34477.3 38167.8 38276.2 38327.0 38422.8 38948.8 39400.4 39418.8 39445.2 39492.6 7524.2 7654.1 7670.0 7680.1 7681.4 7502.0 7522.9 7530.8 7535.5 7537.9 7543.2 7550.2 7555.6 7566.7 7567.9 7532.3 7542.9 7571.3 7572.2 7575.2 7568.6 7633.2 7633.8 7634.8 7650.2 36717.8 37109.6 37174.4 37231.3 37241.8 2922.9 2938.1 3008.2 3268.8 3644.8 28258.0 28645.0 28830.6 28875.1 28959.9 3371.7 3496.8 3569.2 3635.4 3638.6 188257.0 188649.0 189091.0 189866.0 190036.0 28428.6 51361.7 51691.2 51760.5 51827.2 30406.5 32220.8 32283.5 32290.5 32310.5 11683.8 11726.2 11836.2 11846.5 11921.3 9508.2 9541.0 9546.0 9560.0 9563.7 7770.7 7784.9 7842.1 7891.1 7927.9 3044.8 3074.8 3125.1 3129.1 3181.3 809.4 864.6 897.1 915.4 960.6 27389.5 27618.0 27843.3 28370.0 28401.4 919.1 951.8 954.9 984.9 1056.3 14910.6 14967.7 15174.8 15250.7 15407.8 413954.0 416269.0 416395.0 416974.0 420010.0 49288.5 50198.5 50202.7 50255.5 50263.0 1095.1 1156.6 1176.3 1220.8 1222.8 27968.2 28976.6 29406.3 30252.4 30255.0 42775.6 43280.8 43314.4 43355.0 43362.8 312555.0 313112.0 313281.0 313570.0 314024.0 21219.8 21667.9 25264.1 25314.7 25608.2 41533.0 42285.2 42489.2 42568.4 42658.8 36150.3 36409.3 36557.6 36643.0 37309.4 36595.1 37011.8 37301.6 37469.0 38265.2 34974.0 35462.8 35978.0 36141.5 36256.6 30415.8 33023.5 33228.3 33383.3 33549.5 24381.3 25121.4 25379.0 25594.4 25941.9 06:10:00 INFO - PROCESS | 29688 | 06:10:00 INFO - PROCESS | 29688 | [#2] jquery.html Cycles:180 Average:24955.47 Median:202372.14 stddev:60533.65 (29.9%) stddev-sans-first:60675.29 06:10:00 INFO - PROCESS | 29688 | Values: 358.8 359.1 363.3 379.5 391.7 16078.5 17090.4 17738.8 17924.1 17931.4 16684.3 16703.0 16787.7 17039.1 17244.7 4967.2 5201.6 5204.5 5205.2 5209.1 3784.8 3964.3 5034.2 5731.2 5984.6 6070.4 6076.1 6076.4 6083.7 6089.3 5824.3 5950.1 5981.9 5994.1 6002.8 4592.6 5248.1 5250.8 5257.0 5260.9 12275.1 13627.3 19151.7 20805.8 20843.3 1894.9 1921.3 1927.5 1956.4 2000.2 13691.5 14052.5 14830.8 15369.7 15557.8 1829.0 1842.5 1891.5 1914.4 1930.7 74052.9 80410.6 81655.6 82070.0 85181.5 14068.2 15536.2 16955.8 17430.5 17514.0 28782.9 28811.6 28932.9 28960.7 28995.3 8377.3 8623.3 8829.8 9017.5 9087.3 7083.3 7167.0 7274.5 7341.2 7382.8 8331.5 8512.8 8601.6 8640.3 8740.5 2700.3 3187.5 3257.7 3275.6 3406.2 760.3 862.0 900.7 914.5 946.6 16628.8 16701.0 17229.5 17341.7 17359.0 824.6 846.2 861.1 873.9 914.0 9141.9 9880.9 9901.8 9912.3 9982.3 293412.0 296069.8 400780.0 402883.0 403087.0 82425.6 83043.6 84339.0 84763.6 85277.0 853.6 891.9 892.9 893.2 895.1 15109.6 16089.8 16587.4 16622.2 16853.8 36697.0 37748.8 38025.0 38339.6 38977.0 48627.3 52733.0 54213.0 55345.0 55566.7 7664.2 7702.0 7780.2 7800.1 8002.4 6259.6 7567.8 11081.5 12153.3 12582.6 10053.5 10142.9 10551.2 10927.5 10939.9 4396.9 10244.5 10434.6 11004.0 11101.1 10744.0 10764.6 10819.9 10868.9 11276.3 7621.4 7656.7 7720.8 7785.1 7967.3 10214.2 10428.6 10463.6 10766.7 11041.5 06:10:00 INFO - PROCESS | 29688 | 06:10:00 INFO - PROCESS | 29688 | [#3] mootools.html Cycles:180 Average:4946.65 Median:5243.70 stddev:2712.44 (51.7%) stddev-sans-first:2706.58 06:10:00 INFO - PROCESS | 29688 | Values: 1349.9 1383.3 1437.0 1601.1 1638.5 6956.4 7560.0 7581.2 7583.5 7587.7 6412.8 7082.0 7288.5 7309.5 7401.3 2157.1 2180.4 2180.5 2184.9 2194.7 2129.2 2141.8 2173.0 2175.6 2177.1 2150.1 2150.3 2160.2 2161.7 2185.4 2116.6 2121.1 2124.4 2124.5 2124.8 2091.5 2139.3 2139.7 2140.0 2155.6 7168.5 7316.7 7319.5 7326.6 7332.7 4221.2 4384.3 4395.3 4397.6 4422.6 2720.7 2891.2 2894.7 2903.1 2907.9 922.4 968.2 985.5 987.6 997.5 9855.6 9910.0 9910.3 9974.8 10025.3 3901.8 4100.8 4229.0 4251.1 4339.2 8550.0 8568.1 8573.7 8576.1 8653.4 4534.4 4536.5 4537.1 4540.1 4541.0 3444.4 4032.3 4117.3 4147.0 4200.1 3584.6 3588.7 3747.6 3750.1 3753.7 1189.8 1198.9 1204.0 1209.0 1209.7 691.9 854.1 861.4 869.9 880.6 5041.1 5108.5 5137.3 5142.6 5250.9 412.8 419.7 427.8 430.2 436.8 3542.1 3582.4 3601.9 3609.7 3793.6 8736.8 9252.2 9265.0 9273.0 9278.2 9141.7 9150.4 9150.8 9155.2 9169.1 6355.9 7010.5 7079.1 7082.0 7085.9 5236.5 5251.9 5343.6 5367.2 5548.0 8420.4 8489.4 8554.5 8630.2 8658.8 8463.4 8490.2 8523.0 8703.9 8771.1 5989.9 6408.8 6555.8 6670.4 6675.6 7141.9 7315.1 7349.1 7354.3 7354.5 6436.9 6464.7 6595.1 6645.5 6784.9 6192.0 6247.2 6270.3 6435.9 6508.8 6127.9 6231.9 6233.6 6242.3 6260.8 4493.2 4514.1 4583.9 4584.8 4620.0 4355.5 4425.5 4510.5 4580.9 4599.7 06:10:00 INFO - PROCESS | 29688 | 06:10:00 INFO - PROCESS | 29688 | [#4] prototype.html Cycles:180 Average:4133.57 Median:4744.20 stddev:1196.96 (25.2%) stddev-sans-first:1165.07 06:10:00 INFO - PROCESS | 29688 | Values: 291.8 294.8 299.8 302.1 302.4 4701.8 4745.7 4756.9 4764.3 4812.4 4713.1 4716.7 4747.8 4755.3 4759.2 3548.9 3655.9 3668.0 3669.4 3686.3 3657.4 3661.8 3731.0 3759.8 3803.0 3732.0 3737.0 3769.0 3786.0 3787.1 3509.2 3661.5 3756.3 3768.6 3771.4 3240.2 3240.7 3242.8 3249.7 3273.2 4620.3 4623.4 4627.7 4636.8 4651.7 4072.4 4166.9 4201.0 4210.8 4259.9 4910.3 4913.3 4913.7 4918.2 4918.5 3535.6 3538.8 3539.7 3540.3 3543.2 5016.4 5135.7 5195.8 5200.8 5222.0 3597.4 3612.9 3613.0 3630.7 3635.8 3684.4 3689.2 3689.7 3690.7 3693.4 4167.9 4185.1 4200.3 4215.4 4234.9 4643.5 4892.7 4914.8 4972.9 4978.2 1255.6 1272.4 1274.9 1275.5 1277.7 830.3 859.9 873.7 875.5 878.7 4207.5 4252.2 4413.5 4443.0 4457.6 5047.4 5080.3 5122.1 5137.3 5166.5 4386.8 4400.3 4414.9 4422.3 4427.4 2601.4 2666.0 2704.6 2710.3 2730.7 4814.7 4816.5 4856.4 4858.3 4872.3 5210.4 5218.8 5247.2 5249.9 5276.6 4623.9 4819.3 4862.3 4871.5 4875.2 5092.6 5124.4 5154.3 5154.8 5175.4 4836.5 5035.7 5051.9 5054.6 5056.3 4832.4 4833.8 4857.4 4867.9 4911.2 3681.5 3725.8 3747.8 3763.9 3778.1 5108.9 5150.0 5161.2 5167.2 5168.5 4742.7 4957.1 4977.7 4989.9 4990.6 4979.9 4982.7 4989.0 4990.2 5055.6 4782.7 4927.3 4930.0 4931.8 4932.1 4814.7 4858.0 4958.9 4987.1 5029.2 4850.4 4886.5 4890.6 4890.6 4899.2 06:10:00 INFO - PROCESS | 29688 | 06:10:00 INFO - PROCESS | 29688 | [#5] yui.html Cycles:180 Average:18235.22 Median:3913.96 stddev:26573.59 (678.9%) stddev-sans-first:26615.23 06:10:00 INFO - PROCESS | 29688 | Values: 623.4 669.8 673.8 713.7 718.4 13024.5 13902.0 13922.3 13948.3 13969.2 13452.3 13490.3 13534.5 13585.6 13588.5 618.4 736.3 746.6 752.7 775.0 751.8 764.2 764.4 765.1 766.5 823.6 823.6 825.0 825.6 827.1 646.6 775.9 815.1 815.5 815.6 598.4 599.0 599.5 599.9 600.7 12501.9 12536.4 12549.5 12556.6 12557.0 12180.5 12496.4 12503.5 13030.6 13108.9 11829.4 12204.4 12272.6 12296.0 12305.6 3865.2 3868.7 3879.8 3948.2 3986.4 62165.7 62227.7 62243.0 62271.0 62340.0 9973.9 10235.2 10325.4 10360.3 10857.1 16742.3 17421.9 17436.9 18407.7 19179.1 6974.4 7040.2 7109.5 7163.1 7211.6 3509.7 3568.0 3620.9 3645.5 3675.6 2873.5 2972.6 2979.6 2983.4 2984.4 500.3 511.2 513.3 516.4 519.0 510.6 534.8 583.7 606.2 621.4 8633.8 8811.6 8861.6 8885.2 8919.4 583.1 595.6 605.5 611.5 613.1 3867.7 3992.0 4029.3 4084.1 4214.4 104979.0 105419.0 106737.0 108233.5 108577.5 91560.5 91633.0 92076.0 92609.5 94223.0 75222.0 78019.2 80454.6 80878.6 81140.2 7581.9 8715.0 9003.1 9110.9 9299.0 38388.5 38526.2 41495.9 43470.6 43783.8 38509.8 49848.3 58949.0 59609.7 60897.1 11317.2 11556.6 11819.3 11841.6 12116.9 13125.5 13346.3 13554.5 14107.9 14383.1 11402.6 11411.6 11469.2 11487.8 11867.5 12073.3 12108.5 12218.5 12264.3 12867.1 11781.2 12101.6 12290.6 12819.5 12835.0 10373.2 10455.2 10646.5 11119.6 11205.5 10120.7 10707.8 10857.0 10879.5 10904.9 06:10:00 INFO - PROCESS | 29688 | -------- Summary: end -------- 06:10:00 INFO - PROCESS | 29688 | 06:10:01 INFO - TEST-INFO | 29688: exit 0 06:10:01 INFO - TEST-OK | dromaeo_css | took 1121513ms 06:10:01 INFO - TEST-START | kraken 06:10:01 INFO - operating with platform_type : linux_ 06:10:01 INFO - Initialising browser for kraken test... 06:10:01 INFO - TEST-INFO | started process 29994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1yuf9F/profile http://localhost:40588/getInfo.html) 06:10:06 INFO - PROCESS | 29994 | __metrics Screen width/height:1600/1200 06:10:06 INFO - PROCESS | 29994 | colorDepth:24 06:10:06 INFO - PROCESS | 29994 | Browser inner width/height: 1024/697 06:10:06 INFO - PROCESS | 29994 | __metrics 06:10:06 INFO - PROCESS | 29994 | 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" 06:10:06 INFO - PROCESS | 29994 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:10:07 INFO - PROCESS | 29994 | console.error: PushService: 06:10:07 INFO - PROCESS | 29994 | stateChangeProcessEnqueue: Error transitioning state 06:10:07 INFO - PROCESS | 29994 | UnknownError 06:10:07 INFO - TEST-INFO | 29994: exit 0 06:10:07 INFO - Browser initialized. 06:10:07 INFO - Running cycle 1/1 for kraken test... 06:10:07 INFO - TEST-INFO | started process 30078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1yuf9F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:20 INFO - PROCESS | 30078 | RSS: Main: 175964160 06:10:20 INFO - PROCESS | 30078 | 06:10:22 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40588/tests/kraken/driver.html?testName=audio-beat-detection) 06:10:23 INFO - PROCESS | 30078 | RSS: Main: 236158976 06:10:23 INFO - PROCESS | 30078 | 06:10:26 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40588/tests/kraken/driver.html?testName=audio-dft) 06:10:27 INFO - PROCESS | 30078 | RSS: Main: 227377152 06:10:27 INFO - PROCESS | 30078 | 06:10:30 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40588/tests/kraken/driver.html?testName=audio-fft) 06:10:31 INFO - PROCESS | 30078 | RSS: Main: 302063616 06:10:31 INFO - PROCESS | 30078 | 06:10:33 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40588/tests/kraken/driver.html?testName=audio-oscillator) 06:10:33 INFO - PROCESS | 30078 | RSS: Main: 210358272 06:10:33 INFO - PROCESS | 30078 | 06:10:36 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40588/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:10:36 INFO - PROCESS | 30078 | RSS: Main: 214822912 06:10:36 INFO - PROCESS | 30078 | 06:10:40 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40588/tests/kraken/driver.html?testName=imaging-darkroom) 06:10:40 INFO - PROCESS | 30078 | RSS: Main: 251592704 06:10:40 INFO - PROCESS | 30078 | 06:10:44 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40588/tests/kraken/driver.html?testName=imaging-desaturate) 06:10:44 INFO - PROCESS | 30078 | RSS: Main: 244813824 06:10:44 INFO - PROCESS | 30078 | 06:10:47 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40588/tests/kraken/driver.html?testName=json-parse-financial) 06:10:48 INFO - PROCESS | 30078 | RSS: Main: 247873536 06:10:48 INFO - PROCESS | 30078 | 06:10:50 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40588/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:10:50 INFO - PROCESS | 30078 | RSS: Main: 211546112 06:10:50 INFO - PROCESS | 30078 | 06:10:52 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40588/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:10:53 INFO - PROCESS | 30078 | RSS: Main: 218976256 06:10:53 INFO - PROCESS | 30078 | 06:10:55 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40588/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:10:56 INFO - PROCESS | 30078 | RSS: Main: 224206848 06:10:56 INFO - PROCESS | 30078 | 06:10:59 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:10:59 INFO - PROCESS | 30078 | RSS: Main: 219774976 06:10:59 INFO - PROCESS | 30078 | 06:11:02 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:11:03 INFO - PROCESS | 30078 | RSS: Main: 221777920 06:11:03 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | Cycle 1(1): loaded http://localhost:40588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40588/tests/kraken/driver.html?testName=ai-astar) 06:11:05 INFO - PROCESS | 30078 | RSS: Main: 273612800 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | __start_tp_report 06:11:05 INFO - PROCESS | 30078 | _x_x_mozilla_page_load 06:11:05 INFO - PROCESS | 30078 | _x_x_mozilla_page_load_details 06:11:05 INFO - PROCESS | 30078 | |i|pagename|runs| 06:11:05 INFO - PROCESS | 30078 | |0;ai-astar;102;114;113;115;115;115;119;115;116;115 06:11:05 INFO - PROCESS | 30078 | |1;audio-beat-detection;145;122;151;188;124;142;143;124;185;125 06:11:05 INFO - PROCESS | 30078 | |2;audio-dft;162;162;164;163;161;161;161;161;161;160 06:11:05 INFO - PROCESS | 30078 | |3;audio-fft;76;75;124;118;76;79;78;120;116;76 06:11:05 INFO - PROCESS | 30078 | |4;audio-oscillator;88;87;148;86;86;87;142;86;86;144 06:11:05 INFO - PROCESS | 30078 | |5;imaging-gaussian-blur;117;117;117;118;117;118;119;119;118;117 06:11:05 INFO - PROCESS | 30078 | |6;imaging-darkroom;148;147;147;147;147;146;147;148;147;146 06:11:05 INFO - PROCESS | 30078 | |7;imaging-desaturate;95;95;94;95;96;95;95;96;96;102 06:11:05 INFO - PROCESS | 30078 | |8;json-parse-financial;66;65;65;65;67;66;66;67;65;65 06:11:05 INFO - PROCESS | 30078 | |9;json-stringify-tinderbox;65;66;66;65;65;65;65;65;66;67 06:11:05 INFO - PROCESS | 30078 | |10;stanford-crypto-aes;91;86;86;87;86;83;87;83;84;83 06:11:05 INFO - PROCESS | 30078 | |11;stanford-crypto-ccm;144;143;140;131;141;142;146;132;149;141 06:11:05 INFO - PROCESS | 30078 | |12;stanford-crypto-pbkdf2;180;174;178;175;172;171;171;172;170;176 06:11:05 INFO - PROCESS | 30078 | |13;stanford-crypto-sha256-iterative;70;68;69;71;68;68;72;68;68;69 06:11:05 INFO - PROCESS | 30078 | __end_tp_report 06:11:05 INFO - PROCESS | 30078 | __start_cc_report 06:11:05 INFO - PROCESS | 30078 | _x_x_mozilla_cycle_collect,2000 06:11:05 INFO - PROCESS | 30078 | __end_cc_report 06:11:05 INFO - PROCESS | 30078 | __startTimestamp1471871465553__endTimestamp 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | ------- Summary: start ------- 06:11:05 INFO - PROCESS | 30078 | Number of tests: 14 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.00 stddev:4.46 (3.9%) stddev-sans-first:1.64 06:11:05 INFO - PROCESS | 30078 | Values: 102.0 114.0 113.0 115.0 115.0 115.0 119.0 115.0 116.0 115.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:144.00 stddev:24.29 (16.9%) stddev-sans-first:25.76 06:11:05 INFO - PROCESS | 30078 | Values: 145.0 122.0 151.0 188.0 124.0 142.0 143.0 124.0 185.0 125.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 06:11:05 INFO - PROCESS | 30078 | Values: 162.0 162.0 164.0 163.0 161.0 161.0 161.0 161.0 161.0 160.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:22.24 (29.3%) stddev-sans-first:22.63 06:11:05 INFO - PROCESS | 30078 | Values: 76.0 75.0 124.0 118.0 76.0 79.0 78.0 120.0 116.0 76.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:86.00 stddev:28.11 (32.7%) stddev-sans-first:29.21 06:11:05 INFO - PROCESS | 30078 | Values: 88.0 87.0 148.0 86.0 86.0 87.0 142.0 86.0 86.0 144.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 06:11:05 INFO - PROCESS | 30078 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 119.0 119.0 118.0 117.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 06:11:05 INFO - PROCESS | 30078 | Values: 148.0 147.0 147.0 147.0 147.0 146.0 147.0 148.0 147.0 146.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:2.23 (2.4%) stddev-sans-first:2.35 06:11:05 INFO - PROCESS | 30078 | Values: 95.0 95.0 94.0 95.0 96.0 95.0 95.0 96.0 96.0 102.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 06:11:05 INFO - PROCESS | 30078 | Values: 66.0 65.0 65.0 65.0 67.0 66.0 66.0 67.0 65.0 65.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 06:11:05 INFO - PROCESS | 30078 | Values: 65.0 66.0 66.0 65.0 65.0 65.0 65.0 65.0 66.0 67.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:2.50 (2.9%) stddev-sans-first:1.73 06:11:05 INFO - PROCESS | 30078 | Values: 91.0 86.0 86.0 87.0 86.0 83.0 87.0 83.0 84.0 83.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:142.50 stddev:5.63 (3.9%) stddev-sans-first:5.85 06:11:05 INFO - PROCESS | 30078 | Values: 144.0 143.0 140.0 131.0 141.0 142.0 146.0 132.0 149.0 141.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.50 stddev:3.31 (1.9%) stddev-sans-first:2.68 06:11:05 INFO - PROCESS | 30078 | Values: 180.0 174.0 178.0 175.0 172.0 171.0 171.0 172.0 170.0 176.0 06:11:05 INFO - PROCESS | 30078 | 06:11:05 INFO - PROCESS | 30078 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.45 (2.1%) stddev-sans-first:1.50 06:11:05 INFO - PROCESS | 30078 | Values: 70.0 68.0 69.0 71.0 68.0 68.0 72.0 68.0 68.0 69.0 06:11:05 INFO - PROCESS | 30078 | -------- Summary: end -------- 06:11:05 INFO - PROCESS | 30078 | 06:11:06 INFO - TEST-INFO | 30078: exit 0 06:11:06 INFO - TEST-OK | kraken | took 65192ms 06:11:06 INFO - SUITE-END | took 1186s 06:11:07 INFO - Completed test suite (00:19:47) 06:11:07 INFO - javascript benchmark 06:11:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.8709564521773, 2626.0677459501862, 2631.46055058713, 2637.2352017914804, 2650.2711754267584, 4612.884677883055, 4694.577488026077, 4726.62187025038, 4786.928196077058, 4792.7603619819, 4695.483496815347, 4713.83501577444, 4713.9057218855605, 4725.456572494156, 4775.116603428368, 4314.439122914033, 4372.169287835317, 4374.846880359188, 4392.3631073494325, 4396.6043056124945, 4331.566843315659, 4385.276429389163, 4431.468223813147, 4449.911001779962, 4490.865274041784, 4472.08322293929, 4475.351074094255, 4478.596926276635, 4487.46150461945, 4494.887627809315, 4218.1985422769885, 4256.382824490463, 4302.763348015857, 4387.714798538117, 4399.0, 4315.072259464199, 4323.762193079379, 4335.436393268855, 4345.630621397185, 4405.537418571036, 4764.2615394613895, 4793.880152996168, 4807.134715751164, 4810.687305325143, 4818.301346304766, 4879.560839524424, 4977.552020318152, 5015.648904576681, 5139.58883289336, 5147.536721695028, 4982.701037937735, 5062.670926389773, 5064.645474816764, 5068.898622027539, 5068.923966140511, 4665.066986602693, 4688.742119183477, 4708.717476951394, 4712.552307530779, 4712.740799256074, 5009.348784658044, 5019.974900125549, 5049.040682270357, 5055.317532133188, 5142.2029585413575, 4894.1679914414635, 4911.877203069952, 4916.70499770015, 4917.1149193144865, 4917.729524876167, 4981.352424184833, 4984.800607975641, 4991.051700176955, 5002.049610574052, 5010.824621138316, 4890.266460030953, 4937.728424936591, 4952.975235123873, 4953.90092198154, 4975.527324904128, 4987.202047672355, 5011.348524691767, 5024.547790698854, 5025.698458092526, 5033.672811267256, 4261.616454519108, 4271.0, 4276.5295817460055, 4277.743335399886, 4278.914421711548, 3649.94525082124, 3670.3209906167444, 3692.8892133236045, 3739.1026153723456, 3771.189194323179, 4340.65274778017, 4381.737095774264, 4383.62739167168, 4395.802188901507, 4396.736195828196, 5063.620228482879, 5086.287919691246, 5095.490450954949, 5106.693598384109, 5107.208382700687, 4243.787810609457, 4270.743755374688, 4388.166248412791, 4394.2749446340995, 4395.604395604411, 4452.220861349251, 4482.484514280834, 4494.887627809331, 4498.752568608693, 4501.41481607389, 4725.716457012591, 4758.333833263277, 4765.189917713928, 4766.261229509431, 4768.165571024987, 4831.855044348676, 5002.499750024968, 5010.574101201439, 5022.924656130234, 5046.6719663221775, 4743.810247590058, 4780.737059461763, 4799.352087468287, 4817.301491283674, 4818.325434439112, 5014.42334131565, 5018.774155162953, 5021.974890125673, 5023.522765337287, 5029.371328583927, 4895.04546613407, 4980.128477516492, 5100.515451032146, 5107.642465027412, 5116.334876466036, 4902.803887844446, 4909.116359055404, 4917.065757506062, 4928.310036594808, 4938.2839488273285, 4901.3383193268455, 4908.460069392293, 4910.042541704333, 4912.0, 4915.066137433876, 4728.59806916416, 4799.136155492045, 4802.447718512416, 4831.73425461603, 4854.417469903493, 4953.801847926043, 5041.521055499722, 5053.67151135175, 5054.949450505448, 5060.898782024413, 4922.8769280768265, 4925.310456536159, 4927.655064145475, 4928.408590969107, 4931.334269873521], "value": 4634.413399929123, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.169633094854, 573.3807487913055, 585.8242527241827, 587.9323877754057, 613.3498491598908, 34477.31045379091, 38167.80916095416, 38276.23447531048, 38327.0, 38422.80788596053, 38948.80525597368, 39400.408993865116, 39418.80290598543, 39445.21109577814, 39492.60507394925, 7524.172341042495, 7654.11977622575, 7669.961650191769, 7680.078390593108, 7681.385489160882, 7502.0, 7522.9247707523045, 7530.849383012336, 7535.5478671279625, 7537.924620753777, 7543.245675432468, 7550.169481357047, 7555.622218889061, 7566.735164269252, 7567.886481702752, 7532.284432978859, 7542.924570754304, 7571.280728330799, 7572.242775722439, 7575.166731659513, 7568.621568921532, 7633.198514156044, 7633.770986870402, 7634.809129771745, 7650.1967293433945, 36717.81641091804, 37109.62890371116, 37174.44238336427, 37231.25537489235, 37241.81379093087, 2922.8538573071473, 2938.074506530436, 3008.17275249306, 3268.754843386732, 3644.817759112034, 28258.0, 28645.0, 28830.567541486686, 28875.133745987652, 28959.855200724072, 3371.7302615790923, 3496.7552271341015, 3569.1790888095884, 3635.4001589737663, 3638.599754027055, 188257.0, 188649.0, 189091.0, 189866.0, 190036.0498197514, 28428.57357139603, 51361.74319128455, 51691.22463163055, 51760.48239517557, 51827.22259166116, 30406.54390184149, 32220.83889580584, 32283.51574726381, 32290.515642265385, 32310.515342269886, 11683.766324673628, 11726.237794543327, 11836.230645008047, 11846.526138954518, 11921.284722916653, 9508.239340852853, 9541.0, 9546.0, 9560.0, 9563.713088607354, 7770.650320735581, 7784.922150778533, 7842.098158711821, 7891.053073631201, 7927.920720792834, 3044.8173109613494, 3074.7540196784203, 3125.093722820402, 3129.1225264840914, 3181.2683082891062, 809.4455298120806, 864.5849992003873, 897.0670502677273, 915.4187091197005, 960.6061514779046, 27389.45221095567, 27618.0, 27843.303917401823, 28370.0, 28401.43197136087, 919.090100800203, 951.8001219743793, 954.9427034377959, 984.9162821160281, 1056.292284169593, 14910.627234319012, 14967.700645987019, 15174.848251517564, 15250.694986100216, 15407.768883466757, 413954.0, 416269.0, 416395.0, 416974.0, 420010.0, 49288.50711492839, 50198.498015020115, 50202.74898625483, 50255.497445025816, 50263.0, 1095.0637205189607, 1156.5662876421343, 1176.253079294654, 1220.8229806677982, 1222.7615614954998, 27968.160955171377, 28976.565351519323, 29406.264843379086, 30252.394952101276, 30255.0, 42775.5722442784, 43280.78359608182, 43314.350284745124, 43355.0, 43362.78318608387, 312555.0, 313112.0, 313281.0, 313570.0, 314024.0, 21219.7878021224, 21667.891660542227, 25264.115755948453, 25314.74685253124, 25608.23175304744, 41533.0, 42285.1542969145, 42489.150216994865, 42568.36147457852, 42658.78670606627, 36150.27699445944, 36409.27181456409, 36557.634423656484, 36643.0, 37309.4403583941, 36595.085122872144, 37011.81494092512, 37301.6269837309, 37469.0, 38265.23469530649, 34974.0, 35462.82268588641, 35978.0, 36141.45787813237, 36256.55562721537, 30415.847920761138, 33023.50464743079, 33228.33543329168, 33383.33233335368, 33549.47730488264, 24381.26856194317, 25121.371965701004, 25379.0, 25594.360140996625, 25941.870290648425], "value": 16121.488297017277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.84569635056914, 359.10582649203485, 363.3097115480587, 379.45737595238796, 391.69252137072385, 16078.517644470656, 17090.401835935743, 17738.822611773878, 17924.10379481027, 17931.372401965902, 16684.33262669492, 16703.0, 16787.74818377722, 17039.14804259788, 17244.655106897855, 4967.180415231483, 5201.609879259052, 5204.505571970676, 5205.16717325228, 5209.1404918188455, 3784.829682664287, 3964.2864284428792, 5034.219695947134, 5731.226284451587, 5984.611000284989, 6070.423309785563, 6076.058210977306, 6076.392360763933, 6083.665398403086, 6089.299730530979, 5824.301083869942, 5950.077737950603, 5981.850453738648, 5994.100884867261, 6002.8499287517725, 4592.563706447882, 5248.0553500369915, 5250.7637156328055, 5256.9737151314, 5260.894782104375, 12275.140740148194, 13627.250501222428, 19151.712724309145, 20805.791942080537, 20843.270485532932, 1894.9242030318771, 1921.3179321340863, 1927.4506765571746, 1956.3739603326942, 2000.1599328282011, 13691.520796772065, 14052.508162214273, 14830.777538336934, 15369.687368499131, 15557.766633500507, 1828.9542761430937, 1842.4933143385542, 1891.517662995941, 1914.425672298305, 1930.6524825531399, 74052.88920666194, 80410.59794701048, 81655.591722041, 82069.9999999994, 85181.50049743267, 14068.226247556482, 15536.223188840513, 16955.813093083365, 17430.47708568745, 17514.0, 28782.856085719857, 28811.56782648262, 28932.85533572361, 28960.710392895802, 28995.275118122216, 8377.329813614897, 8623.31013518917, 8829.779255518664, 9017.458952462874, 9087.318451116193, 7083.256258092929, 7166.964165179245, 7274.4907856449545, 7341.192468828424, 7382.815429614303, 8331.458455200393, 8512.787180320418, 8601.61292741828, 8640.30877529796, 8740.475571465733, 2700.338417087826, 3187.474066779002, 3257.657945915692, 3275.623303320101, 3406.1654894550993, 760.3385055002184, 861.9914699801247, 900.7256676890903, 914.4741773480275, 946.5787724462548, 16628.750568741478, 16701.0, 17229.483115506555, 17341.7398739019, 17359.0, 824.583585289425, 846.1876598465542, 861.1356413364995, 873.9169778870997, 914.0356923445696, 9141.88615123184, 9880.851787223197, 9901.752456188653, 9912.256580756472, 9982.251331150048, 293412.0, 296069.8340641027, 400780.0, 402883.0, 403087.0, 82425.58787206025, 83043.58478207691, 84339.0, 84763.57618211869, 85277.0, 853.5561508015797, 891.919727224553, 892.9374943754004, 893.2005854760083, 895.1004240738016, 15109.622259443602, 16089.839101608834, 16587.419440319532, 16622.16889155513, 16853.831461685717, 36697.0, 37748.81125594355, 38025.0, 38339.6166038336, 38977.0, 48627.270590940454, 52733.0, 54213.0, 55345.0, 55566.72216638891, 7664.195259497896, 7702.030254776936, 7780.2219778021745, 7800.102988156208, 8002.439829211899, 6259.624422534663, 7567.810804729926, 11081.50133244022, 12153.29853820448, 12582.559610413591, 10053.547590358598, 10142.949285253526, 10551.208659350734, 10927.45362731876, 10939.945300273448, 4396.890077748082, 10244.538995745359, 10434.634787782392, 11004.0, 11101.111911046935, 10743.958647856882, 10764.569417223223, 10819.945900270448, 10868.934902368524, 11276.32342059479, 7621.361407297458, 7656.736638454593, 7720.7683769487, 7785.143634200347, 7967.282944534788, 10214.182865370902, 10428.634997775041, 10463.581456741646, 10766.73083172927, 11041.503132358903], "value": 9013.220689837104, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.9325033748314, 1383.2668685596634, 1437.0, 1601.10338210602, 1638.5330180898438, 6956.408705260053, 7560.0, 7581.203973582763, 7583.50707204032, 7587.696492140321, 6412.775552855651, 7082.0, 7288.453365997545, 7309.524880882739, 7401.333879950804, 2157.1048015073725, 2180.433087397272, 2180.5420861619077, 2184.9344519664355, 2194.681771143183, 2129.233475948657, 2141.796529329711, 2172.967405488911, 2175.630142875707, 2177.140029688272, 2150.086213359316, 2150.3441450357636, 2160.1899287767087, 2161.740591129059, 2185.366243789307, 2116.6347705729872, 2121.0561300221407, 2124.4370241885913, 2124.479502521884, 2124.8300135989084, 2091.518950641346, 2139.3261122746285, 2139.689744986984, 2140.047678782942, 2155.644318687415, 7168.498205125643, 7316.743913963039, 7319.451041171933, 7326.560406375635, 7332.743353982585, 4221.219074471202, 4384.276594361926, 4395.318725597537, 4397.648188144973, 4422.601965823092, 2720.7007229204773, 2891.161563146685, 2894.7394734473996, 2903.11455006223, 2907.941841163186, 922.4419226368018, 968.2399316536555, 985.522021819417, 987.5605355616754, 997.5261750668446, 9855.55649995752, 9909.950450247703, 9910.306278560503, 9974.800503989953, 10025.348352357074, 3901.804909754501, 4100.794960251976, 4228.9788551057045, 4251.149770046003, 4339.240632889232, 8549.957250213709, 8568.143185681507, 8573.74278771638, 8576.1423857615, 8653.39426240157, 4534.410526631516, 4536.5236650151255, 4537.0925814837165, 4540.091981603692, 4541.046380260183, 3444.362792883325, 4032.2943484890616, 4117.3206420940805, 4147.0, 4200.075983283673, 3584.6415358464465, 3588.659077387644, 3747.6439738224826, 3750.0812300985885, 3753.6621704046765, 1189.827475016118, 1198.8861058199457, 1203.9819402708965, 1209.0, 1209.661294837447, 691.865086308165, 854.0775961961191, 861.4486728493769, 869.9260562852102, 880.6081293824315, 5041.143005689041, 5108.514691104339, 5137.255098010843, 5142.588592912558, 5250.921236181461, 412.84518305635385, 419.7313719219702, 427.8310067523373, 430.1955343507661, 436.8252698920457, 3542.0613537412605, 3582.373084710165, 3601.85592576294, 3609.657082577151, 3793.639604237593, 8736.781580460412, 9252.167304942453, 9264.953675231716, 9273.026332235153, 9278.164965153168, 9141.725748227564, 9150.359474836698, 9150.816983660423, 9155.22180614642, 9169.128932751511, 6355.904661430175, 7010.509264351446, 7079.115110611174, 7082.043924070287, 7085.92914070863, 5236.476352364733, 5251.894962100813, 5343.62594618373, 5367.221752845893, 5547.972260138674, 8420.368472364475, 8489.4481858679, 8554.486730795923, 8630.223279904587, 8658.826823463622, 8463.407561470638, 8490.15098490146, 8523.0, 8703.91296087031, 8771.122887711177, 5989.850253743692, 6408.807735767934, 6555.770548030987, 6670.366315200048, 6675.566088204251, 7141.85716285661, 7315.122185337794, 7349.081364829396, 7354.301341372561, 7354.485186036926, 6436.9034464484, 6464.709088091141, 6595.109660196004, 6645.468362530889, 6784.93215067843, 6192.0, 6247.219097612799, 6270.310265870842, 6435.935640643534, 6508.837279068061, 6127.908081378694, 6231.875362492816, 6233.563650544418, 6242.3133455320785, 6260.780872669435, 4493.168763778712, 4514.074614704044, 4583.862484125481, 4584.839530616412, 4619.983603607201, 4355.477342718894, 4425.545475367789, 4510.526394728507, 4580.88547786308, 4599.747013914133], "value": 3965.176293798433, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.8453219793509, 294.75977078680876, 299.7841554081061, 302.09522480171887, 302.3544731997186, 4701.7649117544115, 4745.738984355855, 4756.8572942811725, 4764.284857451315, 4812.446568644598, 4713.077891707147, 4716.740579268139, 4747.8338258160975, 4755.334253204554, 4759.167145749498, 3548.9112772180642, 3655.8903232903053, 3668.0279725872533, 3669.3945498992634, 3686.2996030754207, 3657.3965295726307, 3661.7802931824044, 3731.0112820102695, 3759.7556158849725, 3802.9809850950705, 3732.0, 3737.0, 3768.9647590301206, 3785.9810700946455, 3787.0532366908274, 3509.1928856362924, 3661.4690869823726, 3756.2908876461142, 3768.6244520749865, 3771.4154306082464, 3240.2223466368137, 3240.7245384142375, 3242.8001639393574, 3249.675032496755, 3273.247153154764, 4620.283856002325, 4623.352730617717, 4627.652926030528, 4636.794433447294, 4651.674382793206, 4072.429859819628, 4166.937495937564, 4200.978995105035, 4210.789460526992, 4259.850905218303, 4910.288008238786, 4913.263010548446, 4913.729744864031, 4918.2376731606655, 4918.532739389752, 3535.5580552430947, 3538.8230588470474, 3539.7345199109914, 3540.274243780019, 3543.2382037861985, 5016.448190699057, 5135.666181698215, 5195.766190521435, 5200.8179713710215, 5221.973890130525, 3597.442396428558, 3612.8735494257576, 3613.0244833894703, 3630.7276954228537, 3635.763675361093, 3684.3920753075977, 3689.2252626948643, 3689.6679298862696, 3690.6678398943686, 3693.372126738407, 4167.916641667211, 4185.142045880587, 4200.285951388271, 4215.367694845736, 4234.894127646772, 4643.535646435397, 4892.730899800474, 4914.8034078637165, 4972.8508144755715, 4978.228374601942, 1255.598208573266, 1272.4464857786893, 1274.9107562470538, 1275.4770544077069, 1277.6678063703318, 830.2569200565581, 859.9011113722003, 873.7160422862595, 875.5272153037416, 878.692457639821, 4207.474065741782, 4252.234597772431, 4413.514513403523, 4442.977785111054, 4457.5988161065015, 5047.4447810740785, 5080.288759573663, 5122.129238029469, 5137.255098010843, 5166.483351664803, 4386.780660967002, 4400.3399490076745, 4414.933775993362, 4422.314541246112, 4427.380166776654, 2601.427685909097, 2665.9733402665724, 2704.5943108533484, 2710.254679963026, 2730.7405796449702, 4814.662973591815, 4816.54242846936, 4856.41722993236, 4858.271259311132, 4872.342233798392, 5210.374755029421, 5218.843434696965, 5247.16045432729, 5249.921251181236, 5276.577873770089, 4623.9075218495445, 4819.277108433763, 4862.343583616308, 4871.537203965618, 4875.19559272716, 5092.618053645917, 5124.410692770379, 5154.304168937146, 5154.819581314636, 5175.360566111235, 4836.492168322276, 5035.697858128524, 5051.949480505295, 5054.620903432184, 5056.317397151484, 4832.371791667061, 4833.830815921426, 4857.441394239567, 4867.902641947212, 4911.165101932752, 3681.466187402865, 3725.8323375447626, 3747.8313475894197, 3763.868264610835, 3778.074371778932, 5108.948910510847, 5149.9742501287255, 5161.200013997836, 5167.199084141964, 5168.457311982338, 4742.66801323904, 4957.082939656175, 4977.694294435215, 4989.900201996013, 4990.600751939909, 4979.875503112451, 4982.701037937735, 4989.0, 4990.176620857518, 5055.646104772778, 4782.736949467812, 4927.334809800631, 4930.0, 4931.753412329297, 4932.136876046749, 4814.6870453420415, 4857.975710121426, 4958.8760280993265, 4987.127252730685, 5029.220470827027, 4850.442199147144, 4886.511348865085, 4890.559849613552, 4890.559849613552, 4899.240617704261], "value": 3755.1339828333375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.4015345268542, 669.7650348815223, 673.8214373191105, 713.7145141943222, 718.4396170986629, 13024.544140955068, 13902.0, 13922.303884805757, 13948.302584870766, 13969.231692256948, 13452.327383630829, 13490.258035808027, 13534.526291579798, 13585.59243222705, 13588.524401645944, 618.3754408047881, 736.3483317264233, 746.6042997211473, 752.6838727734337, 774.9922500774976, 751.8345963887963, 764.1785081037879, 764.3693952489191, 765.0551568812513, 766.4979438467784, 823.6129019360891, 823.6334831000207, 825.0223485170093, 825.6367198432671, 827.1439060572309, 646.6120327803327, 775.8681024225895, 815.0993152566417, 815.4699445360504, 815.6003558256471, 598.35676647604, 598.9670568118752, 599.4604855629924, 599.8680290336163, 600.726669365442, 12501.874981250254, 12536.435860386304, 12549.498020079185, 12556.560520381743, 12557.0, 12180.451879665436, 12496.375181240901, 12503.49986000568, 13030.609081727564, 13108.850811966951, 11829.408529573573, 12204.389780510939, 12272.631821045383, 12296.0, 12305.630831075083, 3865.16898866745, 3868.7485313454536, 3879.7672139671427, 3948.1511475033008, 3986.382110772835, 62165.68917155385, 62227.68886155586, 62243.0, 62271.0, 62340.0, 9973.850392244121, 10235.232357573212, 10325.432101234353, 10360.274780765274, 10857.131429485622, 16742.330306787837, 17421.91289043572, 17436.91281543584, 18407.72388414175, 19179.136938837786, 6974.4420446364165, 7040.160622611466, 7109.502334836512, 7163.10461192351, 7211.567305961659, 3509.719222462248, 3567.9643203568153, 3620.8913732588067, 3645.4714066460747, 3675.5589329280124, 2873.48277310082, 2972.6432828060338, 2979.5679626454476, 2983.3884053768925, 2984.40311937609, 500.2721040885503, 511.1948680827711, 513.3326675322066, 516.3932379454202, 518.9610779191576, 510.56091761085435, 534.7647035304453, 583.7285662167112, 606.1574411567924, 621.3693101501979, 8633.827323453495, 8811.559422029, 8861.556922153866, 8885.244754195837, 8919.42023768453, 583.1311346094288, 595.5622617376225, 605.479287812481, 611.4771870051131, 613.0956838662936, 3867.690584753213, 3992.0, 4029.274730548471, 4084.1423301106506, 4214.3678448232395, 104979.0, 105419.0, 106737.0, 108233.45883270534, 108577.4571127155, 91560.54219728858, 91633.0, 92076.0, 92609.53695231481, 94223.0, 75222.0, 78019.21980780234, 80454.59772701099, 80878.59560702159, 81140.18859811327, 7581.924180758342, 8715.0, 9003.14470125337, 9110.90889091127, 9298.95350523243, 38388.54985467615, 38526.229475409775, 41495.9252037403, 43470.56529434665, 43783.78108109439, 38509.807450962566, 49848.252276215164, 58949.0, 59609.701951489966, 60897.08654370277, 11317.151213658844, 11556.59551915679, 11819.290842549475, 11841.644750657493, 12116.939415303219, 13125.54060607874, 13346.3326833656, 13554.457821687021, 14107.858921410654, 14383.137011779327, 11402.615087194514, 11411.60059397917, 11469.197156198987, 11487.827682584935, 11867.465964031811, 12073.27560346382, 12108.515659373526, 12218.51125954952, 12264.264144151379, 12867.099303049072, 11781.234219775688, 12101.636950891487, 12290.631281061582, 12819.487220511448, 12835.0, 10373.222008349554, 10455.215858810772, 10646.467676615983, 11119.610813621484, 11205.495752691311, 10120.746981325527, 10707.839382409426, 10857.022867941923, 10879.456027198767, 10904.945475272572], "value": 6699.195102975111, "unit": "score"}], "name": "dromaeo_css", "value": 6375.879511518784, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 113.0, 115.0, 115.0, 115.0, 119.0, 115.0, 116.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 151.0, 188.0, 124.0, 142.0, 143.0, 124.0, 185.0, 125.0], "value": 144.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 124.0, 118.0, 76.0, 79.0, 78.0, 120.0, 116.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 148.0, 86.0, 86.0, 87.0, 142.0, 86.0, 86.0, 144.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 119.0, 119.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 102.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 67.0, 66.0, 66.0, 67.0, 65.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 67.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 86.0, 87.0, 86.0, 83.0, 87.0, 83.0, 84.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 143.0, 140.0, 131.0, 141.0, 142.0, 146.0, 132.0, 149.0, 141.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 174.0, 178.0, 175.0, 172.0, 171.0, 171.0, 172.0, 170.0, 176.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 71.0, 68.0, 68.0, 72.0, 68.0, 68.0, 69.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1579.5, "alertThreshold": 2.0}]} 06:11:07 INFO - Return code: 0 06:11:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:11:07 INFO - # TBPL SUCCESS # 06:11:07 INFO - Running post-action listener: _resource_record_post_action 06:11:07 INFO - [mozharness: 2016-08-22 13:11:07.322576Z] Finished run-tests step (success) 06:11:07 INFO - Running post-run listener: _resource_record_post_run 06:11:07 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 422191104; Read time: 12; Write time: 331180 06:11:07 INFO - TinderboxPrint: CPU usage
13.2% 06:11:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:11:07 INFO - TinderboxPrint: I/O write bytes / time
422,191,104 / 331,180 06:11:07 INFO - TinderboxPrint: CPU idle
8,329.0 (86.8%) 06:11:07 INFO - TinderboxPrint: CPU user
1,205.7 (12.6%) 06:11:07 INFO - TinderboxPrint: Swap in / out
0 / 0 06:11:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 130322432; Read time: 0; Write time: 126680 06:11:07 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291254272; Read time: 0; Write time: 204484 06:11:07 INFO - Running post-run listener: _upload_blobber_files 06:11:07 INFO - Blob upload gear active. 06:11:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:11:07 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 06:11:07 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:11:07 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:11:08 INFO - (blobuploader) - INFO - Open directory for files ... 06:11:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:11:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:11:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:09 INFO - (blobuploader) - INFO - Done attempting. 06:11:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:11:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:11:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:10 INFO - (blobuploader) - INFO - Done attempting. 06:11:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:11:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:11:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:13 INFO - (blobuploader) - INFO - Done attempting. 06:11:13 INFO - (blobuploader) - INFO - Iteration through files over. 06:11:13 INFO - Return code: 0 06:11:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:11:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:11:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3b0d74e7a30feb97c5329a706362339ba9849575f253c2872bb8ff160726c2d4b26463103e0c587f2d124ea2b82d804db89907d1735e2446ba442ba72fa0764e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55c14175d8ff23151c145d4bf1e088cb9fe4b39794868f1b50c98d3136ac6c1ec3ffeeeddbb063fc529491f146417604e74c99180cb4d08e68871af6a72b25da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/766db0ebcee73a68db37605a72cfe0ad6760a116fcaf80606435c09851ec98a05f87c7f64bfd0240183908587857c9b376fbc6a97a73e2f0277bc34e55d9bd21"} 06:11:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:11:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:11:13 INFO - Contents: 06:11:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3b0d74e7a30feb97c5329a706362339ba9849575f253c2872bb8ff160726c2d4b26463103e0c587f2d124ea2b82d804db89907d1735e2446ba442ba72fa0764e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55c14175d8ff23151c145d4bf1e088cb9fe4b39794868f1b50c98d3136ac6c1ec3ffeeeddbb063fc529491f146417604e74c99180cb4d08e68871af6a72b25da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/766db0ebcee73a68db37605a72cfe0ad6760a116fcaf80606435c09851ec98a05f87c7f64bfd0240183908587857c9b376fbc6a97a73e2f0277bc34e55d9bd21"} 06:11:13 INFO - Running post-run listener: copy_logs_to_upload_dir 06:11:13 INFO - Copying logs to upload dir... 06:11:13 INFO - mkdir: /builds/slave/test/build/upload/logs 06:11:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.453757 ========= master_lag: 1.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-22 06:11:15.328888) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 06:11:15.334534) ========= 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=652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3b0d74e7a30feb97c5329a706362339ba9849575f253c2872bb8ff160726c2d4b26463103e0c587f2d124ea2b82d804db89907d1735e2446ba442ba72fa0764e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55c14175d8ff23151c145d4bf1e088cb9fe4b39794868f1b50c98d3136ac6c1ec3ffeeeddbb063fc529491f146417604e74c99180cb4d08e68871af6a72b25da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/766db0ebcee73a68db37605a72cfe0ad6760a116fcaf80606435c09851ec98a05f87c7f64bfd0240183908587857c9b376fbc6a97a73e2f0277bc34e55d9bd21"} build_url:https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/A4h85X3zR4iav-zCPGhovg/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/Fx-Team-Non-PGO/sha512/3b0d74e7a30feb97c5329a706362339ba9849575f253c2872bb8ff160726c2d4b26463103e0c587f2d124ea2b82d804db89907d1735e2446ba442ba72fa0764e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55c14175d8ff23151c145d4bf1e088cb9fe4b39794868f1b50c98d3136ac6c1ec3ffeeeddbb063fc529491f146417604e74c99180cb4d08e68871af6a72b25da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/766db0ebcee73a68db37605a72cfe0ad6760a116fcaf80606435c09851ec98a05f87c7f64bfd0240183908587857c9b376fbc6a97a73e2f0277bc34e55d9bd21"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 06:11:15.367148) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 06:11:15.367519) ========= 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=652eb03db935cfc1c15ebda0000001ad-1471867328.881969-1613288929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 06:11:15.420221) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 06:11:15.420681) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 06:11:15.421021) ========= ========= Total master_lag: 1.69 =========