builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1471632382.6 results: success (0) buildid: 20160819101924 builduid: 73a3f29e0b154ee5b9974f29ab9a0b7e revision: 7a6329cd8524c0c8c746d380deade176c787c235 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:22.603381) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:22.604084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:22.604504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:22.621891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:22.622279) ========= 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=ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 11:46:23-- 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% 220M=0s 2016-08-19 11:46:23 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097909 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:22.735092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:22.735436) ========= 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=ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016521 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:22.784794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:22.785158) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7a6329cd8524c0c8c746d380deade176c787c235 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 7a6329cd8524c0c8c746d380deade176c787c235 --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=ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 11:46:23,451 truncating revision to first 12 chars 2016-08-19 11:46:23,451 Setting DEBUG logging. 2016-08-19 11:46:23,451 attempt 1/10 2016-08-19 11:46:23,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7a6329cd8524?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 11:46:23,778 unpacking tar archive at: autoland-7a6329cd8524/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648387 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:23.451107) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:23.451718) ========= script_repo_revision: 7a6329cd8524c0c8c746d380deade176c787c235 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:23.452453) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:23.452925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 11:46:23.465080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-19 11:46:23.465725) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:46:24 INFO - MultiFileLogger online at 20160819 11:46:24 in /builds/slave/test 11:46:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 11:46:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:46:24 INFO - {'append_to_log': False, 11:46:24 INFO - 'base_work_dir': '/builds/slave/test', 11:46:24 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 11:46:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:46:24 INFO - 'branch': 'Autoland-Non-PGO', 11:46:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:46:24 INFO - 'config_files': ('talos/linux_config.py',), 11:46:24 INFO - 'default_actions': ('clobber', 11:46:24 INFO - 'read-buildbot-config', 11:46:24 INFO - 'download-and-extract', 11:46:24 INFO - 'populate-webroot', 11:46:24 INFO - 'create-virtualenv', 11:46:24 INFO - 'install', 11:46:24 INFO - 'run-tests'), 11:46:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:46:24 INFO - 'download_minidump_stackwalk': True, 11:46:24 INFO - 'download_symbols': 'ondemand', 11:46:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:46:24 INFO - 'tooltool.py': '/tools/tooltool.py', 11:46:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:46:24 INFO - '/tools/misc-python/virtualenv.py')}, 11:46:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:46:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:46:24 INFO - 'installer_path': 'installer.exe', 11:46:24 INFO - 'log_level': 'info', 11:46:24 INFO - 'log_name': 'talos', 11:46:24 INFO - 'log_to_console': True, 11:46:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:46:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:46:24 INFO - 'opt_config_files': (), 11:46:24 INFO - 'pip_index': False, 11:46:24 INFO - 'sps_profile': False, 11:46:24 INFO - 'sps_profile_interval': 0, 11:46:24 INFO - 'suite': 'dromaeojs-e10s', 11:46:24 INFO - 'system_bits': '32', 11:46:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:46:24 INFO - 'title': 'talos-linux64-ix-035', 11:46:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:46:24 INFO - 'use_talos_json': True, 11:46:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:46:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:46:24 INFO - 'work_dir': 'build'} 11:46:24 INFO - [mozharness: 2016-08-19 18:46:24.222815Z] Running clobber step. 11:46:24 INFO - Running pre-action listener: _resource_record_pre_action 11:46:24 INFO - Running main action method: clobber 11:46:24 INFO - rmtree: /builds/slave/test/build 11:46:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:46:24 INFO - Running post-action listener: _resource_record_post_action 11:46:24 INFO - [mozharness: 2016-08-19 18:46:24.676934Z] Finished clobber step (success) 11:46:24 INFO - [mozharness: 2016-08-19 18:46:24.677034Z] Running read-buildbot-config step. 11:46:24 INFO - Running pre-action listener: _resource_record_pre_action 11:46:24 INFO - Running main action method: read_buildbot_config 11:46:24 INFO - Using buildbot properties: 11:46:24 INFO - { 11:46:24 INFO - "project": "", 11:46:24 INFO - "product": "firefox", 11:46:24 INFO - "script_repo_revision": "production", 11:46:24 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 11:46:24 INFO - "repository": "", 11:46:24 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 11:46:24 INFO - "buildid": "20160819101924", 11:46:24 INFO - "pgo_build": "False", 11:46:24 INFO - "basedir": "/builds/slave/test", 11:46:24 INFO - "buildnumber": 357, 11:46:24 INFO - "slavename": "talos-linux64-ix-035", 11:46:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:46:24 INFO - "platform": "ubuntu64_hw", 11:46:24 INFO - "scheduler": "tests-autoland-linux64-talos-7-3600", 11:46:24 INFO - "branch": "autoland", 11:46:24 INFO - "repo_path": "integration/autoland", 11:46:24 INFO - "revision": "7a6329cd8524c0c8c746d380deade176c787c235", 11:46:24 INFO - "stage_platform": "linux64", 11:46:24 INFO - "builduid": "73a3f29e0b154ee5b9974f29ab9a0b7e", 11:46:24 INFO - "slavebuilddir": "test" 11:46:24 INFO - } 11:46:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:46:24 INFO - Running post-action listener: _resource_record_post_action 11:46:24 INFO - [mozharness: 2016-08-19 18:46:24.679707Z] Finished read-buildbot-config step (success) 11:46:24 INFO - [mozharness: 2016-08-19 18:46:24.679795Z] Running download-and-extract step. 11:46:24 INFO - Running pre-action listener: _resource_record_pre_action 11:46:24 INFO - Running main action method: download_and_extract 11:46:24 INFO - mkdir: /builds/slave/test/build/tests 11:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:24 INFO - trying https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:46:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/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 11:46:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/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 11:46:25 INFO - Downloaded 1361 bytes. 11:46:25 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:46:25 INFO - Using the following test package requirements: 11:46:25 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:46:25 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:46:25 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:46:25 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:25 INFO - u'jsshell-linux-x86_64.zip'], 11:46:25 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:46:25 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:46:25 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:46:25 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:46:25 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:46:25 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:46:25 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:25 INFO - trying https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:46:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/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 11:46:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/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 11:46:26 INFO - Downloaded 20328962 bytes. 11:46:26 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 11:46:30 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 11:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:30 INFO - trying https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:46:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/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 11:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/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 11:46:31 INFO - Downloaded 20328962 bytes. 11:46:31 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 11:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:35 INFO - trying https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:46:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/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 11:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/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 11:46:36 INFO - Downloaded 14413981 bytes. 11:46:36 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 11:46:36 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')]} 11:46:36 INFO - trying https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:46:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/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 11:46:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/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 11:46:38 INFO - Downloaded 55785741 bytes. 11:46:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:46:38 INFO - mkdir: /builds/slave/test/properties 11:46:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:46:38 INFO - Writing to file /builds/slave/test/properties/build_url 11:46:38 INFO - Contents: 11:46:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:46:38 INFO - Running post-action listener: _resource_record_post_action 11:46:38 INFO - Running post-action listener: set_extra_try_arguments 11:46:38 INFO - [mozharness: 2016-08-19 18:46:38.705770Z] Finished download-and-extract step (success) 11:46:38 INFO - [mozharness: 2016-08-19 18:46:38.705993Z] Running populate-webroot step. 11:46:38 INFO - Running pre-action listener: _resource_record_pre_action 11:46:38 INFO - Running main action method: populate_webroot 11:46:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:46:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:46:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:46:38 INFO - '--tppagecycles', 11:46:38 INFO - '7'], 11:46:38 INFO - 'tests': ['tsvgm']}}, 11:46:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:46:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:46:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:46:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:46:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:46:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:46:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:38 INFO - 'talos_options': ['--disable-e10s'], 11:46:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:46:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:46:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:38 INFO - 'talos_options': ['--disable-e10s'], 11:46:38 INFO - 'tests': ['damp', 'tps']}, 11:46:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:38 INFO - 'tests': ['damp', 'tps']}, 11:46:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:46:38 INFO - 'tests': ['dromaeo_dom']}, 11:46:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:46:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:46:38 INFO - 'tests': ['basic_compositor_video']}, 11:46:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:46:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:46:38 INFO - 'tests': ['a11yr', 11:46:38 INFO - 'ts_paint', 11:46:38 INFO - 'tpaint', 11:46:38 INFO - 'sessionrestore', 11:46:38 INFO - 'sessionrestore_no_auto_restore', 11:46:38 INFO - 'tabpaint']}, 11:46:38 INFO - 'other-e10s': {'tests': ['a11yr', 11:46:38 INFO - 'ts_paint', 11:46:38 INFO - 'tpaint', 11:46:38 INFO - 'sessionrestore', 11:46:38 INFO - 'sessionrestore_no_auto_restore', 11:46:38 INFO - 'tabpaint']}, 11:46:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:46:38 INFO - 'ts_paint', 11:46:38 INFO - 'tpaint', 11:46:38 INFO - 'sessionrestore', 11:46:38 INFO - 'sessionrestore_no_auto_restore', 11:46:38 INFO - 'tabpaint']}, 11:46:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:46:38 INFO - 'ts_paint', 11:46:38 INFO - 'tpaint', 11:46:38 INFO - 'sessionrestore', 11:46:38 INFO - 'sessionrestore_no_auto_restore', 11:46:38 INFO - 'tabpaint']}, 11:46:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:46:38 INFO - 'tests': ['a11yr', 11:46:38 INFO - 'ts_paint', 11:46:38 INFO - 'tpaint', 11:46:38 INFO - 'sessionrestore', 11:46:38 INFO - 'sessionrestore_no_auto_restore', 11:46:38 INFO - 'tabpaint']}, 11:46:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:46:38 INFO - 'tests': ['a11yr', 11:46:38 INFO - 'ts_paint', 11:46:38 INFO - 'tpaint', 11:46:38 INFO - 'sessionrestore', 11:46:38 INFO - 'sessionrestore_no_auto_restore', 11:46:38 INFO - 'tabpaint']}, 11:46:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:46:38 INFO - 'tests': ['tsvgx', 11:46:38 INFO - 'tsvgr_opacity', 11:46:38 INFO - 'tart', 11:46:38 INFO - 'tscrollx', 11:46:38 INFO - 'cart']}, 11:46:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:46:38 INFO - 'tsvgr_opacity', 11:46:38 INFO - 'tart', 11:46:38 INFO - 'tscrollx', 11:46:38 INFO - 'cart']}, 11:46:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:38 INFO - 'talos_options': ['--disable-e10s'], 11:46:38 INFO - 'tests': ['tp5o']}, 11:46:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:38 INFO - 'tests': ['tp5o']}, 11:46:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:38 INFO - 'talos_options': ['--disable-e10s', 11:46:38 INFO - '--xperf_path', 11:46:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:46:38 INFO - 'tests': ['tp5n']}, 11:46:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:38 INFO - 'talos_options': ['--xperf_path', 11:46:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:46:38 INFO - 'tests': ['tp5n']}}, 11:46:38 INFO - 'talos.zip': {'path': '', 11:46:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:46:38 INFO - Running post-action listener: _resource_record_post_action 11:46:38 INFO - [mozharness: 2016-08-19 18:46:38.726437Z] Finished populate-webroot step (success) 11:46:38 INFO - [mozharness: 2016-08-19 18:46:38.726524Z] Running create-virtualenv step. 11:46:38 INFO - Running pre-action listener: _resource_record_pre_action 11:46:38 INFO - Running main action method: create_virtualenv 11:46:38 INFO - Creating virtualenv /builds/slave/test/build/venv 11:46:38 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 11:46:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:46:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:46:38 INFO - Using real prefix '/usr' 11:46:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:46:39 INFO - Installing distribute.............................................................................................................................................................................................done. 11:46:41 INFO - Installing pip.................done. 11:46:41 INFO - Return code: 0 11:46:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:46:41 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')]} 11:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:41 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')]} 11:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:41 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 0x7fb773a34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac090>, '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 0xfaf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfafe40>, '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': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', '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 11:46:41 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 11:46:41 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 11:46:41 INFO - Using env: {'DISPLAY': ':0', 11:46:41 INFO - 'HOME': '/home/cltbld', 11:46:41 INFO - 'LANG': 'en_US.UTF-8', 11:46:41 INFO - 'LANGUAGE': 'en_US:en', 11:46:41 INFO - 'LOGNAME': 'cltbld', 11:46:41 INFO - 'MAIL': '/var/mail/cltbld', 11:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:41 INFO - 'MOZ_NO_REMOTE': '1', 11:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:41 INFO - 'NO_EM_RESTART': '1', 11:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:41 INFO - 'PWD': '/builds/slave/test', 11:46:41 INFO - 'SHELL': '/bin/bash', 11:46:41 INFO - 'SHLVL': '1', 11:46:41 INFO - 'TERM': 'linux', 11:46:41 INFO - 'TMOUT': '86400', 11:46:41 INFO - 'USER': 'cltbld', 11:46:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', 11:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:41 INFO - '_': '/tools/buildbot/bin/python'} 11:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:41 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 11:46:41 INFO - Cleaning up... 11:46:41 INFO - Return code: 0 11:46:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:46:41 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')]} 11:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:41 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')]} 11:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:41 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 0x7fb773a34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac090>, '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 0xfaf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfafe40>, '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': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', '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 11:46:41 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 11:46:41 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 11:46:41 INFO - Using env: {'DISPLAY': ':0', 11:46:41 INFO - 'HOME': '/home/cltbld', 11:46:41 INFO - 'LANG': 'en_US.UTF-8', 11:46:41 INFO - 'LANGUAGE': 'en_US:en', 11:46:41 INFO - 'LOGNAME': 'cltbld', 11:46:41 INFO - 'MAIL': '/var/mail/cltbld', 11:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:41 INFO - 'MOZ_NO_REMOTE': '1', 11:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:41 INFO - 'NO_EM_RESTART': '1', 11:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:41 INFO - 'PWD': '/builds/slave/test', 11:46:41 INFO - 'SHELL': '/bin/bash', 11:46:41 INFO - 'SHLVL': '1', 11:46:41 INFO - 'TERM': 'linux', 11:46:41 INFO - 'TMOUT': '86400', 11:46:41 INFO - 'USER': 'cltbld', 11:46:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', 11:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:41 INFO - '_': '/tools/buildbot/bin/python'} 11:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:41 INFO - Downloading/unpacking psutil>=3.1.1 11:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:46:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:43 INFO - Installing collected packages: psutil 11:46:43 INFO - Running setup.py install for psutil 11:46:43 INFO - building 'psutil._psutil_linux' extension 11:46:43 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 11:46:43 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 11:46:44 INFO - building 'psutil._psutil_posix' extension 11:46:44 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 11:46:44 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 11:46:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:44 INFO - Successfully installed psutil 11:46:44 INFO - Cleaning up... 11:46:44 INFO - Return code: 0 11:46:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:46: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')]} 11:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46: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')]} 11:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb773a34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac090>, '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 0xfaf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfafe40>, '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': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', '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 11:46: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:46: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 mozsystemmonitor==0.3 11:46:44 INFO - Using env: {'DISPLAY': ':0', 11:46:44 INFO - 'HOME': '/home/cltbld', 11:46:44 INFO - 'LANG': 'en_US.UTF-8', 11:46:44 INFO - 'LANGUAGE': 'en_US:en', 11:46:44 INFO - 'LOGNAME': 'cltbld', 11:46:44 INFO - 'MAIL': '/var/mail/cltbld', 11:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:44 INFO - 'MOZ_NO_REMOTE': '1', 11:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:44 INFO - 'NO_EM_RESTART': '1', 11:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:44 INFO - 'PWD': '/builds/slave/test', 11:46:44 INFO - 'SHELL': '/bin/bash', 11:46:44 INFO - 'SHLVL': '1', 11:46:44 INFO - 'TERM': 'linux', 11:46:44 INFO - 'TMOUT': '86400', 11:46:44 INFO - 'USER': 'cltbld', 11:46:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', 11:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:44 INFO - '_': '/tools/buildbot/bin/python'} 11:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:46:44 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 11:46:44 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 11:46:44 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 11:46:44 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 11:46:44 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 11:46:44 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 11:46:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:46:46 INFO - Installing collected packages: mozsystemmonitor 11:46:46 INFO - Running setup.py install for mozsystemmonitor 11:46:46 INFO - Successfully installed mozsystemmonitor 11:46:46 INFO - Cleaning up... 11:46:46 INFO - Return code: 0 11:46:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:46:46 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')]} 11:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:46 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')]} 11:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:46 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 0x7fb773a34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac090>, '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 0xfaf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfafe40>, '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': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', '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 11:46:46 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 11:46:46 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 11:46:46 INFO - Using env: {'DISPLAY': ':0', 11:46:46 INFO - 'HOME': '/home/cltbld', 11:46:46 INFO - 'LANG': 'en_US.UTF-8', 11:46:46 INFO - 'LANGUAGE': 'en_US:en', 11:46:46 INFO - 'LOGNAME': 'cltbld', 11:46:46 INFO - 'MAIL': '/var/mail/cltbld', 11:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:46 INFO - 'MOZ_NO_REMOTE': '1', 11:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:46 INFO - 'NO_EM_RESTART': '1', 11:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:46 INFO - 'PWD': '/builds/slave/test', 11:46:46 INFO - 'SHELL': '/bin/bash', 11:46:46 INFO - 'SHLVL': '1', 11:46:46 INFO - 'TERM': 'linux', 11:46:46 INFO - 'TMOUT': '86400', 11:46:46 INFO - 'USER': 'cltbld', 11:46:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', 11:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:46 INFO - '_': '/tools/buildbot/bin/python'} 11:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:46 INFO - Downloading/unpacking jsonschema==2.5.1 11:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:46:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:48 INFO - Downloading functools32-3.2.3-2.tar.gz 11:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:46:48 INFO - warning: no files found matching '*.txt' 11:46:48 INFO - no previously-included directories found matching 'build' 11:46:48 INFO - no previously-included directories found matching 'dist' 11:46:48 INFO - no previously-included directories found matching '.git*' 11:46:48 INFO - Installing collected packages: jsonschema, functools32 11:46:49 INFO - Running setup.py install for functools32 11:46:49 INFO - warning: no files found matching '*.txt' 11:46:49 INFO - no previously-included directories found matching 'build' 11:46:49 INFO - no previously-included directories found matching 'dist' 11:46:49 INFO - no previously-included directories found matching '.git*' 11:46:49 INFO - Successfully installed jsonschema functools32 11:46:49 INFO - Cleaning up... 11:46:49 INFO - Return code: 0 11:46:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:46: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')]} 11:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46: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')]} 11:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46: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', '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 0x7fb773a34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac090>, '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 0xfaf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfafe40>, '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': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', '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 11:46: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:46: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 functools32==3.2.3-2 11:46:49 INFO - Using env: {'DISPLAY': ':0', 11:46:49 INFO - 'HOME': '/home/cltbld', 11:46:49 INFO - 'LANG': 'en_US.UTF-8', 11:46:49 INFO - 'LANGUAGE': 'en_US:en', 11:46:49 INFO - 'LOGNAME': 'cltbld', 11:46:49 INFO - 'MAIL': '/var/mail/cltbld', 11:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:49 INFO - 'MOZ_NO_REMOTE': '1', 11:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:49 INFO - 'NO_EM_RESTART': '1', 11:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:49 INFO - 'PWD': '/builds/slave/test', 11:46:49 INFO - 'SHELL': '/bin/bash', 11:46:49 INFO - 'SHLVL': '1', 11:46:49 INFO - 'TERM': 'linux', 11:46:49 INFO - 'TMOUT': '86400', 11:46:49 INFO - 'USER': 'cltbld', 11:46:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', 11:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:49 INFO - '_': '/tools/buildbot/bin/python'} 11:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:46:49 INFO - Cleaning up... 11:46:49 INFO - Return code: 0 11:46:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:46: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')]} 11:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46: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')]} 11:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46: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', '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 0x7fb773a34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac090>, '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 0xfaf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfafe40>, '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': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', '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 11:46: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:46: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 blobuploader==1.2.4 11:46:49 INFO - Using env: {'DISPLAY': ':0', 11:46:49 INFO - 'HOME': '/home/cltbld', 11:46:49 INFO - 'LANG': 'en_US.UTF-8', 11:46:49 INFO - 'LANGUAGE': 'en_US:en', 11:46:49 INFO - 'LOGNAME': 'cltbld', 11:46:49 INFO - 'MAIL': '/var/mail/cltbld', 11:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:49 INFO - 'MOZ_NO_REMOTE': '1', 11:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:49 INFO - 'NO_EM_RESTART': '1', 11:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:49 INFO - 'PWD': '/builds/slave/test', 11:46:49 INFO - 'SHELL': '/bin/bash', 11:46:49 INFO - 'SHLVL': '1', 11:46:49 INFO - 'TERM': 'linux', 11:46:49 INFO - 'TMOUT': '86400', 11:46:49 INFO - 'USER': 'cltbld', 11:46:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', 11:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:49 INFO - '_': '/tools/buildbot/bin/python'} 11:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:49 INFO - Downloading/unpacking blobuploader==1.2.4 11:46:49 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 11:46:49 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 11:46:49 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 11:46:49 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 11:46:49 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 11:46:49 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 11:46:51 INFO - Downloading blobuploader-1.2.4.tar.gz 11:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:46:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:46: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 11:46: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 11:46: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 11:46: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 11:46: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 11:46: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 11:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:46:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:46: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 11:46: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 11:46: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 11:46: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 11:46: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 11:46: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 11:46:52 INFO - Downloading docopt-0.6.1.tar.gz 11:46:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:46:52 INFO - Installing collected packages: blobuploader, requests, docopt 11:46:52 INFO - Running setup.py install for blobuploader 11:46:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:46:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:46:52 INFO - Running setup.py install for requests 11:46:52 INFO - Running setup.py install for docopt 11:46:52 INFO - Successfully installed blobuploader requests docopt 11:46:52 INFO - Cleaning up... 11:46:52 INFO - Return code: 0 11:46:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46: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')]} 11:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46: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')]} 11:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:52 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 0x7fb773a34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac090>, '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 0xfaf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfafe40>, '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': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', '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 11:46:52 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 11:46:52 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 11:46:52 INFO - Using env: {'DISPLAY': ':0', 11:46:52 INFO - 'HOME': '/home/cltbld', 11:46:52 INFO - 'LANG': 'en_US.UTF-8', 11:46:52 INFO - 'LANGUAGE': 'en_US:en', 11:46:52 INFO - 'LOGNAME': 'cltbld', 11:46:52 INFO - 'MAIL': '/var/mail/cltbld', 11:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:52 INFO - 'MOZ_NO_REMOTE': '1', 11:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:52 INFO - 'NO_EM_RESTART': '1', 11:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:52 INFO - 'PWD': '/builds/slave/test', 11:46:52 INFO - 'SHELL': '/bin/bash', 11:46:52 INFO - 'SHLVL': '1', 11:46:52 INFO - 'TERM': 'linux', 11:46:52 INFO - 'TMOUT': '86400', 11:46:52 INFO - 'USER': 'cltbld', 11:46:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', 11:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:52 INFO - '_': '/tools/buildbot/bin/python'} 11:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:46:53 INFO - Running setup.py (path:/tmp/pip-HHC5vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:46:53 INFO - Running setup.py (path:/tmp/pip-6AW1dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:46:53 INFO - Running setup.py (path:/tmp/pip-zcJm_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:46:53 INFO - Running setup.py (path:/tmp/pip-NAz7sZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:46:53 INFO - Running setup.py (path:/tmp/pip-vKOj_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:46:53 INFO - Running setup.py (path:/tmp/pip-w6bjbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:46:53 INFO - Running setup.py (path:/tmp/pip-AB1DG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:46:53 INFO - Running setup.py (path:/tmp/pip-GK6LCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:46:53 INFO - Running setup.py (path:/tmp/pip-Uu2I_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:46:53 INFO - Running setup.py (path:/tmp/pip-pxwHs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:46:53 INFO - Running setup.py (path:/tmp/pip-qK_nDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:46:53 INFO - Running setup.py (path:/tmp/pip-XQytHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:46:53 INFO - Running setup.py (path:/tmp/pip-PagKIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:46:53 INFO - Running setup.py (path:/tmp/pip-T6MluP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:54 INFO - Running setup.py (path:/tmp/pip-ppHLQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:46:54 INFO - Running setup.py (path:/tmp/pip-nA1r6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:46:54 INFO - Running setup.py (path:/tmp/pip-R_IB0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:46:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:46:54 INFO - Running setup.py install for manifestparser 11:46:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:46:54 INFO - Running setup.py install for mozcrash 11:46:54 INFO - Running setup.py install for mozdebug 11:46:54 INFO - Running setup.py install for mozdevice 11:46:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:46:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:46:54 INFO - Running setup.py install for mozfile 11:46:54 INFO - Running setup.py install for mozhttpd 11:46:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:46:54 INFO - Running setup.py install for mozinfo 11:46:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:46:54 INFO - Running setup.py install for mozInstall 11:46:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:46:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:46:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:46:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:46:55 INFO - Running setup.py install for mozleak 11:46:55 INFO - Running setup.py install for mozlog 11:46:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:46:55 INFO - Running setup.py install for moznetwork 11:46:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:46:55 INFO - Running setup.py install for mozprocess 11:46:55 INFO - Running setup.py install for mozprofile 11:46:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:46:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:46:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:46:55 INFO - Running setup.py install for mozrunner 11:46:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:46:55 INFO - Running setup.py install for mozscreenshot 11:46:55 INFO - Running setup.py install for moztest 11:46:55 INFO - Running setup.py install for mozversion 11:46:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:46:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:46:56 INFO - Cleaning up... 11:46:56 INFO - Return code: 0 11:46:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46: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')]} 11:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46: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')]} 11:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:56 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 0x7fb773a34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac090>, '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 0xfaf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfafe40>, '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': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', '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 11:46:56 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 11:46:56 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 11:46:56 INFO - Using env: {'DISPLAY': ':0', 11:46:56 INFO - 'HOME': '/home/cltbld', 11:46:56 INFO - 'LANG': 'en_US.UTF-8', 11:46:56 INFO - 'LANGUAGE': 'en_US:en', 11:46:56 INFO - 'LOGNAME': 'cltbld', 11:46:56 INFO - 'MAIL': '/var/mail/cltbld', 11:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:56 INFO - 'MOZ_NO_REMOTE': '1', 11:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:56 INFO - 'NO_EM_RESTART': '1', 11:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:56 INFO - 'PWD': '/builds/slave/test', 11:46:56 INFO - 'SHELL': '/bin/bash', 11:46:56 INFO - 'SHLVL': '1', 11:46:56 INFO - 'TERM': 'linux', 11:46:56 INFO - 'TMOUT': '86400', 11:46:56 INFO - 'USER': 'cltbld', 11:46:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', 11:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:56 INFO - '_': '/tools/buildbot/bin/python'} 11:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:46:56 INFO - Running setup.py (path:/tmp/pip-jK9b0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:46:56 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)) 11:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:46:56 INFO - Running setup.py (path:/tmp/pip-D4dZXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:46:56 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)) 11:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:46:56 INFO - Running setup.py (path:/tmp/pip-HcAllc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:46:56 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)) 11:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:46:56 INFO - Running setup.py (path:/tmp/pip-luCtLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:46:56 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)) 11:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:46:56 INFO - Running setup.py (path:/tmp/pip-QLcuF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:46:56 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)) 11:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:46:56 INFO - Running setup.py (path:/tmp/pip-Np0oyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:46:56 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)) 11:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:46:56 INFO - Running setup.py (path:/tmp/pip-8EQYFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:46:56 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)) 11:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:46:56 INFO - Running setup.py (path:/tmp/pip-ghPtpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:46:56 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)) 11:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:46:56 INFO - Running setup.py (path:/tmp/pip-fIkD90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:46:56 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)) 11:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:46:56 INFO - Running setup.py (path:/tmp/pip-O_Tc7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:46:56 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)) 11:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:46:56 INFO - Running setup.py (path:/tmp/pip-GTslVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:46:57 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)) 11:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:46:57 INFO - Running setup.py (path:/tmp/pip-xPSHj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:46:57 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)) 11:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:46:57 INFO - Running setup.py (path:/tmp/pip-VbIXiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:46:57 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)) 11:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:46:57 INFO - Running setup.py (path:/tmp/pip-NPxyVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:46:57 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)) 11:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:57 INFO - Running setup.py (path:/tmp/pip-aVDE7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:57 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)) 11:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:46:57 INFO - Running setup.py (path:/tmp/pip-sSp5hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:46:57 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)) 11:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:46:57 INFO - Running setup.py (path:/tmp/pip-fXH4s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:46:57 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)) 11:46:57 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)) 11:46:57 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)) 11:46:57 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)) 11:46:57 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)) 11:46:57 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)) 11:46:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:59 INFO - Downloading blessings-1.6.tar.gz 11:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:46:59 INFO - Installing collected packages: blessings 11:46:59 INFO - Running setup.py install for blessings 11:46:59 INFO - Successfully installed blessings 11:46:59 INFO - Cleaning up... 11:46:59 INFO - Return code: 0 11:46:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:46:59 INFO - Reading from file tmpfile_stdout 11:46:59 INFO - Current package versions: 11:46:59 INFO - argparse == 1.2.1 11:46:59 INFO - blessings == 1.6 11:46:59 INFO - blobuploader == 1.2.4 11:46:59 INFO - docopt == 0.6.1 11:46:59 INFO - functools32 == 3.2.3-2 11:46:59 INFO - jsonschema == 2.5.1 11:46:59 INFO - manifestparser == 1.1 11:46:59 INFO - mozInstall == 1.12 11:46:59 INFO - mozcrash == 0.17 11:46:59 INFO - mozdebug == 0.1 11:46:59 INFO - mozdevice == 0.48 11:46:59 INFO - mozfile == 1.2 11:46:59 INFO - mozhttpd == 0.7 11:46:59 INFO - mozinfo == 0.9 11:46:59 INFO - mozleak == 0.1 11:46:59 INFO - mozlog == 3.3 11:46:59 INFO - moznetwork == 0.27 11:46:59 INFO - mozprocess == 0.23 11:46:59 INFO - mozprofile == 0.28 11:46:59 INFO - mozrunner == 6.12 11:46:59 INFO - mozscreenshot == 0.1 11:46:59 INFO - mozsystemmonitor == 0.3 11:46:59 INFO - moztest == 0.7 11:46:59 INFO - mozversion == 1.4 11:46:59 INFO - psutil == 3.1.1 11:46:59 INFO - requests == 1.2.3 11:46:59 INFO - wsgiref == 0.1.2 11:46:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46: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')]} 11:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46: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')]} 11:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:59 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 0x7fb773a34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac090>, '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 0xfaf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfafe40>, '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': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', '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 11:46:59 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 11:46:59 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 11:46:59 INFO - Using env: {'DISPLAY': ':0', 11:46:59 INFO - 'HOME': '/home/cltbld', 11:46:59 INFO - 'LANG': 'en_US.UTF-8', 11:46:59 INFO - 'LANGUAGE': 'en_US:en', 11:46:59 INFO - 'LOGNAME': 'cltbld', 11:46:59 INFO - 'MAIL': '/var/mail/cltbld', 11:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:59 INFO - 'MOZ_NO_REMOTE': '1', 11:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:59 INFO - 'NO_EM_RESTART': '1', 11:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:59 INFO - 'PWD': '/builds/slave/test', 11:46:59 INFO - 'SHELL': '/bin/bash', 11:46:59 INFO - 'SHLVL': '1', 11:46:59 INFO - 'TERM': 'linux', 11:46:59 INFO - 'TMOUT': '86400', 11:46:59 INFO - 'USER': 'cltbld', 11:46:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', 11:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:59 INFO - '_': '/tools/buildbot/bin/python'} 11:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:00 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)) 11:47:00 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)) 11:47:00 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)) 11:47:00 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)) 11:47:00 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)) 11:47:00 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)) 11:47:00 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)) 11:47:00 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)) 11:47:00 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)) 11:47:00 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)) 11:47:00 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)) 11:47:00 INFO - Cleaning up... 11:47:00 INFO - Return code: 0 11:47:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb773a34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac090>, '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 0xfaf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfafe40>, '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': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', '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 11:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:47:00 INFO - Using env: {'DISPLAY': ':0', 11:47:00 INFO - 'HOME': '/home/cltbld', 11:47:00 INFO - 'LANG': 'en_US.UTF-8', 11:47:00 INFO - 'LANGUAGE': 'en_US:en', 11:47:00 INFO - 'LOGNAME': 'cltbld', 11:47:00 INFO - 'MAIL': '/var/mail/cltbld', 11:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:00 INFO - 'MOZ_NO_REMOTE': '1', 11:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:00 INFO - 'NO_EM_RESTART': '1', 11:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:00 INFO - 'PWD': '/builds/slave/test', 11:47:00 INFO - 'SHELL': '/bin/bash', 11:47:00 INFO - 'SHLVL': '1', 11:47:00 INFO - 'TERM': 'linux', 11:47:00 INFO - 'TMOUT': '86400', 11:47:00 INFO - 'USER': 'cltbld', 11:47:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', 11:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:00 INFO - '_': '/tools/buildbot/bin/python'} 11:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:47:00 INFO - Cleaning up... 11:47:00 INFO - Return code: 0 11:47:00 INFO - Running post-action listener: _resource_record_post_action 11:47:00 INFO - Running post-action listener: _start_resource_monitoring 11:47:00 INFO - Starting resource monitoring. 11:47:00 INFO - [mozharness: 2016-08-19 18:47:00.297300Z] Finished create-virtualenv step (success) 11:47:00 INFO - [mozharness: 2016-08-19 18:47:00.297868Z] Running install step. 11:47:00 INFO - Running pre-action listener: _resource_record_pre_action 11:47:00 INFO - Running main action method: install 11:47:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:00 INFO - Reading from file tmpfile_stdout 11:47:00 INFO - Detecting whether we're running mozinstall >=1.0... 11:47:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:47:00 INFO - Reading from file tmpfile_stdout 11:47:00 INFO - Output received: 11:47:00 INFO - Usage: mozinstall [options] installer 11:47:00 INFO - Options: 11:47:00 INFO - -h, --help show this help message and exit 11:47:00 INFO - -d DEST, --destination=DEST 11:47:00 INFO - Directory to install application into. [default: 11:47:00 INFO - "/builds/slave/test"] 11:47:00 INFO - --app=APP Application being installed. [default: firefox] 11:47:00 INFO - mkdir: /builds/slave/test/build/application 11:47:00 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'] 11:47:00 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 11:47:16 INFO - Reading from file tmpfile_stdout 11:47:16 INFO - Output received: 11:47:16 INFO - /builds/slave/test/build/application/firefox/firefox 11:47:16 INFO - Running post-action listener: _resource_record_post_action 11:47:16 INFO - [mozharness: 2016-08-19 18:47:16.675150Z] Finished install step (success) 11:47:16 INFO - [mozharness: 2016-08-19 18:47:16.675394Z] Running run-tests step. 11:47:16 INFO - Running pre-action listener: _resource_record_pre_action 11:47:16 INFO - Running main action method: run_tests 11:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:47:16 INFO - Python 2.7.3 11:47:16 INFO - Return code: 0 11:47:16 INFO - grabbing minidump binary from tooltool 11:47:16 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')]} 11:47:16 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 0xfac090>, '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 0xfaf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfafe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:47:16 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 11:47:16 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 11:47:16 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 11:47:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:47:16 INFO - Return code: 0 11:47:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:47:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:47:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:47:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:47:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:47:16 INFO - Using env: {'DISPLAY': ':0', 11:47:16 INFO - 'HOME': '/home/cltbld', 11:47:16 INFO - 'LANG': 'en_US.UTF-8', 11:47:16 INFO - 'LANGUAGE': 'en_US:en', 11:47:16 INFO - 'LOGNAME': 'cltbld', 11:47:16 INFO - 'MAIL': '/var/mail/cltbld', 11:47:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:47:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:16 INFO - 'MOZ_NO_REMOTE': '1', 11:47:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:16 INFO - 'NO_EM_RESTART': '1', 11:47:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:16 INFO - 'PWD': '/builds/slave/test', 11:47:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:47:16 INFO - 'SHELL': '/bin/bash', 11:47:16 INFO - 'SHLVL': '1', 11:47:16 INFO - 'TERM': 'linux', 11:47:16 INFO - 'TMOUT': '86400', 11:47:16 INFO - 'USER': 'cltbld', 11:47:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932', 11:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:16 INFO - '_': '/tools/buildbot/bin/python'} 11:47:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:47:16 INFO - mozversion application_buildid: 20160819101924 11:47:16 INFO - mozversion application_changeset: 7a6329cd8524c0c8c746d380deade176c787c235 11:47:16 INFO - mozversion application_display_name: Nightly 11:47:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:47:16 INFO - mozversion application_name: Firefox 11:47:16 INFO - mozversion application_remotingname: firefox 11:47:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:47:16 INFO - mozversion application_vendor: Mozilla 11:47:16 INFO - mozversion application_version: 51.0a1 11:47:16 INFO - mozversion platform_buildid: 20160819101924 11:47:16 INFO - mozversion platform_changeset: 7a6329cd8524c0c8c746d380deade176c787c235 11:47:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:47:16 INFO - mozversion platform_version: 51.0a1 11:47:16 INFO - using testdate: 1471632436 11:47:16 INFO - actual date: 1471632436 11:47:16 INFO - starting webserver on 'localhost:58144' 11:47:16 INFO - SUITE-START | Running 2 tests 11:47:16 INFO - TEST-START | dromaeo_css 11:47:16 INFO - operating with platform_type : linux_ 11:47:16 INFO - Initialising browser for dromaeo_css test... 11:47:16 INFO - TEST-INFO | started process 8720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkH_BJn/profile http://localhost:58144/getInfo.html) 11:47:21 INFO - PROCESS | 8720 | __metrics Screen width/height:1600/1200 11:47:21 INFO - PROCESS | 8720 | colorDepth:24 11:47:21 INFO - PROCESS | 8720 | Browser inner width/height: 1024/697 11:47:21 INFO - PROCESS | 8720 | __metrics 11:47:22 ERROR - PROCESS | 8720 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 11:47:23 INFO - TEST-INFO | 8720: exit 0 11:47:23 INFO - Browser initialized. 11:47:23 INFO - Running cycle 1/1 for dromaeo_css test... 11:47:23 INFO - TEST-INFO | started process 8839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkH_BJn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:35 INFO - PROCESS | 8839 | RSS: Main: 187039744 11:47:35 INFO - PROCESS | 8839 | 11:48:25 INFO - PROCESS | 8839 | 1471632505133 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] 11:50:37 INFO - PROCESS | 8839 | Cycle 1(1): loaded http://localhost:58144/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58144/tests/dromaeo/cssquery-ext.html) 11:50:39 INFO - PROCESS | 8839 | RSS: Main: 198553600 11:50:39 INFO - PROCESS | 8839 | 11:53:41 INFO - PROCESS | 8839 | Cycle 1(1): loaded http://localhost:58144/tests/dromaeo/cssquery-ext.html (next: http://localhost:58144/tests/dromaeo/cssquery-jquery.html) 11:53:42 INFO - PROCESS | 8839 | RSS: Main: 197353472 11:53:42 INFO - PROCESS | 8839 | 11:56:44 INFO - PROCESS | 8839 | Cycle 1(1): loaded http://localhost:58144/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58144/tests/dromaeo/cssquery-mootools.html) 11:56:44 INFO - PROCESS | 8839 | RSS: Main: 198172672 11:56:44 INFO - PROCESS | 8839 | 11:59:46 INFO - PROCESS | 8839 | Cycle 1(1): loaded http://localhost:58144/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58144/tests/dromaeo/cssquery-prototype.html) 11:59:47 INFO - PROCESS | 8839 | RSS: Main: 195858432 11:59:47 INFO - PROCESS | 8839 | 12:02:50 INFO - PROCESS | 8839 | Cycle 1(1): loaded http://localhost:58144/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58144/tests/dromaeo/cssquery-yui.html) 12:02:51 INFO - PROCESS | 8839 | RSS: Main: 198180864 12:02:51 INFO - PROCESS | 8839 | 12:05:53 INFO - PROCESS | 8839 | Cycle 1(1): loaded http://localhost:58144/tests/dromaeo/cssquery-yui.html (next: http://localhost:58144/tests/dromaeo/cssquery-dojo.html) 12:05:53 INFO - PROCESS | 8839 | RSS: Main: 198930432 12:05:53 INFO - PROCESS | 8839 | 12:05:53 INFO - PROCESS | 8839 | __start_tp_report 12:05:53 INFO - PROCESS | 8839 | _x_x_mozilla_page_load 12:05:53 INFO - PROCESS | 8839 | _x_x_mozilla_page_load_details 12:05:53 INFO - PROCESS | 8839 | |i|pagename|runs| 12:05:53 INFO - PROCESS | 8839 | |0;dojo.html;2643.1674022682855;2666.3467450474623;2674.1041751013418;2675.9197224083287;2694.2052094632095;4649.674522783406;4856.295837103622;4880.048390563841;4917.360743103396;4932.87667808305;4780.737059461728;4783.521647835215;4839.225723884179;4853.927191092136;4861.173600487917;4301.268784306675;4415.028693687384;4483.820647174109;4569.520200378962;4596.3794887690065;4558.908821823578;4560.452745670525;4576.382188404573;4588.655850811186;4591.311303304497;4309.461317335333;4378.124375124988;4408.515063343062;4427.645788336958;4484.080763443486;4400.515943246241;4436.667249956234;4450.443694538183;4458.08609235106;4471.1728330259;4428.468583769968;4456.398386217851;4479.843205487792;4480.775961201927;4490.483594386655;4750.61995040396;4781.976090119527;4810.6873053251775;4873.585745211662;4906.852794416173;5211.088059589594;5220.973895130538;5232.607554433433;5242.239875218072;5247.134222853263;5154.175331946871;5248.0553500369915;5275.920861187085;5284.81503147388;5290.947090529123;4839.104765618336;4955.876103097379;4956.256561515729;4960.280759289955;4962.8511144665;5384.246205531229;5424.891502169935;5432.185172224119;5432.375276843135;5447.564194864481;5020.322256495399;5065.670731402447;5185.533302002837;5195.870103247374;5215.29593504872;5047.343845300161;5112.565431938327;5124.743762811844;5142.357205349332;5225.555827754607;5138.511841375063;5150.690958542499;5152.201408781645;5161.896762064737;5163.432022477525;4902.436219834764;5131.025105229995;5156.690598564023;5162.561182299547;5182.378114626194;4311.935320970188;4341.110072435144;4350.32569951658;4398.406215160912;4419.359192917009;3827.8468861245237;3840.9807950960626;3845.942310865339;3845.980815083949;3846.942090925018;4377.9781101094295;4492.595666390041;4516.277395616686;4532.546745325507;4534.365188873494;5143.074246635567;5246.842594722164;5254.947450525522;5262.500062494057;5266.420693723688;4430.202563538594;4432.312991486325;4484;4487.057717879282;4490.528494508029;4558.817647294071;4576.519465456146;4674.0885527322525;4676.275177347517;4694.108119457293;4910.607151427877;4936.333594964633;4962.429320628174;4966.056449274626;4971;5252.9737351313;5259.500347466985;5263.23683065961;5267.841964741064;5271.947280527145;4808.447028591617;4857.101436234308;4876.097921884463;4935.235038569028;4961.404631444249;5181.248718935658;5194.558462530727;5197.272381866617;5202.271681964452;5208.921866172086;5251.264822924717;5261.631685781958;5262.842114736411;5264.420913699567;5289.312389389354;4828.61371090319;4956;4985.227289770091;5001.399832020181;5130.076586214517;4922.286268491121;4930.457649658463;5020.799168033238;5076.18780995039;5079.517445842639;4980;4990.50094990498;4996.400431948189;5007.39911210657;5014.899702005867;4894.95105048945;4994.875128121681;5036.546710796046;5113.4375218726655;5126.692398455955;4977.701337919591;4995.650304478651;5001.374828146481;5002.049610573979;5014.548690617716 12:05:53 INFO - PROCESS | 8839 | |1;ext.html;525.9421463639;532.1352801697242;537.5081800152859;537.6827671673711;567.9602427830054;33334.166645833866;38661.613383866155;38689.61310386896;38898.80550597243;38902.221955560875;38784;39432.60567394325;39444.21111577767;39508.80245598768;39532;7525.811854703649;7666.348360389374;7669;7679.539227646331;7681.884771728429;7642.12115606704;7679.116901556309;7724.9613751931165;7743.0708315002275;7747.457677962545;7754.728584499544;7782.416318776086;7785.143634200262;7799.922000780005;7801.882971755428;7687.923120768776;7714.884276735854;7724.7682569523;7728.922710772877;7774.416918731061;7512.098548174199;7547.28300811422;7610.353119984808;7611.429142814256;7619.428542859252;36331.09172270688;36468.63531364679;36530.8173459131;36539.451908221396;36692.44961325582;3203.263249452639;3440.535527703753;3533.6819686228364;3714.962850371489;3750.456183853326;28495;28608;28620.713792862014;28698.713012870023;29483.557746633818;3407.2844702612483;3416.0947348952545;3442.7590068695204;3470.496777967206;3502.4571191465366;250947;251697;251778;252213;252834;31009.68990310068;52179.47820521822;52297.7385113072;52580;52614;31139.688603114133;33131.3373732524;33220.16949576232;33251;33252;11997.460114294878;12240.571579994657;12264.080193985486;12275.815862762065;12282.877171228352;9513.619455221851;9597.568109435093;9608.231341492803;9608.471534065693;9611.951940240255;7713.267239612228;7748.377433849226;7817.179196184433;7827.804304892423;7846.33306168982;3028.5911401960893;3050.161205668459;3079.353335799507;3097.070878736415;3138.5919830422354;873.1835733588988;892.5225004622496;900.6712549919363;925.6204955968021;990.217727994876;27801.44397112087;28382.85808570944;28550.85724571364;28671.426571468455;28965.710342896302;887.9556022198864;972.9637935598565;1010.1968934696934;1015.5176291261739;1041.8541404203418;13946.58160255194;14531.200783956983;14685.55943321702;14983.325750341042;15113.697726045417;379849;380263;381417;382253;383578;48445.515544844806;48669.2699609499;48739.26891096636;48916.26625600619;48969.26546101811;1147.3345459633392;1186.4186548591128;1187.281694574787;1191.7199458127507;1200.2198570928792;26262.94948202127;26625.733742662327;27122.72877271202;27260.863695681393;27359.45281094407;41840.1631967365;42278.788606056776;42399.788001059795;42455.7877210612;42505.57494425016;344126;346149;347735;348095;348760;25212.24363269105;25483.10809121672;25535.744642553338;25550.23349299524;25625.82180514677;41909.79045104755;42282;42431;42733.78633106814;43394;35526.64473355233;35834;35919.28161436704;36015.45976810298;36277.27445451023;34110.317793644484;36620;36641.81679091587;36714;36858.26283474262;34065.31869362648;34363.312733744686;34853.477197841545;34991;35452.822735886155;30584.388312233186;33037.50443743394;33128.83435582903;33354.4996825043;33380.499292511115;25138;25565;25628.231153065437;25742.485150297263;25834.87082564575 12:05:53 INFO - PROCESS | 8839 | |2;jquery.html;351.79771631312;360.1428599932162;360.71143085531577;367.70950948750453;384.2334542587537;15569.688606227883;16899;17026.404075857365;17368.305267789307;17486.562835929108;14921.253937303118;14944.178070206135;14952.401903923857;15130.394784208618;15260.847391526082;4853.563179313861;5100.234964755279;5112.41207261166;5128.769205385748;5131.871703207431;3631.927361452769;4987.725675087869;5822.214001109838;6100.1154832549255;6119.479844213225;6183.690815459231;6184.652050996951;6200.968995155018;6235.875282494348;6245.094461303108;5860;6160.630362178261;6183.103449999748;6190.752369905198;6193.7832175873855;5242.501962313612;5242.81650142247;5252.448492908228;5253.684778913277;5380.730963451851;20474.488137796525;20765.480862978395;20771;20863.061162247584;21169.68245476304;1945.3191383015974;2060.474578982365;2159.7948194921455;2325.395397196724;2510.9497810043695;12435.689107772288;12678.619641410773;13548.322583870768;13578.117422367613;13722.519711810139;1694.7373157160537;1704.989910565255;1727.6976529107483;1739.5303268117536;1829.9176537055864;66174;67208.3279167207;67411.32588674099;67532.66233668849;68235;9135;9148.359614826899;9330.486823224788;9397.248220142372;9467.52662366879;11976.28142311464;11979.10156738248;12006.579769708018;12020.699482513008;12036.87963120375;6660.766873159416;6850.725970961105;7025;7094.077769889881;7111.182214045451;6519;6601.70292336846;6768.153980752406;6796.762113326109;6811.761588344384;5830.096335068071;5864.501517370986;5880.7353669085;5888.087346461305;6031.522277042152;1505.7063872544747;1600.6074714997794;1611.4521062838692;1632.4857669833964;1639.9098049607387;823.3454403749034;825.1500954017372;847.3221422861686;980.0444566547559;984.414273507262;15920.283587238602;17200.1399930003;18100.909495452437;18317.084145792924;18402.631947360976;825.6325934959006;852.2798235491;877.5831480047054;889.6308032166578;891.8350105230553;9398.859017114748;9487.810243795086;9854.753631159278;9952.552135153936;10016.098551130433;407106;409180;410613;410790;417426;76552.2344776545;78496;79603.60198198972;80001;81272;882.4793371910475;909.4539283218555;943.6508491858057;947.7820101376722;949.1789601994225;15511.922440387725;15603.921980390025;15923.124228167098;15976;16277.918610406872;36988;37526.43710344402;37689.43465848069;37749.4337584942;38239;46245;47768;48958;53664.463355365944;54045;7175.497715159889;7355.963220183865;7362.926370736224;7429.777106686592;7455.030845989987;10047.899521004696;11446.713832154262;11659.417029148679;11743.941280293544;11887.940560297144;9596.856047159437;9924.751881203028;10155.289129760846;10381.844272336071;10536.894631053898;10066.396016239049;10340.638077667245;10426;10799.298045627009;10814.89185108139;10334.121599664113;10681.198910081619;10756.139508839118;10810;10953.288036277616;7537.246275372639;7573.848523029619;7624.313811756969;7636.121845987783;7654.693812247448;5026.84919452417;9898;9976.750581235237;10096;10331.896681033093 12:05:53 INFO - PROCESS | 8839 | |3;mootools.html;1347.5351003903652;1379.5240641978517;1418.7588110021295;1609.3240838847682;1669.390672404572;6672.499562532817;7140.428765698744;7333.413326933845;7713.92286077139;7717.845643087135;7364.116306043283;7645.579493127876;7668.693252269903;7670.769876903688;7672.808179795508;2134.6371116910123;2153.6015837070113;2160.103557023833;2166.9241576544823;2170.7937745914114;2120.162535798359;2141.2291575032978;2164.2641501889357;2176.6517357222847;2190.7042549255884;2106.0838535237144;2106.6418708819538;2119.73503312086;2136.7222261106035;2138.219549864304;2116.3121985354746;2126.797954194349;2127.638301488743;2131.690904818808;2134.9786502134934;2062.05145633009;2094.853360264782;2111.4826867417582;2113.6935144403974;2123.4691327168207;7489.28851759082;7610.847783044308;7657.655405506765;7725.150233474314;7737.342325902305;4209.6421804146685;4348.369486424483;4356.281213599784;4360.171567402183;4363.3018717005125;2787.846668433235;2833.1642165561;2846.4164846206686;2900.10096869971;2919.2993681516496;863.1196179896533;918.3342076994193;919.8988111307751;920.0661328751323;922.6667465512337;9932.80134397308;9938.90061099387;9949.90050099497;10004.249681273934;10032.347897386646;3780.8109594520165;3936.2127574485216;4044.69664775143;4052.4326594276827;4117.794110294473;8539.14608539141;8556.914430855611;8644.178803013703;8648;8689.782755431164;4315.892102697395;4399.714018588781;4401.845935392246;4421.425214722066;4438.068005718836;3437.5187473753695;3858.6141385861188;3930.9803450982563;4020.638142567183;4050.5544390117066;3449.2756521130846;3476.878309259164;3585.946210806788;3610.2418492116426;3614.204874927512;1184.9822252666218;1191.5114802930757;1195.4261954262004;1201.1351826684947;1211.0372254058045;803.2529747335035;834.8645841655344;842.4987132656059;855.6577369052429;861.2119910282022;4987.501249875056;5031.295618613397;5077.035363280965;5152.381714194321;5160.225966105114;376.6252578684172;378.89390970528297;380.9657130858236;384.3619591478133;386.3682878493683;3389.457686770105;3415.077928959167;3423.4522476403654;3441.0193094967813;3495.493153492729;9076.500792456478;9237.907620923705;9317.301202409846;9340.673076442292;9365.11031452011;9223.10926260115;9306.348555601178;9320.394174378644;9328.860067098998;9345.813083738287;6645.568038077509;6883.242843287134;7131.429485641136;7221.675024623904;7231.132264128233;5102.821401250939;5241.711705856214;5257.447967963309;5264.921026184534;5373.516383525345;8100.79748006281;8457.492550446746;8701.869471958053;8777.385583009129;8779.429337093068;8345.165483451607;8358.164183581837;8542.231199192103;8867.866981995146;8897.91102088971;5743.8564035899435;6145.66198859067;6313.968430158004;6489.156409666713;6657.900131498128;7316.378107860892;7364.116306043309;7379.741709040158;7390.371818395497;7390.556566606021;6447.935520644921;6460.192475940507;6577.276499585138;6589.769358072444;6754.324567543206;6452.645104519109;6478.287388387368;6510.674466276762;6671.766488172891;6698.497612679166;5739.139129130664;5850.853728656818;5850.94149058504;5850.94149058521;5860.531157507475;4371.956280437155;4406.4051353066925;4463.7991290391365;4464.709793863389;4472.865814025585;4373.671974601854;4382.320740285261;4548.74981876;4560.931586026146;4584.312353147055 12:05:53 INFO - PROCESS | 8839 | |4;prototype.html;282.72858056265983;291.2805370734286;294.1543063691886;299.4026916301978;303.03030303030295;4979.601631869451;5021.924671129936;5050.898982020362;5072.528966599691;5076.543111119999;4971.602271818255;4977;4982.950170498294;4999.275105109757;5000.149974504334;3708.202736411671;3752.8311225994894;3861.9806900965596;3897.7271590988644;3902.043999220181;3882.320593896071;3885.61143885612;3893.6761501089622;3894.94157587635;3900.9804950975204;3880.359740642805;3886.8250928708276;3886.9222615547674;3887.3391523441082;3888.3972984187494;3787.1289603391374;3845.9807700961596;3877.673395962428;3894.785786781726;3904.511936008013;3416.436288012475;3420.9315813683834;3426.7429942754393;3428.297199074184;3434.759566830323;4832.462956947596;4833.492483289274;4877.829365932162;4878.341423907763;4893.926591101101;4427.26950053244;4437.800298986554;4447.466304043535;4457.24226881431;4465.481736209672;4888.289098815386;5174.275601415805;5186.247994040843;5205.6616319939085;5209.192575150858;3638.272345530904;3643;3643.143861192618;3643.8178091095338;3645.671889529955;5443.727813609304;5469.808556700536;5472.50747432733;5479.479449452296;5491.945080549223;3653.707703383723;3734.6638802507905;3747.6065013173225;3750.39993601028;3757.4739536464917;3806.392621054531;3824.29250588642;3827.550367764633;3828.3300422425964;3837.3668344723364;4390.143921935192;4400.415850293892;4402.075564131568;4404.185225733249;4404.8458303959205;4982.850514484571;5231.3199284092825;5267;5273.841784746463;5288.68267903927;1330.1354119822192;1334.733053389326;1334.9532766353132;1335.1922087137336;1341.3963716327692;807.8568825112518;838.8825564420864;840.7225615546855;862.5557837713583;864.5158711121666;4393.956060439418;4469.307257375112;4599;4603.217453032992;4604.102200071021;5398.406175320712;5425.430329815392;5426.131818909034;5437.864053398696;5438.8912221755345;4596.103759766814;4610;4620.283856002325;4624.537546245416;4628.166929952574;2745.4646343962736;2896.160113567084;2906.6947970462797;2909.1127206202314;2909.9272518187213;5096.311997880239;5102.897942041139;5154.871128221749;5157.4584668610005;5168.948310516922;5330.946690533123;5463.7814487420055;5568.387477377485;5580.665160090408;5583.85530966151;5043.033217045282;5049.141645920203;5053.393592768891;5076.441591424867;5086.9745651271505;5339.97081109176;5390.4879036491475;5392.406835248198;5399;5408.675479471087;5077.213031980049;5291.894162116659;5295.4969277918535;5304.9734751326;5320.457067450396;5105.31078304439;5117.923231151462;5124.846254612367;5134.717590532557;5142.562882155059;3853.4605155277723;3892.182641645173;3900.278448487039;3903.277893589695;3906.4726261954274;5090.956353947506;5326.280952071421;5336.573074153981;5403.540699040625;5409.6213265071065;5262.368515778131;5267.420583735709;5271.578273738169;5272;5272.393674727302;5247.2129180623215;5259.973700131475;5265.394479634738;5274.314339135888;5288.545649946295;5040.370224497805;5091.0581542414775;5144.511271429208;5184.755658641974;5198.8042750166915;5047.343845300087;5139.768710407966;5274.736263186902;5295.205719142159;5306.495882891119;5120.129577971828;5142.84286035654;5144.382674079135;5178.508041736029;5181.974090129676 12:05:53 INFO - PROCESS | 8839 | |5;yui.html;647.3009150117873;723.8226634474554;739.59322372695;742.4728442805608;746.238836386885;12635.305058221795;13650.45398184074;13758.656033599165;13796.586102416932;13801.585952421417;12992.025598080158;13171.275579843104;13376.531821386254;13386.263755493444;13387.531436399728;729.9562026278427;755.3768141283463;757.9772606821804;758.0524344569288;758.6813538313894;739.9926000739978;765.2118318132333;766.7469734987441;781;783.4829012851519;819.942604017719;822.8889099971517;823.9546824924627;824.5506199121463;824.8762685597148;812.9837403251961;814.3892080939296;816.2001238785964;820.0937963550281;821.0229826506468;592.8340064781825;595.3362001368487;595.7289433307834;596.1713218626113;596.3142386255797;13248.86751132486;13272.535461258809;13288.136271142344;13426.32868356588;13493.190408575518;12555.93722031384;12924.612261632072;13079.607611771662;13147.14543554666;13575.049746517649;9710.90289097107;10928.672139835817;10976.506057227443;11417.828732568934;11818.586349477728;4147.108371700068;4153.190127925056;4161.75029498228;4179.373094035919;4187.497500299953;57640;58024.12963805546;58151.41848581545;58214.70892645552;58281.417185828446;9426.717198484057;9472.147506724428;9985.760145276283;10140.898591014144;10203.897961020442;18523.166457509444;19295.8070419294;19322.227110915406;19356.806431935784;19367.515812104528;7027.227005029443;7036.718531258693;7195.96402017997;7271.236520165412;7329.9267007329245;3737.8691745788765;3751.718621103428;3767.6232376762105;3801.961980380216;3847.5190601174854;2877.108096490095;2998.970010299869;3003.3993201359817;3007.8646460909313;3008.2028262510453;487.4418790484875;494.6463278755707;505.60057554531505;514.8198130654316;518.5592246590444;553.3553410276983;572.1732097119623;579.325086274494;591.361329763854;598.6228675934134;7687.961560192163;7982.321502672222;8406.789830254293;8409.873851892227;8480.321574274043;516.5970542976485;528.9894202115936;530.3582664975423;538.4749868877891;539.7786907367961;3727.1613886875234;3850.8459661613783;4039.5758445362812;4065.9390109148385;4098;50039.749801250764;52495.212571811455;82982;91184.08815911756;107350;83044.58477707572;86358;86961.13038869656;89311.55344223237;90510.54744726235;45130.77434612872;57667.71166144226;73669.63165184247;74496.62751686206;75038;7525.435592330707;7536.472446928662;7612.238776122344;7716.7684969451;7728.613569321399;46285.76857115693;46823.29765053459;46962.530374697184;47667.76166119147;48273.517264828304;65305.34694652993;69521.30478695148;70162.29837701557;70426.29573704198;74286.88528687098;9085.909140908507;9237.722868313962;9281.211097056826;9370.938393553408;9477.573509192242;11383.146264030396;11509.654710358702;11517.193796434169;11522;12065.577704780291;9863.556139973574;10032.448215348226;10222.795544088927;10224.488775561342;10471;9292.814143717223;9410.858837117312;9463.621455141718;9682.9031709682;9713.562889670124;10042.297039207186;10415.531301091318;10631.308964917256;10730.785384292114;10994.28537145083;8201.589920503831;8499.065102838806;8594.871076933976;8915.108489151033;9342.766430839283;8849.69026084084;10219.489025548544;10402.11582015507;10456.32033917793;10493.108085812792 12:05:53 INFO - PROCESS | 8839 | __end_tp_report 12:05:53 INFO - PROCESS | 8839 | __start_cc_report 12:05:53 INFO - PROCESS | 8839 | _x_x_mozilla_cycle_collect,381 12:05:53 INFO - PROCESS | 8839 | __end_cc_report 12:05:53 INFO - PROCESS | 8839 | __startTimestamp1471633553765__endTimestamp 12:05:53 INFO - PROCESS | 8839 | 12:05:53 INFO - PROCESS | 8839 | ------- Summary: start ------- 12:05:53 INFO - PROCESS | 8839 | Number of tests: 6 12:05:53 INFO - PROCESS | 8839 | 12:05:53 INFO - PROCESS | 8839 | [#0] dojo.html Cycles:165 Average:4803.20 Median:4955.88 stddev:517.43 (10.4%) stddev-sans-first:490.49 12:05:53 INFO - PROCESS | 8839 | Values: 2643.2 2666.3 2674.1 2675.9 2694.2 4649.7 4856.3 4880.0 4917.4 4932.9 4780.7 4783.5 4839.2 4853.9 4861.2 4301.3 4415.0 4483.8 4569.5 4596.4 4558.9 4560.5 4576.4 4588.7 4591.3 4309.5 4378.1 4408.5 4427.6 4484.1 4400.5 4436.7 4450.4 4458.1 4471.2 4428.5 4456.4 4479.8 4480.8 4490.5 4750.6 4782.0 4810.7 4873.6 4906.9 5211.1 5221.0 5232.6 5242.2 5247.1 5154.2 5248.1 5275.9 5284.8 5290.9 4839.1 4955.9 4956.3 4960.3 4962.9 5384.2 5424.9 5432.2 5432.4 5447.6 5020.3 5065.7 5185.5 5195.9 5215.3 5047.3 5112.6 5124.7 5142.4 5225.6 5138.5 5150.7 5152.2 5161.9 5163.4 4902.4 5131.0 5156.7 5162.6 5182.4 4311.9 4341.1 4350.3 4398.4 4419.4 3827.8 3841.0 3845.9 3846.0 3846.9 4378.0 4492.6 4516.3 4532.5 4534.4 5143.1 5246.8 5254.9 5262.5 5266.4 4430.2 4432.3 4484.0 4487.1 4490.5 4558.8 4576.5 4674.1 4676.3 4694.1 4910.6 4936.3 4962.4 4966.1 4971.0 5253.0 5259.5 5263.2 5267.8 5271.9 4808.4 4857.1 4876.1 4935.2 4961.4 5181.2 5194.6 5197.3 5202.3 5208.9 5251.3 5261.6 5262.8 5264.4 5289.3 4828.6 4956.0 4985.2 5001.4 5130.1 4922.3 4930.5 5020.8 5076.2 5079.5 4980.0 4990.5 4996.4 5007.4 5014.9 4895.0 4994.9 5036.5 5113.4 5126.7 4977.7 4995.7 5001.4 5002.0 5014.5 12:05:53 INFO - PROCESS | 8839 | 12:05:53 INFO - PROCESS | 8839 | [#1] ext.html Cycles:180 Average:46654.85 Median:36499.73 stddev:87509.38 (239.8%) stddev-sans-first:87686.33 12:05:53 INFO - PROCESS | 8839 | Values: 525.9 532.1 537.5 537.7 568.0 33334.2 38661.6 38689.6 38898.8 38902.2 38784.0 39432.6 39444.2 39508.8 39532.0 7525.8 7666.3 7669.0 7679.5 7681.9 7642.1 7679.1 7725.0 7743.1 7747.5 7754.7 7782.4 7785.1 7799.9 7801.9 7687.9 7714.9 7724.8 7728.9 7774.4 7512.1 7547.3 7610.4 7611.4 7619.4 36331.1 36468.6 36530.8 36539.5 36692.4 3203.3 3440.5 3533.7 3715.0 3750.5 28495.0 28608.0 28620.7 28698.7 29483.6 3407.3 3416.1 3442.8 3470.5 3502.5 250947.0 251697.0 251778.0 252213.0 252834.0 31009.7 52179.5 52297.7 52580.0 52614.0 31139.7 33131.3 33220.2 33251.0 33252.0 11997.5 12240.6 12264.1 12275.8 12282.9 9513.6 9597.6 9608.2 9608.5 9612.0 7713.3 7748.4 7817.2 7827.8 7846.3 3028.6 3050.2 3079.4 3097.1 3138.6 873.2 892.5 900.7 925.6 990.2 27801.4 28382.9 28550.9 28671.4 28965.7 888.0 973.0 1010.2 1015.5 1041.9 13946.6 14531.2 14685.6 14983.3 15113.7 379849.0 380263.0 381417.0 382253.0 383578.0 48445.5 48669.3 48739.3 48916.3 48969.3 1147.3 1186.4 1187.3 1191.7 1200.2 26262.9 26625.7 27122.7 27260.9 27359.5 41840.2 42278.8 42399.8 42455.8 42505.6 344126.0 346149.0 347735.0 348095.0 348760.0 25212.2 25483.1 25535.7 25550.2 25625.8 41909.8 42282.0 42431.0 42733.8 43394.0 35526.6 35834.0 35919.3 36015.5 36277.3 34110.3 36620.0 36641.8 36714.0 36858.3 34065.3 34363.3 34853.5 34991.0 35452.8 30584.4 33037.5 33128.8 33354.5 33380.5 25138.0 25565.0 25628.2 25742.5 25834.9 12:05:53 INFO - PROCESS | 8839 | 12:05:53 INFO - PROCESS | 8839 | [#2] jquery.html Cycles:180 Average:24959.21 Median:26972.86 stddev:67730.71 (251.1%) stddev-sans-first:67895.51 12:05:53 INFO - PROCESS | 8839 | Values: 351.8 360.1 360.7 367.7 384.2 15569.7 16899.0 17026.4 17368.3 17486.6 14921.3 14944.2 14952.4 15130.4 15260.8 4853.6 5100.2 5112.4 5128.8 5131.9 3631.9 4987.7 5822.2 6100.1 6119.5 6183.7 6184.7 6201.0 6235.9 6245.1 5860.0 6160.6 6183.1 6190.8 6193.8 5242.5 5242.8 5252.4 5253.7 5380.7 20474.5 20765.5 20771.0 20863.1 21169.7 1945.3 2060.5 2159.8 2325.4 2510.9 12435.7 12678.6 13548.3 13578.1 13722.5 1694.7 1705.0 1727.7 1739.5 1829.9 66174.0 67208.3 67411.3 67532.7 68235.0 9135.0 9148.4 9330.5 9397.2 9467.5 11976.3 11979.1 12006.6 12020.7 12036.9 6660.8 6850.7 7025.0 7094.1 7111.2 6519.0 6601.7 6768.2 6796.8 6811.8 5830.1 5864.5 5880.7 5888.1 6031.5 1505.7 1600.6 1611.5 1632.5 1639.9 823.3 825.2 847.3 980.0 984.4 15920.3 17200.1 18100.9 18317.1 18402.6 825.6 852.3 877.6 889.6 891.8 9398.9 9487.8 9854.8 9952.6 10016.1 407106.0 409180.0 410613.0 410790.0 417426.0 76552.2 78496.0 79603.6 80001.0 81272.0 882.5 909.5 943.7 947.8 949.2 15511.9 15603.9 15923.1 15976.0 16277.9 36988.0 37526.4 37689.4 37749.4 38239.0 46245.0 47768.0 48958.0 53664.5 54045.0 7175.5 7356.0 7362.9 7429.8 7455.0 10047.9 11446.7 11659.4 11743.9 11887.9 9596.9 9924.8 10155.3 10381.8 10536.9 10066.4 10340.6 10426.0 10799.3 10814.9 10334.1 10681.2 10756.1 10810.0 10953.3 7537.2 7573.8 7624.3 7636.1 7654.7 5026.8 9898.0 9976.8 10096.0 10331.9 12:05:53 INFO - PROCESS | 8839 | 12:05:53 INFO - PROCESS | 8839 | [#3] mootools.html Cycles:180 Average:4934.69 Median:5127.60 stddev:2761.17 (53.8%) stddev-sans-first:2755.75 12:05:53 INFO - PROCESS | 8839 | Values: 1347.5 1379.5 1418.8 1609.3 1669.4 6672.5 7140.4 7333.4 7713.9 7717.8 7364.1 7645.6 7668.7 7670.8 7672.8 2134.6 2153.6 2160.1 2166.9 2170.8 2120.2 2141.2 2164.3 2176.7 2190.7 2106.1 2106.6 2119.7 2136.7 2138.2 2116.3 2126.8 2127.6 2131.7 2135.0 2062.1 2094.9 2111.5 2113.7 2123.5 7489.3 7610.8 7657.7 7725.2 7737.3 4209.6 4348.4 4356.3 4360.2 4363.3 2787.8 2833.2 2846.4 2900.1 2919.3 863.1 918.3 919.9 920.1 922.7 9932.8 9938.9 9949.9 10004.2 10032.3 3780.8 3936.2 4044.7 4052.4 4117.8 8539.1 8556.9 8644.2 8648.0 8689.8 4315.9 4399.7 4401.8 4421.4 4438.1 3437.5 3858.6 3931.0 4020.6 4050.6 3449.3 3476.9 3585.9 3610.2 3614.2 1185.0 1191.5 1195.4 1201.1 1211.0 803.3 834.9 842.5 855.7 861.2 4987.5 5031.3 5077.0 5152.4 5160.2 376.6 378.9 381.0 384.4 386.4 3389.5 3415.1 3423.5 3441.0 3495.5 9076.5 9237.9 9317.3 9340.7 9365.1 9223.1 9306.3 9320.4 9328.9 9345.8 6645.6 6883.2 7131.4 7221.7 7231.1 5102.8 5241.7 5257.4 5264.9 5373.5 8100.8 8457.5 8701.9 8777.4 8779.4 8345.2 8358.2 8542.2 8867.9 8897.9 5743.9 6145.7 6314.0 6489.2 6657.9 7316.4 7364.1 7379.7 7390.4 7390.6 6447.9 6460.2 6577.3 6589.8 6754.3 6452.6 6478.3 6510.7 6671.8 6698.5 5739.1 5850.9 5850.9 5850.9 5860.5 4372.0 4406.4 4463.8 4464.7 4472.9 4373.7 4382.3 4548.7 4560.9 4584.3 12:05:53 INFO - PROCESS | 8839 | 12:05:53 INFO - PROCESS | 8839 | [#4] prototype.html Cycles:180 Average:4340.79 Median:4991.11 stddev:1271.55 (25.5%) stddev-sans-first:1238.10 12:05:53 INFO - PROCESS | 8839 | Values: 282.7 291.3 294.2 299.4 303.0 4979.6 5021.9 5050.9 5072.5 5076.5 4971.6 4977.0 4983.0 4999.3 5000.1 3708.2 3752.8 3862.0 3897.7 3902.0 3882.3 3885.6 3893.7 3894.9 3901.0 3880.4 3886.8 3886.9 3887.3 3888.4 3787.1 3846.0 3877.7 3894.8 3904.5 3416.4 3420.9 3426.7 3428.3 3434.8 4832.5 4833.5 4877.8 4878.3 4893.9 4427.3 4437.8 4447.5 4457.2 4465.5 4888.3 5174.3 5186.2 5205.7 5209.2 3638.3 3643.0 3643.1 3643.8 3645.7 5443.7 5469.8 5472.5 5479.5 5491.9 3653.7 3734.7 3747.6 3750.4 3757.5 3806.4 3824.3 3827.6 3828.3 3837.4 4390.1 4400.4 4402.1 4404.2 4404.8 4982.9 5231.3 5267.0 5273.8 5288.7 1330.1 1334.7 1335.0 1335.2 1341.4 807.9 838.9 840.7 862.6 864.5 4394.0 4469.3 4599.0 4603.2 4604.1 5398.4 5425.4 5426.1 5437.9 5438.9 4596.1 4610.0 4620.3 4624.5 4628.2 2745.5 2896.2 2906.7 2909.1 2909.9 5096.3 5102.9 5154.9 5157.5 5168.9 5330.9 5463.8 5568.4 5580.7 5583.9 5043.0 5049.1 5053.4 5076.4 5087.0 5340.0 5390.5 5392.4 5399.0 5408.7 5077.2 5291.9 5295.5 5305.0 5320.5 5105.3 5117.9 5124.8 5134.7 5142.6 3853.5 3892.2 3900.3 3903.3 3906.5 5091.0 5326.3 5336.6 5403.5 5409.6 5262.4 5267.4 5271.6 5272.0 5272.4 5247.2 5260.0 5265.4 5274.3 5288.5 5040.4 5091.1 5144.5 5184.8 5198.8 5047.3 5139.8 5274.7 5295.2 5306.5 5120.1 5142.8 5144.4 5178.5 5182.0 12:05:53 INFO - PROCESS | 8839 | 12:05:53 INFO - PROCESS | 8839 | [#5] yui.html Cycles:180 Average:16986.68 Median:57653.86 stddev:24078.06 (41.8%) stddev-sans-first:24114.34 12:05:53 INFO - PROCESS | 8839 | Values: 647.3 723.8 739.6 742.5 746.2 12635.3 13650.5 13758.7 13796.6 13801.6 12992.0 13171.3 13376.5 13386.3 13387.5 730.0 755.4 758.0 758.1 758.7 740.0 765.2 766.7 781.0 783.5 819.9 822.9 824.0 824.6 824.9 813.0 814.4 816.2 820.1 821.0 592.8 595.3 595.7 596.2 596.3 13248.9 13272.5 13288.1 13426.3 13493.2 12555.9 12924.6 13079.6 13147.1 13575.0 9710.9 10928.7 10976.5 11417.8 11818.6 4147.1 4153.2 4161.8 4179.4 4187.5 57640.0 58024.1 58151.4 58214.7 58281.4 9426.7 9472.1 9985.8 10140.9 10203.9 18523.2 19295.8 19322.2 19356.8 19367.5 7027.2 7036.7 7196.0 7271.2 7329.9 3737.9 3751.7 3767.6 3802.0 3847.5 2877.1 2999.0 3003.4 3007.9 3008.2 487.4 494.6 505.6 514.8 518.6 553.4 572.2 579.3 591.4 598.6 7688.0 7982.3 8406.8 8409.9 8480.3 516.6 529.0 530.4 538.5 539.8 3727.2 3850.8 4039.6 4065.9 4098.0 50039.7 52495.2 82982.0 91184.1 107350.0 83044.6 86358.0 86961.1 89311.6 90510.5 45130.8 57667.7 73669.6 74496.6 75038.0 7525.4 7536.5 7612.2 7716.8 7728.6 46285.8 46823.3 46962.5 47667.8 48273.5 65305.3 69521.3 70162.3 70426.3 74286.9 9085.9 9237.7 9281.2 9370.9 9477.6 11383.1 11509.7 11517.2 11522.0 12065.6 9863.6 10032.4 10222.8 10224.5 10471.0 9292.8 9410.9 9463.6 9682.9 9713.6 10042.3 10415.5 10631.3 10730.8 10994.3 8201.6 8499.1 8594.9 8915.1 9342.8 8849.7 10219.5 10402.1 10456.3 10493.1 12:05:53 INFO - PROCESS | 8839 | -------- Summary: end -------- 12:05:53 INFO - PROCESS | 8839 | 12:05:54 INFO - TEST-INFO | 8839: exit 0 12:05:54 INFO - TEST-OK | dromaeo_css | took 1117789ms 12:05:54 INFO - TEST-START | kraken 12:05:54 INFO - operating with platform_type : linux_ 12:05:54 INFO - Initialising browser for kraken test... 12:05:54 INFO - TEST-INFO | started process 9196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBV7MPh/profile http://localhost:58144/getInfo.html) 12:05:59 INFO - PROCESS | 9196 | __metrics Screen width/height:1600/1200 12:05:59 INFO - PROCESS | 9196 | colorDepth:24 12:05:59 INFO - PROCESS | 9196 | Browser inner width/height: 1024/697 12:05:59 INFO - PROCESS | 9196 | __metrics 12:05:59 ERROR - PROCESS | 9196 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 12:06:00 INFO - TEST-INFO | 9196: exit 0 12:06:00 INFO - Browser initialized. 12:06:00 INFO - Running cycle 1/1 for kraken test... 12:06:00 INFO - TEST-INFO | started process 9315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBV7MPh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:12 INFO - PROCESS | 9315 | RSS: Main: 186765312 12:06:12 INFO - PROCESS | 9315 | 12:06:15 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58144/tests/kraken/driver.html?testName=audio-beat-detection) 12:06:16 INFO - PROCESS | 9315 | RSS: Main: 199917568 12:06:16 INFO - PROCESS | 9315 | 12:06:19 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58144/tests/kraken/driver.html?testName=audio-dft) 12:06:20 INFO - PROCESS | 9315 | RSS: Main: 198778880 12:06:20 INFO - PROCESS | 9315 | 12:06:23 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58144/tests/kraken/driver.html?testName=audio-fft) 12:06:23 INFO - PROCESS | 9315 | RSS: Main: 194772992 12:06:23 INFO - PROCESS | 9315 | 12:06:26 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58144/tests/kraken/driver.html?testName=audio-oscillator) 12:06:26 INFO - PROCESS | 9315 | RSS: Main: 195600384 12:06:26 INFO - PROCESS | 9315 | 12:06:28 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58144/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:06:29 INFO - PROCESS | 9315 | RSS: Main: 196268032 12:06:29 INFO - PROCESS | 9315 | 12:06:32 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58144/tests/kraken/driver.html?testName=imaging-darkroom) 12:06:33 INFO - PROCESS | 9315 | RSS: Main: 196435968 12:06:33 INFO - PROCESS | 9315 | 12:06:37 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58144/tests/kraken/driver.html?testName=imaging-desaturate) 12:06:37 INFO - PROCESS | 9315 | RSS: Main: 193294336 12:06:37 INFO - PROCESS | 9315 | 12:06:40 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58144/tests/kraken/driver.html?testName=json-parse-financial) 12:06:41 INFO - PROCESS | 9315 | RSS: Main: 195231744 12:06:41 INFO - PROCESS | 9315 | 12:06:43 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58144/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:06:43 INFO - PROCESS | 9315 | RSS: Main: 195477504 12:06:43 INFO - PROCESS | 9315 | 12:06:45 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58144/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:06:46 INFO - PROCESS | 9315 | RSS: Main: 195575808 12:06:46 INFO - PROCESS | 9315 | 12:06:48 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58144/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:06:49 INFO - PROCESS | 9315 | RSS: Main: 195608576 12:06:49 INFO - PROCESS | 9315 | 12:06:52 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:06:53 INFO - PROCESS | 9315 | RSS: Main: 196120576 12:06:53 INFO - PROCESS | 9315 | 12:06:56 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:06:56 INFO - PROCESS | 9315 | RSS: Main: 196050944 12:06:56 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | Cycle 1(1): loaded http://localhost:58144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58144/tests/kraken/driver.html?testName=ai-astar) 12:06:58 INFO - PROCESS | 9315 | RSS: Main: 197939200 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | __start_tp_report 12:06:58 INFO - PROCESS | 9315 | _x_x_mozilla_page_load 12:06:58 INFO - PROCESS | 9315 | _x_x_mozilla_page_load_details 12:06:58 INFO - PROCESS | 9315 | |i|pagename|runs| 12:06:58 INFO - PROCESS | 9315 | |0;ai-astar;108;118;115;117;118;117;124;117;116;117 12:06:58 INFO - PROCESS | 9315 | |1;audio-beat-detection;160;125;147;180;133;157;149;132;192;128 12:06:58 INFO - PROCESS | 9315 | |2;audio-dft;173;171;164;165;165;164;163;165;164;165 12:06:58 INFO - PROCESS | 9315 | |3;audio-fft;78;78;77;184;80;80;77;77;160;81 12:06:58 INFO - PROCESS | 9315 | |4;audio-oscillator;88;87;141;91;94;88;138;87;93;137 12:06:58 INFO - PROCESS | 9315 | |5;imaging-gaussian-blur;117;120;118;119;120;125;125;118;119;118 12:06:58 INFO - PROCESS | 9315 | |6;imaging-darkroom;148;148;148;150;149;151;149;149;149;151 12:06:58 INFO - PROCESS | 9315 | |7;imaging-desaturate;96;97;95;95;96;96;97;96;96;96 12:06:58 INFO - PROCESS | 9315 | |8;json-parse-financial;68;66;65;65;65;66;66;64;67;67 12:06:58 INFO - PROCESS | 9315 | |9;json-stringify-tinderbox;67;68;71;71;69;82;69;68;69;69 12:06:58 INFO - PROCESS | 9315 | |10;stanford-crypto-aes;87;88;86;85;84;88;84;81;95;89 12:06:58 INFO - PROCESS | 9315 | |11;stanford-crypto-ccm;151;138;145;139;163;148;138;149;167;152 12:06:58 INFO - PROCESS | 9315 | |12;stanford-crypto-pbkdf2;178;183;179;186;179;177;183;178;178;180 12:06:58 INFO - PROCESS | 9315 | |13;stanford-crypto-sha256-iterative;71;76;70;70;72;71;73;72;75;72 12:06:58 INFO - PROCESS | 9315 | __end_tp_report 12:06:58 INFO - PROCESS | 9315 | __start_cc_report 12:06:58 INFO - PROCESS | 9315 | _x_x_mozilla_cycle_collect,942 12:06:58 INFO - PROCESS | 9315 | __end_cc_report 12:06:58 INFO - PROCESS | 9315 | __startTimestamp1471633618770__endTimestamp 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | ------- Summary: start ------- 12:06:58 INFO - PROCESS | 9315 | Number of tests: 14 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#0] ai-astar Cycles:10 Average:116.70 Median:117.00 stddev:3.89 (3.3%) stddev-sans-first:2.55 12:06:58 INFO - PROCESS | 9315 | Values: 108.0 118.0 115.0 117.0 118.0 117.0 124.0 117.0 116.0 117.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:153.00 stddev:22.47 (14.7%) stddev-sans-first:23.56 12:06:58 INFO - PROCESS | 9315 | Values: 160.0 125.0 147.0 180.0 133.0 157.0 149.0 132.0 192.0 128.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.00 stddev:3.31 (2.0%) stddev-sans-first:2.32 12:06:58 INFO - PROCESS | 9315 | Values: 173.0 171.0 164.0 165.0 165.0 164.0 163.0 165.0 164.0 165.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#3] audio-fft Cycles:10 Average:97.20 Median:78.00 stddev:39.85 (51.1%) stddev-sans-first:41.66 12:06:58 INFO - PROCESS | 9315 | Values: 78.0 78.0 77.0 184.0 80.0 80.0 77.0 77.0 160.0 81.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:88.00 stddev:23.79 (27.0%) stddev-sans-first:24.48 12:06:58 INFO - PROCESS | 9315 | Values: 88.0 87.0 141.0 91.0 94.0 88.0 138.0 87.0 93.0 137.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#5] imaging-gaussian-blur Cycles:10 Average:119.90 Median:119.50 stddev:2.85 (2.4%) stddev-sans-first:2.82 12:06:58 INFO - PROCESS | 9315 | Values: 117.0 120.0 118.0 119.0 120.0 125.0 125.0 118.0 119.0 118.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:1.14 (0.8%) stddev-sans-first:1.12 12:06:58 INFO - PROCESS | 9315 | Values: 148.0 148.0 148.0 150.0 149.0 151.0 149.0 149.0 149.0 151.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:06:58 INFO - PROCESS | 9315 | Values: 96.0 97.0 95.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.00 12:06:58 INFO - PROCESS | 9315 | Values: 68.0 66.0 65.0 65.0 65.0 66.0 66.0 64.0 67.0 67.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:69.00 stddev:4.30 (6.2%) stddev-sans-first:4.39 12:06:58 INFO - PROCESS | 9315 | Values: 67.0 68.0 71.0 71.0 69.0 82.0 69.0 68.0 69.0 69.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.50 stddev:3.77 (4.3%) stddev-sans-first:4.00 12:06:58 INFO - PROCESS | 9315 | Values: 87.0 88.0 86.0 85.0 84.0 88.0 84.0 81.0 95.0 89.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:150.00 stddev:9.96 (6.6%) stddev-sans-first:10.53 12:06:58 INFO - PROCESS | 9315 | Values: 151.0 138.0 145.0 139.0 163.0 148.0 138.0 149.0 167.0 152.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:179.50 stddev:2.92 (1.6%) stddev-sans-first:3.00 12:06:58 INFO - PROCESS | 9315 | Values: 178.0 183.0 179.0 186.0 179.0 177.0 183.0 178.0 178.0 180.0 12:06:58 INFO - PROCESS | 9315 | 12:06:58 INFO - PROCESS | 9315 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.00 stddev:1.99 (2.8%) stddev-sans-first:2.06 12:06:58 INFO - PROCESS | 9315 | Values: 71.0 76.0 70.0 70.0 72.0 71.0 73.0 72.0 75.0 72.0 12:06:58 INFO - PROCESS | 9315 | -------- Summary: end -------- 12:06:58 INFO - PROCESS | 9315 | 12:06:59 INFO - TEST-INFO | 9315: exit 0 12:06:59 INFO - TEST-OK | kraken | took 65231ms 12:06:59 INFO - SUITE-END | took 1183s 12:07:00 INFO - Completed test suite (00:19:43) 12:07:00 INFO - javascript benchmark 12:07:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6322.962937508079, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2643.1674022682855, 2666.3467450474623, 2674.1041751013418, 2675.9197224083287, 2694.2052094632095, 4649.674522783406, 4856.295837103622, 4880.048390563841, 4917.360743103396, 4932.87667808305, 4780.737059461728, 4783.521647835215, 4839.225723884179, 4853.927191092136, 4861.173600487917, 4301.268784306675, 4415.028693687384, 4483.820647174109, 4569.520200378962, 4596.3794887690065, 4558.908821823578, 4560.452745670525, 4576.382188404573, 4588.655850811186, 4591.311303304497, 4309.461317335333, 4378.124375124988, 4408.515063343062, 4427.645788336958, 4484.080763443486, 4400.515943246241, 4436.667249956234, 4450.443694538183, 4458.08609235106, 4471.1728330259, 4428.468583769968, 4456.398386217851, 4479.843205487792, 4480.775961201927, 4490.483594386655, 4750.61995040396, 4781.976090119527, 4810.6873053251775, 4873.585745211662, 4906.852794416173, 5211.088059589594, 5220.973895130538, 5232.607554433433, 5242.239875218072, 5247.134222853263, 5154.175331946871, 5248.0553500369915, 5275.920861187085, 5284.81503147388, 5290.947090529123, 4839.104765618336, 4955.876103097379, 4956.256561515729, 4960.280759289955, 4962.8511144665, 5384.246205531229, 5424.891502169935, 5432.185172224119, 5432.375276843135, 5447.564194864481, 5020.322256495399, 5065.670731402447, 5185.533302002837, 5195.870103247374, 5215.29593504872, 5047.343845300161, 5112.565431938327, 5124.743762811844, 5142.357205349332, 5225.555827754607, 5138.511841375063, 5150.690958542499, 5152.201408781645, 5161.896762064737, 5163.432022477525, 4902.436219834764, 5131.025105229995, 5156.690598564023, 5162.561182299547, 5182.378114626194, 4311.935320970188, 4341.110072435144, 4350.32569951658, 4398.406215160912, 4419.359192917009, 3827.8468861245237, 3840.9807950960626, 3845.942310865339, 3845.980815083949, 3846.942090925018, 4377.9781101094295, 4492.595666390041, 4516.277395616686, 4532.546745325507, 4534.365188873494, 5143.074246635567, 5246.842594722164, 5254.947450525522, 5262.500062494057, 5266.420693723688, 4430.202563538594, 4432.312991486325, 4484.0, 4487.057717879282, 4490.528494508029, 4558.817647294071, 4576.519465456146, 4674.0885527322525, 4676.275177347517, 4694.108119457293, 4910.607151427877, 4936.333594964633, 4962.429320628174, 4966.056449274626, 4971.0, 5252.9737351313, 5259.500347466985, 5263.23683065961, 5267.841964741064, 5271.947280527145, 4808.447028591617, 4857.101436234308, 4876.097921884463, 4935.235038569028, 4961.404631444249, 5181.248718935658, 5194.558462530727, 5197.272381866617, 5202.271681964452, 5208.921866172086, 5251.264822924717, 5261.631685781958, 5262.842114736411, 5264.420913699567, 5289.312389389354, 4828.61371090319, 4956.0, 4985.227289770091, 5001.399832020181, 5130.076586214517, 4922.286268491121, 4930.457649658463, 5020.799168033238, 5076.18780995039, 5079.517445842639, 4980.0, 4990.50094990498, 4996.400431948189, 5007.39911210657, 5014.899702005867, 4894.95105048945, 4994.875128121681, 5036.546710796046, 5113.4375218726655, 5126.692398455955, 4977.701337919591, 4995.650304478651, 5001.374828146481, 5002.049610573979, 5014.548690617716], "value": 4769.21302830986, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.9421463639, 532.1352801697242, 537.5081800152859, 537.6827671673711, 567.9602427830054, 33334.166645833866, 38661.613383866155, 38689.61310386896, 38898.80550597243, 38902.221955560875, 38784.0, 39432.60567394325, 39444.21111577767, 39508.80245598768, 39532.0, 7525.811854703649, 7666.348360389374, 7669.0, 7679.539227646331, 7681.884771728429, 7642.12115606704, 7679.116901556309, 7724.9613751931165, 7743.0708315002275, 7747.457677962545, 7754.728584499544, 7782.416318776086, 7785.143634200262, 7799.922000780005, 7801.882971755428, 7687.923120768776, 7714.884276735854, 7724.7682569523, 7728.922710772877, 7774.416918731061, 7512.098548174199, 7547.28300811422, 7610.353119984808, 7611.429142814256, 7619.428542859252, 36331.09172270688, 36468.63531364679, 36530.8173459131, 36539.451908221396, 36692.44961325582, 3203.263249452639, 3440.535527703753, 3533.6819686228364, 3714.962850371489, 3750.456183853326, 28495.0, 28608.0, 28620.713792862014, 28698.713012870023, 29483.557746633818, 3407.2844702612483, 3416.0947348952545, 3442.7590068695204, 3470.496777967206, 3502.4571191465366, 250947.0, 251697.0, 251778.0, 252213.0, 252834.0, 31009.68990310068, 52179.47820521822, 52297.7385113072, 52580.0, 52614.0, 31139.688603114133, 33131.3373732524, 33220.16949576232, 33251.0, 33252.0, 11997.460114294878, 12240.571579994657, 12264.080193985486, 12275.815862762065, 12282.877171228352, 9513.619455221851, 9597.568109435093, 9608.231341492803, 9608.471534065693, 9611.951940240255, 7713.267239612228, 7748.377433849226, 7817.179196184433, 7827.804304892423, 7846.33306168982, 3028.5911401960893, 3050.161205668459, 3079.353335799507, 3097.070878736415, 3138.5919830422354, 873.1835733588988, 892.5225004622496, 900.6712549919363, 925.6204955968021, 990.217727994876, 27801.44397112087, 28382.85808570944, 28550.85724571364, 28671.426571468455, 28965.710342896302, 887.9556022198864, 972.9637935598565, 1010.1968934696934, 1015.5176291261739, 1041.8541404203418, 13946.58160255194, 14531.200783956983, 14685.55943321702, 14983.325750341042, 15113.697726045417, 379849.0, 380263.0, 381417.0, 382253.0, 383578.0, 48445.515544844806, 48669.2699609499, 48739.26891096636, 48916.26625600619, 48969.26546101811, 1147.3345459633392, 1186.4186548591128, 1187.281694574787, 1191.7199458127507, 1200.2198570928792, 26262.94948202127, 26625.733742662327, 27122.72877271202, 27260.863695681393, 27359.45281094407, 41840.1631967365, 42278.788606056776, 42399.788001059795, 42455.7877210612, 42505.57494425016, 344126.0, 346149.0, 347735.0, 348095.0, 348760.0, 25212.24363269105, 25483.10809121672, 25535.744642553338, 25550.23349299524, 25625.82180514677, 41909.79045104755, 42282.0, 42431.0, 42733.78633106814, 43394.0, 35526.64473355233, 35834.0, 35919.28161436704, 36015.45976810298, 36277.27445451023, 34110.317793644484, 36620.0, 36641.81679091587, 36714.0, 36858.26283474262, 34065.31869362648, 34363.312733744686, 34853.477197841545, 34991.0, 35452.822735886155, 30584.388312233186, 33037.50443743394, 33128.83435582903, 33354.4996825043, 33380.499292511115, 25138.0, 25565.0, 25628.231153065437, 25742.485150297263, 25834.87082564575], "value": 16277.657599087932, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.79771631312, 360.1428599932162, 360.71143085531577, 367.70950948750453, 384.2334542587537, 15569.688606227883, 16899.0, 17026.404075857365, 17368.305267789307, 17486.562835929108, 14921.253937303118, 14944.178070206135, 14952.401903923857, 15130.394784208618, 15260.847391526082, 4853.563179313861, 5100.234964755279, 5112.41207261166, 5128.769205385748, 5131.871703207431, 3631.927361452769, 4987.725675087869, 5822.214001109838, 6100.1154832549255, 6119.479844213225, 6183.690815459231, 6184.652050996951, 6200.968995155018, 6235.875282494348, 6245.094461303108, 5860.0, 6160.630362178261, 6183.103449999748, 6190.752369905198, 6193.7832175873855, 5242.501962313612, 5242.81650142247, 5252.448492908228, 5253.684778913277, 5380.730963451851, 20474.488137796525, 20765.480862978395, 20771.0, 20863.061162247584, 21169.68245476304, 1945.3191383015974, 2060.474578982365, 2159.7948194921455, 2325.395397196724, 2510.9497810043695, 12435.689107772288, 12678.619641410773, 13548.322583870768, 13578.117422367613, 13722.519711810139, 1694.7373157160537, 1704.989910565255, 1727.6976529107483, 1739.5303268117536, 1829.9176537055864, 66174.0, 67208.3279167207, 67411.32588674099, 67532.66233668849, 68235.0, 9135.0, 9148.359614826899, 9330.486823224788, 9397.248220142372, 9467.52662366879, 11976.28142311464, 11979.10156738248, 12006.579769708018, 12020.699482513008, 12036.87963120375, 6660.766873159416, 6850.725970961105, 7025.0, 7094.077769889881, 7111.182214045451, 6519.0, 6601.70292336846, 6768.153980752406, 6796.762113326109, 6811.761588344384, 5830.096335068071, 5864.501517370986, 5880.7353669085, 5888.087346461305, 6031.522277042152, 1505.7063872544747, 1600.6074714997794, 1611.4521062838692, 1632.4857669833964, 1639.9098049607387, 823.3454403749034, 825.1500954017372, 847.3221422861686, 980.0444566547559, 984.414273507262, 15920.283587238602, 17200.1399930003, 18100.909495452437, 18317.084145792924, 18402.631947360976, 825.6325934959006, 852.2798235491, 877.5831480047054, 889.6308032166578, 891.8350105230553, 9398.859017114748, 9487.810243795086, 9854.753631159278, 9952.552135153936, 10016.098551130433, 407106.0, 409180.0, 410613.0, 410790.0, 417426.0, 76552.2344776545, 78496.0, 79603.60198198972, 80001.0, 81272.0, 882.4793371910475, 909.4539283218555, 943.6508491858057, 947.7820101376722, 949.1789601994225, 15511.922440387725, 15603.921980390025, 15923.124228167098, 15976.0, 16277.918610406872, 36988.0, 37526.43710344402, 37689.43465848069, 37749.4337584942, 38239.0, 46245.0, 47768.0, 48958.0, 53664.463355365944, 54045.0, 7175.497715159889, 7355.963220183865, 7362.926370736224, 7429.777106686592, 7455.030845989987, 10047.899521004696, 11446.713832154262, 11659.417029148679, 11743.941280293544, 11887.940560297144, 9596.856047159437, 9924.751881203028, 10155.289129760846, 10381.844272336071, 10536.894631053898, 10066.396016239049, 10340.638077667245, 10426.0, 10799.298045627009, 10814.89185108139, 10334.121599664113, 10681.198910081619, 10756.139508839118, 10810.0, 10953.288036277616, 7537.246275372639, 7573.848523029619, 7624.313811756969, 7636.121845987783, 7654.693812247448, 5026.84919452417, 9898.0, 9976.750581235237, 10096.0, 10331.896681033093], "value": 8326.177954632256, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.5351003903652, 1379.5240641978517, 1418.7588110021295, 1609.3240838847682, 1669.390672404572, 6672.499562532817, 7140.428765698744, 7333.413326933845, 7713.92286077139, 7717.845643087135, 7364.116306043283, 7645.579493127876, 7668.693252269903, 7670.769876903688, 7672.808179795508, 2134.6371116910123, 2153.6015837070113, 2160.103557023833, 2166.9241576544823, 2170.7937745914114, 2120.162535798359, 2141.2291575032978, 2164.2641501889357, 2176.6517357222847, 2190.7042549255884, 2106.0838535237144, 2106.6418708819538, 2119.73503312086, 2136.7222261106035, 2138.219549864304, 2116.3121985354746, 2126.797954194349, 2127.638301488743, 2131.690904818808, 2134.9786502134934, 2062.05145633009, 2094.853360264782, 2111.4826867417582, 2113.6935144403974, 2123.4691327168207, 7489.28851759082, 7610.847783044308, 7657.655405506765, 7725.150233474314, 7737.342325902305, 4209.6421804146685, 4348.369486424483, 4356.281213599784, 4360.171567402183, 4363.3018717005125, 2787.846668433235, 2833.1642165561, 2846.4164846206686, 2900.10096869971, 2919.2993681516496, 863.1196179896533, 918.3342076994193, 919.8988111307751, 920.0661328751323, 922.6667465512337, 9932.80134397308, 9938.90061099387, 9949.90050099497, 10004.249681273934, 10032.347897386646, 3780.8109594520165, 3936.2127574485216, 4044.69664775143, 4052.4326594276827, 4117.794110294473, 8539.14608539141, 8556.914430855611, 8644.178803013703, 8648.0, 8689.782755431164, 4315.892102697395, 4399.714018588781, 4401.845935392246, 4421.425214722066, 4438.068005718836, 3437.5187473753695, 3858.6141385861188, 3930.9803450982563, 4020.638142567183, 4050.5544390117066, 3449.2756521130846, 3476.878309259164, 3585.946210806788, 3610.2418492116426, 3614.204874927512, 1184.9822252666218, 1191.5114802930757, 1195.4261954262004, 1201.1351826684947, 1211.0372254058045, 803.2529747335035, 834.8645841655344, 842.4987132656059, 855.6577369052429, 861.2119910282022, 4987.501249875056, 5031.295618613397, 5077.035363280965, 5152.381714194321, 5160.225966105114, 376.6252578684172, 378.89390970528297, 380.9657130858236, 384.3619591478133, 386.3682878493683, 3389.457686770105, 3415.077928959167, 3423.4522476403654, 3441.0193094967813, 3495.493153492729, 9076.500792456478, 9237.907620923705, 9317.301202409846, 9340.673076442292, 9365.11031452011, 9223.10926260115, 9306.348555601178, 9320.394174378644, 9328.860067098998, 9345.813083738287, 6645.568038077509, 6883.242843287134, 7131.429485641136, 7221.675024623904, 7231.132264128233, 5102.821401250939, 5241.711705856214, 5257.447967963309, 5264.921026184534, 5373.516383525345, 8100.79748006281, 8457.492550446746, 8701.869471958053, 8777.385583009129, 8779.429337093068, 8345.165483451607, 8358.164183581837, 8542.231199192103, 8867.866981995146, 8897.91102088971, 5743.8564035899435, 6145.66198859067, 6313.968430158004, 6489.156409666713, 6657.900131498128, 7316.378107860892, 7364.116306043309, 7379.741709040158, 7390.371818395497, 7390.556566606021, 6447.935520644921, 6460.192475940507, 6577.276499585138, 6589.769358072444, 6754.324567543206, 6452.645104519109, 6478.287388387368, 6510.674466276762, 6671.766488172891, 6698.497612679166, 5739.139129130664, 5850.853728656818, 5850.94149058504, 5850.94149058521, 5860.531157507475, 4371.956280437155, 4406.4051353066925, 4463.7991290391365, 4464.709793863389, 4472.865814025585, 4373.671974601854, 4382.320740285261, 4548.74981876, 4560.931586026146, 4584.312353147055], "value": 3923.058734175755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.72858056265983, 291.2805370734286, 294.1543063691886, 299.4026916301978, 303.03030303030295, 4979.601631869451, 5021.924671129936, 5050.898982020362, 5072.528966599691, 5076.543111119999, 4971.602271818255, 4977.0, 4982.950170498294, 4999.275105109757, 5000.149974504334, 3708.202736411671, 3752.8311225994894, 3861.9806900965596, 3897.7271590988644, 3902.043999220181, 3882.320593896071, 3885.61143885612, 3893.6761501089622, 3894.94157587635, 3900.9804950975204, 3880.359740642805, 3886.8250928708276, 3886.9222615547674, 3887.3391523441082, 3888.3972984187494, 3787.1289603391374, 3845.9807700961596, 3877.673395962428, 3894.785786781726, 3904.511936008013, 3416.436288012475, 3420.9315813683834, 3426.7429942754393, 3428.297199074184, 3434.759566830323, 4832.462956947596, 4833.492483289274, 4877.829365932162, 4878.341423907763, 4893.926591101101, 4427.26950053244, 4437.800298986554, 4447.466304043535, 4457.24226881431, 4465.481736209672, 4888.289098815386, 5174.275601415805, 5186.247994040843, 5205.6616319939085, 5209.192575150858, 3638.272345530904, 3643.0, 3643.143861192618, 3643.8178091095338, 3645.671889529955, 5443.727813609304, 5469.808556700536, 5472.50747432733, 5479.479449452296, 5491.945080549223, 3653.707703383723, 3734.6638802507905, 3747.6065013173225, 3750.39993601028, 3757.4739536464917, 3806.392621054531, 3824.29250588642, 3827.550367764633, 3828.3300422425964, 3837.3668344723364, 4390.143921935192, 4400.415850293892, 4402.075564131568, 4404.185225733249, 4404.8458303959205, 4982.850514484571, 5231.3199284092825, 5267.0, 5273.841784746463, 5288.68267903927, 1330.1354119822192, 1334.733053389326, 1334.9532766353132, 1335.1922087137336, 1341.3963716327692, 807.8568825112518, 838.8825564420864, 840.7225615546855, 862.5557837713583, 864.5158711121666, 4393.956060439418, 4469.307257375112, 4599.0, 4603.217453032992, 4604.102200071021, 5398.406175320712, 5425.430329815392, 5426.131818909034, 5437.864053398696, 5438.8912221755345, 4596.103759766814, 4610.0, 4620.283856002325, 4624.537546245416, 4628.166929952574, 2745.4646343962736, 2896.160113567084, 2906.6947970462797, 2909.1127206202314, 2909.9272518187213, 5096.311997880239, 5102.897942041139, 5154.871128221749, 5157.4584668610005, 5168.948310516922, 5330.946690533123, 5463.7814487420055, 5568.387477377485, 5580.665160090408, 5583.85530966151, 5043.033217045282, 5049.141645920203, 5053.393592768891, 5076.441591424867, 5086.9745651271505, 5339.97081109176, 5390.4879036491475, 5392.406835248198, 5399.0, 5408.675479471087, 5077.213031980049, 5291.894162116659, 5295.4969277918535, 5304.9734751326, 5320.457067450396, 5105.31078304439, 5117.923231151462, 5124.846254612367, 5134.717590532557, 5142.562882155059, 3853.4605155277723, 3892.182641645173, 3900.278448487039, 3903.277893589695, 3906.4726261954274, 5090.956353947506, 5326.280952071421, 5336.573074153981, 5403.540699040625, 5409.6213265071065, 5262.368515778131, 5267.420583735709, 5271.578273738169, 5272.0, 5272.393674727302, 5247.2129180623215, 5259.973700131475, 5265.394479634738, 5274.314339135888, 5288.545649946295, 5040.370224497805, 5091.0581542414775, 5144.511271429208, 5184.755658641974, 5198.8042750166915, 5047.343845300087, 5139.768710407966, 5274.736263186902, 5295.205719142159, 5306.495882891119, 5120.129577971828, 5142.84286035654, 5144.382674079135, 5178.508041736029, 5181.974090129676], "value": 3928.935850798716, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.3009150117873, 723.8226634474554, 739.59322372695, 742.4728442805608, 746.238836386885, 12635.305058221795, 13650.45398184074, 13758.656033599165, 13796.586102416932, 13801.585952421417, 12992.025598080158, 13171.275579843104, 13376.531821386254, 13386.263755493444, 13387.531436399728, 729.9562026278427, 755.3768141283463, 757.9772606821804, 758.0524344569288, 758.6813538313894, 739.9926000739978, 765.2118318132333, 766.7469734987441, 781.0, 783.4829012851519, 819.942604017719, 822.8889099971517, 823.9546824924627, 824.5506199121463, 824.8762685597148, 812.9837403251961, 814.3892080939296, 816.2001238785964, 820.0937963550281, 821.0229826506468, 592.8340064781825, 595.3362001368487, 595.7289433307834, 596.1713218626113, 596.3142386255797, 13248.86751132486, 13272.535461258809, 13288.136271142344, 13426.32868356588, 13493.190408575518, 12555.93722031384, 12924.612261632072, 13079.607611771662, 13147.14543554666, 13575.049746517649, 9710.90289097107, 10928.672139835817, 10976.506057227443, 11417.828732568934, 11818.586349477728, 4147.108371700068, 4153.190127925056, 4161.75029498228, 4179.373094035919, 4187.497500299953, 57640.0, 58024.12963805546, 58151.41848581545, 58214.70892645552, 58281.417185828446, 9426.717198484057, 9472.147506724428, 9985.760145276283, 10140.898591014144, 10203.897961020442, 18523.166457509444, 19295.8070419294, 19322.227110915406, 19356.806431935784, 19367.515812104528, 7027.227005029443, 7036.718531258693, 7195.96402017997, 7271.236520165412, 7329.9267007329245, 3737.8691745788765, 3751.718621103428, 3767.6232376762105, 3801.961980380216, 3847.5190601174854, 2877.108096490095, 2998.970010299869, 3003.3993201359817, 3007.8646460909313, 3008.2028262510453, 487.4418790484875, 494.6463278755707, 505.60057554531505, 514.8198130654316, 518.5592246590444, 553.3553410276983, 572.1732097119623, 579.325086274494, 591.361329763854, 598.6228675934134, 7687.961560192163, 7982.321502672222, 8406.789830254293, 8409.873851892227, 8480.321574274043, 516.5970542976485, 528.9894202115936, 530.3582664975423, 538.4749868877891, 539.7786907367961, 3727.1613886875234, 3850.8459661613783, 4039.5758445362812, 4065.9390109148385, 4098.0, 50039.749801250764, 52495.212571811455, 82982.0, 91184.08815911756, 107350.0, 83044.58477707572, 86358.0, 86961.13038869656, 89311.55344223237, 90510.54744726235, 45130.77434612872, 57667.71166144226, 73669.63165184247, 74496.62751686206, 75038.0, 7525.435592330707, 7536.472446928662, 7612.238776122344, 7716.7684969451, 7728.613569321399, 46285.76857115693, 46823.29765053459, 46962.530374697184, 47667.76166119147, 48273.517264828304, 65305.34694652993, 69521.30478695148, 70162.29837701557, 70426.29573704198, 74286.88528687098, 9085.909140908507, 9237.722868313962, 9281.211097056826, 9370.938393553408, 9477.573509192242, 11383.146264030396, 11509.654710358702, 11517.193796434169, 11522.0, 12065.577704780291, 9863.556139973574, 10032.448215348226, 10222.795544088927, 10224.488775561342, 10471.0, 9292.814143717223, 9410.858837117312, 9463.621455141718, 9682.9031709682, 9713.562889670124, 10042.297039207186, 10415.531301091318, 10631.308964917256, 10730.785384292114, 10994.28537145083, 8201.589920503831, 8499.065102838806, 8594.871076933976, 8915.108489151033, 9342.766430839283, 8849.69026084084, 10219.489025548544, 10402.11582015507, 10456.32033917793, 10493.108085812792], "value": 6413.469245314201, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1623.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 115.0, 117.0, 118.0, 117.0, 124.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 125.0, 147.0, 180.0, 133.0, 157.0, 149.0, 132.0, 192.0, 128.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 164.0, 165.0, 165.0, 164.0, 163.0, 165.0, 164.0, 165.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 184.0, 80.0, 80.0, 77.0, 77.0, 160.0, 81.0], "value": 97.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 141.0, 91.0, 94.0, 88.0, 138.0, 87.0, 93.0, 137.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 118.0, 119.0, 120.0, 125.0, 125.0, 118.0, 119.0, 118.0], "value": 119.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 150.0, 149.0, 151.0, 149.0, 149.0, 149.0, 151.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 64.0, 67.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 71.0, 69.0, 82.0, 69.0, 68.0, 69.0, 69.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 86.0, 85.0, 84.0, 88.0, 84.0, 81.0, 95.0, 89.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 138.0, 145.0, 139.0, 163.0, 148.0, 138.0, 149.0, 167.0, 152.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 183.0, 179.0, 186.0, 179.0, 177.0, 183.0, 178.0, 178.0, 180.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 70.0, 70.0, 72.0, 71.0, 73.0, 72.0, 75.0, 72.0], "value": 72.2, "unit": "score"}]}]} 12:07:00 INFO - Return code: 0 12:07:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:07:00 ERROR - # TBPL SUCCESS # 12:07:00 INFO - Running post-action listener: _resource_record_post_action 12:07:00 INFO - [mozharness: 2016-08-19 19:07:00.599669Z] Finished run-tests step (success) 12:07:00 INFO - Running post-run listener: _resource_record_post_run 12:07:00 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 4096; Write bytes: 410263552; Read time: 12; Write time: 292360 12:07:00 INFO - TinderboxPrint: CPU usage
13.8% 12:07:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:07:00 INFO - TinderboxPrint: I/O write bytes / time
410,263,552 / 292,360 12:07:00 INFO - TinderboxPrint: CPU idle
8,244.4 (86.1%) 12:07:00 INFO - TinderboxPrint: CPU user
1,229.9 (12.9%) 12:07:00 INFO - TinderboxPrint: Swap in / out
0 / 0 12:07:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 117276672; Read time: 0; Write time: 105368 12:07:00 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 0; Write bytes: 292986880; Read time: 0; Write time: 186992 12:07:01 INFO - Running post-run listener: _upload_blobber_files 12:07:01 INFO - Blob upload gear active. 12:07:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:07:01 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 12:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:07:01 INFO - (blobuploader) - INFO - Open directory for files ... 12:07:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:07:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:07:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:03 INFO - (blobuploader) - INFO - Done attempting. 12:07:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:07:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:07:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:08 INFO - (blobuploader) - INFO - Done attempting. 12:07:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:07:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:09 INFO - (blobuploader) - INFO - Done attempting. 12:07:09 INFO - (blobuploader) - INFO - Iteration through files over. 12:07:09 INFO - Return code: 0 12:07:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:07:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:07:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f4586cad90c783b05668e739665f98257161f7f161a59d51d415552f0259190f9c137ca510d3b6bfff856456c5ad14f42775350777c46332e0655ab32c71d0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/20e48f3ff7350b90ff8868c2f42fbda5b617016140b7b8bb5a4e622b35739cb4420af83311466dc25e4ad8e0896488f6ff730d3fd3300facded0b3464187af03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2715ee00dac627cd2284820ce459a3f5216e3ad4c8c7ae5530963bbfef1070be9d0638cb1511753f11961a944468ae05ee06a22630e0ecf67e48a1237ba9e78c"} 12:07:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:07:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:07:09 INFO - Contents: 12:07:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f4586cad90c783b05668e739665f98257161f7f161a59d51d415552f0259190f9c137ca510d3b6bfff856456c5ad14f42775350777c46332e0655ab32c71d0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/20e48f3ff7350b90ff8868c2f42fbda5b617016140b7b8bb5a4e622b35739cb4420af83311466dc25e4ad8e0896488f6ff730d3fd3300facded0b3464187af03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2715ee00dac627cd2284820ce459a3f5216e3ad4c8c7ae5530963bbfef1070be9d0638cb1511753f11961a944468ae05ee06a22630e0ecf67e48a1237ba9e78c"} 12:07:09 INFO - Running post-run listener: copy_logs_to_upload_dir 12:07:09 INFO - Copying logs to upload dir... 12:07:09 INFO - mkdir: /builds/slave/test/build/upload/logs 12:07:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.291823 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-19 12:07:08.767615) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 12:07:08.771080) ========= 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=ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f4586cad90c783b05668e739665f98257161f7f161a59d51d415552f0259190f9c137ca510d3b6bfff856456c5ad14f42775350777c46332e0655ab32c71d0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/20e48f3ff7350b90ff8868c2f42fbda5b617016140b7b8bb5a4e622b35739cb4420af83311466dc25e4ad8e0896488f6ff730d3fd3300facded0b3464187af03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2715ee00dac627cd2284820ce459a3f5216e3ad4c8c7ae5530963bbfef1070be9d0638cb1511753f11961a944468ae05ee06a22630e0ecf67e48a1237ba9e78c"} build_url:https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011607 build_url: 'https://queue.taskcluster.net/v1/task/Ou431EdcSLmkTrnrwA2jYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f4586cad90c783b05668e739665f98257161f7f161a59d51d415552f0259190f9c137ca510d3b6bfff856456c5ad14f42775350777c46332e0655ab32c71d0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/20e48f3ff7350b90ff8868c2f42fbda5b617016140b7b8bb5a4e622b35739cb4420af83311466dc25e4ad8e0896488f6ff730d3fd3300facded0b3464187af03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2715ee00dac627cd2284820ce459a3f5216e3ad4c8c7ae5530963bbfef1070be9d0638cb1511753f11961a944468ae05ee06a22630e0ecf67e48a1237ba9e78c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 12:07:08.797131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 12:07:08.797451) ========= 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=ed14279e38b05397cf4aa391000001a4-1471632381.768597-1483194932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004374 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 12:07:08.879492) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 12:07:08.879810) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 12:07:08.880093) ========= ========= Total master_lag: 0.17 =========