builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1471062504.37 results: success (0) buildid: 20160812183004 builduid: d76c245cb9144dcc96902836c827ed7b revision: bd22ef65b95cd84bc9fbef26309524b1f53a2263 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 21:28:24.368315) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 21:28:24.368872) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 21:28:24.369160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 21:28:24.401848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:28:24.402160) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-12 21:28:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-08-12 21:28:24 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161581 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:28:24.577604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:28:24.577912) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020257 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:28:24.627747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 21:28:24.628080) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev bd22ef65b95cd84bc9fbef26309524b1f53a2263 --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 bd22ef65b95cd84bc9fbef26309524b1f53a2263 --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=74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-12 21:28:24,890 truncating revision to first 12 chars 2016-08-12 21:28:24,890 Setting DEBUG logging. 2016-08-12 21:28:24,890 attempt 1/10 2016-08-12 21:28:24,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/bd22ef65b95c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 21:28:26,285 unpacking tar archive at: autoland-bd22ef65b95c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.750346 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 21:28:26.393129) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 21:28:26.393492) ========= script_repo_revision: bd22ef65b95cd84bc9fbef26309524b1f53a2263 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 21:28:26.393940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 21:28:26.394271) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 21:28:26.404115) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-12 21:28:26.404477) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:28:26 INFO - MultiFileLogger online at 20160812 21:28:26 in /builds/slave/test 21:28:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:28:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:28:26 INFO - {'append_to_log': False, 21:28:26 INFO - 'base_work_dir': '/builds/slave/test', 21:28:26 INFO - 'blob_upload_branch': 'Autoland', 21:28:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:28:26 INFO - 'branch': 'Autoland', 21:28:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:28:26 INFO - 'config_files': ('talos/linux_config.py',), 21:28:26 INFO - 'default_actions': ('clobber', 21:28:26 INFO - 'read-buildbot-config', 21:28:26 INFO - 'download-and-extract', 21:28:26 INFO - 'populate-webroot', 21:28:26 INFO - 'create-virtualenv', 21:28:26 INFO - 'install', 21:28:26 INFO - 'run-tests'), 21:28:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:28:26 INFO - 'download_minidump_stackwalk': True, 21:28:26 INFO - 'download_symbols': 'ondemand', 21:28:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:28:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:28:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:28:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:28:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:28:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:28:26 INFO - 'installer_path': 'installer.exe', 21:28:26 INFO - 'log_level': 'info', 21:28:26 INFO - 'log_name': 'talos', 21:28:26 INFO - 'log_to_console': True, 21:28:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:28:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:28:26 INFO - 'opt_config_files': (), 21:28:26 INFO - 'pip_index': False, 21:28:26 INFO - 'sps_profile': False, 21:28:26 INFO - 'sps_profile_interval': 0, 21:28:26 INFO - 'suite': 'dromaeojs', 21:28:26 INFO - 'system_bits': '32', 21:28:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:28:26 INFO - 'title': 'talos-linux64-ix-042', 21:28:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:28:26 INFO - 'use_talos_json': True, 21:28:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:28:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:28:26 INFO - 'work_dir': 'build'} 21:28:26 INFO - [mozharness: 2016-08-13 04:28:26.764164Z] Running clobber step. 21:28:26 INFO - Running pre-action listener: _resource_record_pre_action 21:28:26 INFO - Running main action method: clobber 21:28:26 INFO - rmtree: /builds/slave/test/build 21:28:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:28:27 INFO - Running post-action listener: _resource_record_post_action 21:28:27 INFO - [mozharness: 2016-08-13 04:28:27.229909Z] Finished clobber step (success) 21:28:27 INFO - [mozharness: 2016-08-13 04:28:27.230009Z] Running read-buildbot-config step. 21:28:27 INFO - Running pre-action listener: _resource_record_pre_action 21:28:27 INFO - Running main action method: read_buildbot_config 21:28:27 INFO - Using buildbot properties: 21:28:27 INFO - { 21:28:27 INFO - "project": "", 21:28:27 INFO - "product": "firefox", 21:28:27 INFO - "script_repo_revision": "production", 21:28:27 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:28:27 INFO - "repository": "", 21:28:27 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 21:28:27 INFO - "buildid": "20160812183004", 21:28:27 INFO - "pgo_build": "True", 21:28:27 INFO - "basedir": "/builds/slave/test", 21:28:27 INFO - "buildnumber": 119, 21:28:27 INFO - "slavename": "talos-linux64-ix-042", 21:28:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:28:27 INFO - "platform": "ubuntu64_hw", 21:28:27 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:28:27 INFO - "branch": "autoland", 21:28:27 INFO - "repo_path": "integration/autoland", 21:28:27 INFO - "revision": "bd22ef65b95cd84bc9fbef26309524b1f53a2263", 21:28:27 INFO - "stage_platform": "linux64-pgo", 21:28:27 INFO - "builduid": "d76c245cb9144dcc96902836c827ed7b", 21:28:27 INFO - "slavebuilddir": "test" 21:28:27 INFO - } 21:28:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 21:28:27 INFO - Running post-action listener: _resource_record_post_action 21:28:27 INFO - [mozharness: 2016-08-13 04:28:27.232429Z] Finished read-buildbot-config step (success) 21:28:27 INFO - [mozharness: 2016-08-13 04:28:27.232517Z] Running download-and-extract step. 21:28:27 INFO - Running pre-action listener: _resource_record_pre_action 21:28:27 INFO - Running main action method: download_and_extract 21:28:27 INFO - mkdir: /builds/slave/test/build/tests 21:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:27 INFO - trying https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:28:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/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 21:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/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 21:28:27 INFO - Downloaded 1361 bytes. 21:28:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:28:27 INFO - Using the following test package requirements: 21:28:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:28:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:28:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:28:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:27 INFO - u'jsshell-linux-x86_64.zip'], 21:28:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:28:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:28:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:28:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:28:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:28:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:28:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:27 INFO - trying https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:28:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/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 21:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/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 21:28:28 INFO - Downloaded 21837086 bytes. 21:28:28 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 21:28:32 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 21:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:32 INFO - trying https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:28:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/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 21:28:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/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 21:28:33 INFO - Downloaded 21837086 bytes. 21:28:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 21:28:38 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')]} 21:28:38 INFO - trying https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:28:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/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 21:28:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/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 21:28:39 INFO - Downloaded 14413719 bytes. 21:28:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 21:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:39 INFO - trying https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:28:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/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 21:28:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/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 21:28:40 INFO - Downloaded 59405868 bytes. 21:28:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:28:40 INFO - mkdir: /builds/slave/test/properties 21:28:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:28:40 INFO - Writing to file /builds/slave/test/properties/build_url 21:28:40 INFO - Contents: 21:28:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:28:41 INFO - Running post-action listener: _resource_record_post_action 21:28:41 INFO - Running post-action listener: set_extra_try_arguments 21:28:41 INFO - [mozharness: 2016-08-13 04:28:41.237450Z] Finished download-and-extract step (success) 21:28:41 INFO - [mozharness: 2016-08-13 04:28:41.237673Z] Running populate-webroot step. 21:28:41 INFO - Running pre-action listener: _resource_record_pre_action 21:28:41 INFO - Running main action method: populate_webroot 21:28:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:28:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:28:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:28:41 INFO - '--tppagecycles', 21:28:41 INFO - '7'], 21:28:41 INFO - 'tests': ['tsvgm']}}, 21:28:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:28:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:28:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:28:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:28:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:28:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:28:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:41 INFO - 'talos_options': ['--disable-e10s'], 21:28:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:28:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:28:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:41 INFO - 'talos_options': ['--disable-e10s'], 21:28:41 INFO - 'tests': ['damp', 'tps']}, 21:28:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:41 INFO - 'tests': ['damp', 'tps']}, 21:28:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:28:41 INFO - 'tests': ['dromaeo_dom']}, 21:28:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:28:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:28:41 INFO - 'tests': ['basic_compositor_video']}, 21:28:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:28:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:28:41 INFO - 'tests': ['a11yr', 21:28:41 INFO - 'ts_paint', 21:28:41 INFO - 'tpaint', 21:28:41 INFO - 'sessionrestore', 21:28:41 INFO - 'sessionrestore_no_auto_restore', 21:28:41 INFO - 'tabpaint']}, 21:28:41 INFO - 'other-e10s': {'tests': ['a11yr', 21:28:41 INFO - 'ts_paint', 21:28:41 INFO - 'tpaint', 21:28:41 INFO - 'sessionrestore', 21:28:41 INFO - 'sessionrestore_no_auto_restore', 21:28:41 INFO - 'tabpaint']}, 21:28:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:28:41 INFO - 'ts_paint', 21:28:41 INFO - 'tpaint', 21:28:41 INFO - 'sessionrestore', 21:28:41 INFO - 'sessionrestore_no_auto_restore', 21:28:41 INFO - 'tabpaint']}, 21:28:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:28:41 INFO - 'ts_paint', 21:28:41 INFO - 'tpaint', 21:28:41 INFO - 'sessionrestore', 21:28:41 INFO - 'sessionrestore_no_auto_restore', 21:28:41 INFO - 'tabpaint']}, 21:28:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:28:41 INFO - 'tests': ['a11yr', 21:28:41 INFO - 'ts_paint', 21:28:41 INFO - 'tpaint', 21:28:41 INFO - 'sessionrestore', 21:28:41 INFO - 'sessionrestore_no_auto_restore', 21:28:41 INFO - 'tabpaint']}, 21:28:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:28:41 INFO - 'tests': ['a11yr', 21:28:41 INFO - 'ts_paint', 21:28:41 INFO - 'tpaint', 21:28:41 INFO - 'sessionrestore', 21:28:41 INFO - 'sessionrestore_no_auto_restore', 21:28:41 INFO - 'tabpaint']}, 21:28:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:28:41 INFO - 'tests': ['tsvgx', 21:28:41 INFO - 'tsvgr_opacity', 21:28:41 INFO - 'tart', 21:28:41 INFO - 'tscrollx', 21:28:41 INFO - 'cart']}, 21:28:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:28:41 INFO - 'tsvgr_opacity', 21:28:41 INFO - 'tart', 21:28:41 INFO - 'tscrollx', 21:28:41 INFO - 'cart']}, 21:28:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:41 INFO - 'talos_options': ['--disable-e10s'], 21:28:41 INFO - 'tests': ['tp5o']}, 21:28:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:41 INFO - 'tests': ['tp5o']}, 21:28:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:41 INFO - 'talos_options': ['--disable-e10s', 21:28:41 INFO - '--xperf_path', 21:28:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:28:41 INFO - 'tests': ['tp5n']}, 21:28:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:41 INFO - 'talos_options': ['--xperf_path', 21:28:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:28:41 INFO - 'tests': ['tp5n']}}, 21:28:41 INFO - 'talos.zip': {'path': '', 21:28:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:28:41 INFO - Running post-action listener: _resource_record_post_action 21:28:41 INFO - [mozharness: 2016-08-13 04:28:41.257015Z] Finished populate-webroot step (success) 21:28:41 INFO - [mozharness: 2016-08-13 04:28:41.257102Z] Running create-virtualenv step. 21:28:41 INFO - Running pre-action listener: _resource_record_pre_action 21:28:41 INFO - Running main action method: create_virtualenv 21:28:41 INFO - Creating virtualenv /builds/slave/test/build/venv 21:28:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:28:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:28:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:28:41 INFO - Using real prefix '/usr' 21:28:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:28:41 INFO - Installing distribute.............................................................................................................................................................................................done. 21:28:43 INFO - Installing pip.................done. 21:28:43 INFO - Return code: 0 21:28:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:28:43 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')]} 21:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:43 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')]} 21:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:43 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 0x7ff2be86ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1965370>, '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 0x19688f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1968d80>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', '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 21:28:43 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 21:28:43 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 21:28:43 INFO - Using env: {'DISPLAY': ':0', 21:28:43 INFO - 'HOME': '/home/cltbld', 21:28:43 INFO - 'LANG': 'en_US.UTF-8', 21:28:43 INFO - 'LANGUAGE': 'en_US:en', 21:28:43 INFO - 'LOGNAME': 'cltbld', 21:28:43 INFO - 'MAIL': '/var/mail/cltbld', 21:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:43 INFO - 'MOZ_NO_REMOTE': '1', 21:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:43 INFO - 'NO_EM_RESTART': '1', 21:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:43 INFO - 'PWD': '/builds/slave/test', 21:28:43 INFO - 'SHELL': '/bin/bash', 21:28:43 INFO - 'SHLVL': '1', 21:28:43 INFO - 'TERM': 'linux', 21:28:43 INFO - 'TMOUT': '86400', 21:28:43 INFO - 'USER': 'cltbld', 21:28:43 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', 21:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:43 INFO - '_': '/tools/buildbot/bin/python'} 21:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:28:44 INFO - Cleaning up... 21:28:44 INFO - Return code: 0 21:28:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:28: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')]} 21:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28: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')]} 21:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2be86ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1965370>, '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 0x19688f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1968d80>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', '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 21:28:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:28:44 INFO - Using env: {'DISPLAY': ':0', 21:28:44 INFO - 'HOME': '/home/cltbld', 21:28:44 INFO - 'LANG': 'en_US.UTF-8', 21:28:44 INFO - 'LANGUAGE': 'en_US:en', 21:28:44 INFO - 'LOGNAME': 'cltbld', 21:28:44 INFO - 'MAIL': '/var/mail/cltbld', 21:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:44 INFO - 'MOZ_NO_REMOTE': '1', 21:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:44 INFO - 'NO_EM_RESTART': '1', 21:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:44 INFO - 'PWD': '/builds/slave/test', 21:28:44 INFO - 'SHELL': '/bin/bash', 21:28:44 INFO - 'SHLVL': '1', 21:28:44 INFO - 'TERM': 'linux', 21:28:44 INFO - 'TMOUT': '86400', 21:28:44 INFO - 'USER': 'cltbld', 21:28:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', 21:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:44 INFO - '_': '/tools/buildbot/bin/python'} 21:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:44 INFO - Downloading/unpacking psutil>=3.1.1 21:28: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 21:28: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 21:28: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 21:28: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 21:28: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 21:28: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 21:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:28:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:28:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:28:46 INFO - Installing collected packages: psutil 21:28:46 INFO - Running setup.py install for psutil 21:28:46 INFO - building 'psutil._psutil_linux' extension 21:28:46 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 21:28:46 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 21:28:46 INFO - building 'psutil._psutil_posix' extension 21:28:46 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 21:28:46 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 21:28:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:28:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:28:46 INFO - Successfully installed psutil 21:28:46 INFO - Cleaning up... 21:28:46 INFO - Return code: 0 21:28:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:28: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')]} 21:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28: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')]} 21:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2be86ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1965370>, '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 0x19688f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1968d80>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', '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 21:28: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:28: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 mozsystemmonitor==0.3 21:28:46 INFO - Using env: {'DISPLAY': ':0', 21:28:46 INFO - 'HOME': '/home/cltbld', 21:28:46 INFO - 'LANG': 'en_US.UTF-8', 21:28:46 INFO - 'LANGUAGE': 'en_US:en', 21:28:46 INFO - 'LOGNAME': 'cltbld', 21:28:46 INFO - 'MAIL': '/var/mail/cltbld', 21:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:46 INFO - 'MOZ_NO_REMOTE': '1', 21:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:46 INFO - 'NO_EM_RESTART': '1', 21:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:46 INFO - 'PWD': '/builds/slave/test', 21:28:46 INFO - 'SHELL': '/bin/bash', 21:28:46 INFO - 'SHLVL': '1', 21:28:46 INFO - 'TERM': 'linux', 21:28:46 INFO - 'TMOUT': '86400', 21:28:46 INFO - 'USER': 'cltbld', 21:28:46 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', 21:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:46 INFO - '_': '/tools/buildbot/bin/python'} 21:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:28: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 21:28: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 21:28: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 21:28: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 21:28: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 21:28: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 21:28:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:28:48 INFO - Installing collected packages: mozsystemmonitor 21:28:48 INFO - Running setup.py install for mozsystemmonitor 21:28:49 INFO - Successfully installed mozsystemmonitor 21:28:49 INFO - Cleaning up... 21:28:49 INFO - Return code: 0 21:28:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:28: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')]} 21:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28: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')]} 21:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2be86ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1965370>, '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 0x19688f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1968d80>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', '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 21:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:28:49 INFO - Using env: {'DISPLAY': ':0', 21:28:49 INFO - 'HOME': '/home/cltbld', 21:28:49 INFO - 'LANG': 'en_US.UTF-8', 21:28:49 INFO - 'LANGUAGE': 'en_US:en', 21:28:49 INFO - 'LOGNAME': 'cltbld', 21:28:49 INFO - 'MAIL': '/var/mail/cltbld', 21:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:49 INFO - 'MOZ_NO_REMOTE': '1', 21:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:49 INFO - 'NO_EM_RESTART': '1', 21:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:49 INFO - 'PWD': '/builds/slave/test', 21:28:49 INFO - 'SHELL': '/bin/bash', 21:28:49 INFO - 'SHLVL': '1', 21:28:49 INFO - 'TERM': 'linux', 21:28:49 INFO - 'TMOUT': '86400', 21:28:49 INFO - 'USER': 'cltbld', 21:28:49 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', 21:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:49 INFO - '_': '/tools/buildbot/bin/python'} 21:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:49 INFO - Downloading/unpacking jsonschema==2.5.1 21:28: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 21:28: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 21:28: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 21:28: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 21:28: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 21:28: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 21:28:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:28:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:28: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 21:28: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 21:28: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 21:28: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 21:28: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 21:28: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 21:28:51 INFO - Downloading functools32-3.2.3-2.tar.gz 21:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:28:51 INFO - warning: no files found matching '*.txt' 21:28:51 INFO - no previously-included directories found matching 'build' 21:28:51 INFO - no previously-included directories found matching 'dist' 21:28:51 INFO - no previously-included directories found matching '.git*' 21:28:51 INFO - Installing collected packages: jsonschema, functools32 21:28:51 INFO - Running setup.py install for functools32 21:28:51 INFO - warning: no files found matching '*.txt' 21:28:51 INFO - no previously-included directories found matching 'build' 21:28:51 INFO - no previously-included directories found matching 'dist' 21:28:51 INFO - no previously-included directories found matching '.git*' 21:28:51 INFO - Successfully installed jsonschema functools32 21:28:51 INFO - Cleaning up... 21:28:51 INFO - Return code: 0 21:28:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff2be86ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1965370>, '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 0x19688f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1968d80>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', '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 21:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:28:51 INFO - Using env: {'DISPLAY': ':0', 21:28:51 INFO - 'HOME': '/home/cltbld', 21:28:51 INFO - 'LANG': 'en_US.UTF-8', 21:28:51 INFO - 'LANGUAGE': 'en_US:en', 21:28:51 INFO - 'LOGNAME': 'cltbld', 21:28:51 INFO - 'MAIL': '/var/mail/cltbld', 21:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:51 INFO - 'MOZ_NO_REMOTE': '1', 21:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:51 INFO - 'NO_EM_RESTART': '1', 21:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:51 INFO - 'PWD': '/builds/slave/test', 21:28:51 INFO - 'SHELL': '/bin/bash', 21:28:51 INFO - 'SHLVL': '1', 21:28:51 INFO - 'TERM': 'linux', 21:28:51 INFO - 'TMOUT': '86400', 21:28:51 INFO - 'USER': 'cltbld', 21:28:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', 21:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:51 INFO - '_': '/tools/buildbot/bin/python'} 21:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:28:51 INFO - Cleaning up... 21:28:51 INFO - Return code: 0 21:28:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff2be86ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1965370>, '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 0x19688f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1968d80>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', '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 21:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:28:51 INFO - Using env: {'DISPLAY': ':0', 21:28:51 INFO - 'HOME': '/home/cltbld', 21:28:51 INFO - 'LANG': 'en_US.UTF-8', 21:28:51 INFO - 'LANGUAGE': 'en_US:en', 21:28:51 INFO - 'LOGNAME': 'cltbld', 21:28:51 INFO - 'MAIL': '/var/mail/cltbld', 21:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:51 INFO - 'MOZ_NO_REMOTE': '1', 21:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:51 INFO - 'NO_EM_RESTART': '1', 21:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:51 INFO - 'PWD': '/builds/slave/test', 21:28:51 INFO - 'SHELL': '/bin/bash', 21:28:51 INFO - 'SHLVL': '1', 21:28:51 INFO - 'TERM': 'linux', 21:28:51 INFO - 'TMOUT': '86400', 21:28:51 INFO - 'USER': 'cltbld', 21:28:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', 21:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:51 INFO - '_': '/tools/buildbot/bin/python'} 21:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:52 INFO - Downloading/unpacking blobuploader==1.2.4 21:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:53 INFO - Downloading blobuploader-1.2.4.tar.gz 21:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:28:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:28:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:54 INFO - Downloading docopt-0.6.1.tar.gz 21:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:28:54 INFO - Installing collected packages: blobuploader, requests, docopt 21:28:54 INFO - Running setup.py install for blobuploader 21:28:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:28:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:28:54 INFO - Running setup.py install for requests 21:28:55 INFO - Running setup.py install for docopt 21:28:55 INFO - Successfully installed blobuploader requests docopt 21:28:55 INFO - Cleaning up... 21:28:55 INFO - Return code: 0 21:28:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:55 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 0x7ff2be86ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1965370>, '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 0x19688f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1968d80>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', '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 21:28:55 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 21:28:55 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 21:28:55 INFO - Using env: {'DISPLAY': ':0', 21:28:55 INFO - 'HOME': '/home/cltbld', 21:28:55 INFO - 'LANG': 'en_US.UTF-8', 21:28:55 INFO - 'LANGUAGE': 'en_US:en', 21:28:55 INFO - 'LOGNAME': 'cltbld', 21:28:55 INFO - 'MAIL': '/var/mail/cltbld', 21:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:55 INFO - 'MOZ_NO_REMOTE': '1', 21:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:55 INFO - 'NO_EM_RESTART': '1', 21:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:55 INFO - 'PWD': '/builds/slave/test', 21:28:55 INFO - 'SHELL': '/bin/bash', 21:28:55 INFO - 'SHLVL': '1', 21:28:55 INFO - 'TERM': 'linux', 21:28:55 INFO - 'TMOUT': '86400', 21:28:55 INFO - 'USER': 'cltbld', 21:28:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', 21:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:55 INFO - '_': '/tools/buildbot/bin/python'} 21:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:28:55 INFO - Running setup.py (path:/tmp/pip-2DxpOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:28:55 INFO - Running setup.py (path:/tmp/pip-4JYdzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:28:55 INFO - Running setup.py (path:/tmp/pip-qxQxwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:28:55 INFO - Running setup.py (path:/tmp/pip-l58eq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:28:55 INFO - Running setup.py (path:/tmp/pip-E5nU3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:28:55 INFO - Running setup.py (path:/tmp/pip-xPMOg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:28:55 INFO - Running setup.py (path:/tmp/pip-4CFr0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:28:56 INFO - Running setup.py (path:/tmp/pip-y7nmw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:28:56 INFO - Running setup.py (path:/tmp/pip-h5GN_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:28:56 INFO - Running setup.py (path:/tmp/pip-ARZRaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:28:56 INFO - Running setup.py (path:/tmp/pip-HYuCyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:28:56 INFO - Running setup.py (path:/tmp/pip-MRSa6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:28:56 INFO - Running setup.py (path:/tmp/pip-hNn7fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:28:56 INFO - Running setup.py (path:/tmp/pip-BO50VV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:56 INFO - Running setup.py (path:/tmp/pip-wTXHrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:28:56 INFO - Running setup.py (path:/tmp/pip-AhNKos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:28:56 INFO - Running setup.py (path:/tmp/pip-mn5avX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:28:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:28:56 INFO - Running setup.py install for manifestparser 21:28:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:28:56 INFO - Running setup.py install for mozcrash 21:28:56 INFO - Running setup.py install for mozdebug 21:28:57 INFO - Running setup.py install for mozdevice 21:28:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Running setup.py install for mozfile 21:28:57 INFO - Running setup.py install for mozhttpd 21:28:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Running setup.py install for mozinfo 21:28:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Running setup.py install for mozInstall 21:28:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Running setup.py install for mozleak 21:28:57 INFO - Running setup.py install for mozlog 21:28:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Running setup.py install for moznetwork 21:28:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Running setup.py install for mozprocess 21:28:57 INFO - Running setup.py install for mozprofile 21:28:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:28:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:28:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:28:58 INFO - Running setup.py install for mozrunner 21:28:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:28:58 INFO - Running setup.py install for mozscreenshot 21:28:58 INFO - Running setup.py install for moztest 21:28:58 INFO - Running setup.py install for mozversion 21:28:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:28:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:28:58 INFO - Cleaning up... 21:28:58 INFO - Return code: 0 21:28:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:58 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 0x7ff2be86ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1965370>, '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 0x19688f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1968d80>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', '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 21:28:58 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 21:28:58 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 21:28:58 INFO - Using env: {'DISPLAY': ':0', 21:28:58 INFO - 'HOME': '/home/cltbld', 21:28:58 INFO - 'LANG': 'en_US.UTF-8', 21:28:58 INFO - 'LANGUAGE': 'en_US:en', 21:28:58 INFO - 'LOGNAME': 'cltbld', 21:28:58 INFO - 'MAIL': '/var/mail/cltbld', 21:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:58 INFO - 'MOZ_NO_REMOTE': '1', 21:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:58 INFO - 'NO_EM_RESTART': '1', 21:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:58 INFO - 'PWD': '/builds/slave/test', 21:28:58 INFO - 'SHELL': '/bin/bash', 21:28:58 INFO - 'SHLVL': '1', 21:28:58 INFO - 'TERM': 'linux', 21:28:58 INFO - 'TMOUT': '86400', 21:28:58 INFO - 'USER': 'cltbld', 21:28:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', 21:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:58 INFO - '_': '/tools/buildbot/bin/python'} 21:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:28:58 INFO - Running setup.py (path:/tmp/pip-k_GR8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:28:58 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)) 21:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:28:58 INFO - Running setup.py (path:/tmp/pip-mUvQyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:28:58 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)) 21:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:28:58 INFO - Running setup.py (path:/tmp/pip-6bYDxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:28:58 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)) 21:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:28:58 INFO - Running setup.py (path:/tmp/pip-E71gne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:28:59 INFO - Running setup.py (path:/tmp/pip-eknBLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:28:59 INFO - Running setup.py (path:/tmp/pip-LSGDXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:28:59 INFO - Running setup.py (path:/tmp/pip-hZWcqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:28:59 INFO - Running setup.py (path:/tmp/pip-ps84rP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:28:59 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:28:59 INFO - Running setup.py (path:/tmp/pip-lW1bH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:28:59 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:28:59 INFO - Running setup.py (path:/tmp/pip-SHRfmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:28:59 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:28:59 INFO - Running setup.py (path:/tmp/pip-IYlJNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:28:59 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:28:59 INFO - Running setup.py (path:/tmp/pip-6hGhzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:28:59 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:28:59 INFO - Running setup.py (path:/tmp/pip-ku3xPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:28:59 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:28:59 INFO - Running setup.py (path:/tmp/pip-LIB_AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:28:59 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:59 INFO - Running setup.py (path:/tmp/pip-fD5PT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:59 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:28:59 INFO - Running setup.py (path:/tmp/pip-MrlUSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:28:59 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:28:59 INFO - Running setup.py (path:/tmp/pip-GXMPQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:29:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:01 INFO - Downloading blessings-1.6.tar.gz 21:29:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:29:01 INFO - Installing collected packages: blessings 21:29:01 INFO - Running setup.py install for blessings 21:29:02 INFO - Successfully installed blessings 21:29:02 INFO - Cleaning up... 21:29:02 INFO - Return code: 0 21:29:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:02 INFO - Reading from file tmpfile_stdout 21:29:02 INFO - Current package versions: 21:29:02 INFO - argparse == 1.2.1 21:29:02 INFO - blessings == 1.6 21:29:02 INFO - blobuploader == 1.2.4 21:29:02 INFO - docopt == 0.6.1 21:29:02 INFO - functools32 == 3.2.3-2 21:29:02 INFO - jsonschema == 2.5.1 21:29:02 INFO - manifestparser == 1.1 21:29:02 INFO - mozInstall == 1.12 21:29:02 INFO - mozcrash == 0.17 21:29:02 INFO - mozdebug == 0.1 21:29:02 INFO - mozdevice == 0.48 21:29:02 INFO - mozfile == 1.2 21:29:02 INFO - mozhttpd == 0.7 21:29:02 INFO - mozinfo == 0.9 21:29:02 INFO - mozleak == 0.1 21:29:02 INFO - mozlog == 3.3 21:29:02 INFO - moznetwork == 0.27 21:29:02 INFO - mozprocess == 0.23 21:29:02 INFO - mozprofile == 0.28 21:29:02 INFO - mozrunner == 6.12 21:29:02 INFO - mozscreenshot == 0.1 21:29:02 INFO - mozsystemmonitor == 0.3 21:29:02 INFO - moztest == 0.7 21:29:02 INFO - mozversion == 1.4 21:29:02 INFO - psutil == 3.1.1 21:29:02 INFO - requests == 1.2.3 21:29:02 INFO - wsgiref == 0.1.2 21:29:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:02 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')]} 21:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:02 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')]} 21:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:02 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 0x7ff2be86ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1965370>, '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 0x19688f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1968d80>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', '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 21:29:02 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 21:29:02 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 21:29:02 INFO - Using env: {'DISPLAY': ':0', 21:29:02 INFO - 'HOME': '/home/cltbld', 21:29:02 INFO - 'LANG': 'en_US.UTF-8', 21:29:02 INFO - 'LANGUAGE': 'en_US:en', 21:29:02 INFO - 'LOGNAME': 'cltbld', 21:29:02 INFO - 'MAIL': '/var/mail/cltbld', 21:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:02 INFO - 'MOZ_NO_REMOTE': '1', 21:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:02 INFO - 'NO_EM_RESTART': '1', 21:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:02 INFO - 'PWD': '/builds/slave/test', 21:29:02 INFO - 'SHELL': '/bin/bash', 21:29:02 INFO - 'SHLVL': '1', 21:29:02 INFO - 'TERM': 'linux', 21:29:02 INFO - 'TMOUT': '86400', 21:29:02 INFO - 'USER': 'cltbld', 21:29:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', 21:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:02 INFO - '_': '/tools/buildbot/bin/python'} 21:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:02 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)) 21:29:02 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)) 21:29:02 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)) 21:29:02 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)) 21:29:02 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)) 21:29:02 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)) 21:29:02 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)) 21:29:02 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)) 21:29:02 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)) 21:29:02 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)) 21:29:02 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)) 21:29:02 INFO - Cleaning up... 21:29:02 INFO - Return code: 0 21:29:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:29:02 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')]} 21:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:02 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')]} 21:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:02 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 0x7ff2be86ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1965370>, '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 0x19688f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1968d80>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', '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 21:29:02 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 21:29:02 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 21:29:02 INFO - Using env: {'DISPLAY': ':0', 21:29:02 INFO - 'HOME': '/home/cltbld', 21:29:02 INFO - 'LANG': 'en_US.UTF-8', 21:29:02 INFO - 'LANGUAGE': 'en_US:en', 21:29:02 INFO - 'LOGNAME': 'cltbld', 21:29:02 INFO - 'MAIL': '/var/mail/cltbld', 21:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:02 INFO - 'MOZ_NO_REMOTE': '1', 21:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:02 INFO - 'NO_EM_RESTART': '1', 21:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:02 INFO - 'PWD': '/builds/slave/test', 21:29:02 INFO - 'SHELL': '/bin/bash', 21:29:02 INFO - 'SHLVL': '1', 21:29:02 INFO - 'TERM': 'linux', 21:29:02 INFO - 'TMOUT': '86400', 21:29:02 INFO - 'USER': 'cltbld', 21:29:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', 21:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:02 INFO - '_': '/tools/buildbot/bin/python'} 21:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:29:02 INFO - Cleaning up... 21:29:02 INFO - Return code: 0 21:29:02 INFO - Running post-action listener: _resource_record_post_action 21:29:02 INFO - Running post-action listener: _start_resource_monitoring 21:29:02 INFO - Starting resource monitoring. 21:29:02 INFO - [mozharness: 2016-08-13 04:29:02.828890Z] Finished create-virtualenv step (success) 21:29:02 INFO - [mozharness: 2016-08-13 04:29:02.829337Z] Running install step. 21:29:02 INFO - Running pre-action listener: _resource_record_pre_action 21:29:02 INFO - Running main action method: install 21:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:03 INFO - Reading from file tmpfile_stdout 21:29:03 INFO - Detecting whether we're running mozinstall >=1.0... 21:29:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:29:03 INFO - Reading from file tmpfile_stdout 21:29:03 INFO - Output received: 21:29:03 INFO - Usage: mozinstall [options] installer 21:29:03 INFO - Options: 21:29:03 INFO - -h, --help show this help message and exit 21:29:03 INFO - -d DEST, --destination=DEST 21:29:03 INFO - Directory to install application into. [default: 21:29:03 INFO - "/builds/slave/test"] 21:29:03 INFO - --app=APP Application being installed. [default: firefox] 21:29:03 INFO - mkdir: /builds/slave/test/build/application 21:29:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:29:20 INFO - Reading from file tmpfile_stdout 21:29:20 INFO - Output received: 21:29:20 INFO - /builds/slave/test/build/application/firefox/firefox 21:29:20 INFO - Running post-action listener: _resource_record_post_action 21:29:20 INFO - [mozharness: 2016-08-13 04:29:20.115743Z] Finished install step (success) 21:29:20 INFO - [mozharness: 2016-08-13 04:29:20.115984Z] Running run-tests step. 21:29:20 INFO - Running pre-action listener: _resource_record_pre_action 21:29:20 INFO - Running main action method: run_tests 21:29:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:29:20 INFO - Python 2.7.3 21:29:20 INFO - Return code: 0 21:29:20 INFO - grabbing minidump binary from tooltool 21:29:20 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')]} 21:29:20 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 0x1965370>, '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 0x19688f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1968d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:29:20 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 21:29:20 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 21:29:20 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 21:29:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:29:20 INFO - Return code: 0 21:29:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:29:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:29:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:29:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:29:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:29:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:29:20 INFO - Using env: {'DISPLAY': ':0', 21:29:20 INFO - 'HOME': '/home/cltbld', 21:29:20 INFO - 'LANG': 'en_US.UTF-8', 21:29:20 INFO - 'LANGUAGE': 'en_US:en', 21:29:20 INFO - 'LOGNAME': 'cltbld', 21:29:20 INFO - 'MAIL': '/var/mail/cltbld', 21:29:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:29:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:20 INFO - 'MOZ_NO_REMOTE': '1', 21:29:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:20 INFO - 'NO_EM_RESTART': '1', 21:29:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:20 INFO - 'PWD': '/builds/slave/test', 21:29:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:29:20 INFO - 'SHELL': '/bin/bash', 21:29:20 INFO - 'SHLVL': '1', 21:29:20 INFO - 'TERM': 'linux', 21:29:20 INFO - 'TMOUT': '86400', 21:29:20 INFO - 'USER': 'cltbld', 21:29:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917', 21:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:20 INFO - '_': '/tools/buildbot/bin/python'} 21:29:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:29:20 INFO - mozversion application_buildid: 20160812183004 21:29:20 INFO - mozversion application_changeset: bd22ef65b95cd84bc9fbef26309524b1f53a2263 21:29:20 INFO - mozversion application_display_name: Nightly 21:29:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:29:20 INFO - mozversion application_name: Firefox 21:29:20 INFO - mozversion application_remotingname: firefox 21:29:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:29:20 INFO - mozversion application_vendor: Mozilla 21:29:20 INFO - mozversion application_version: 51.0a1 21:29:20 INFO - mozversion platform_buildid: 20160812183004 21:29:20 INFO - mozversion platform_changeset: bd22ef65b95cd84bc9fbef26309524b1f53a2263 21:29:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:29:20 INFO - mozversion platform_version: 51.0a1 21:29:20 INFO - using testdate: 1471062560 21:29:20 INFO - actual date: 1471062560 21:29:20 INFO - starting webserver on 'localhost:38953' 21:29:20 INFO - SUITE-START | Running 2 tests 21:29:20 INFO - TEST-START | dromaeo_css 21:29:20 INFO - operating with platform_type : linux_ 21:29:20 INFO - Initialising browser for dromaeo_css test... 21:29:20 INFO - TEST-INFO | started process 7771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnCYaT_/profile http://localhost:38953/getInfo.html) 21:29:24 INFO - PROCESS | 7771 | __metrics Screen width/height:1600/1200 21:29:24 INFO - PROCESS | 7771 | colorDepth:24 21:29:24 INFO - PROCESS | 7771 | Browser inner width/height: 1024/697 21:29:24 INFO - PROCESS | 7771 | __metrics 21:29:25 INFO - PROCESS | 7771 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:29:25 INFO - PROCESS | 7771 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:29:26 INFO - TEST-INFO | 7771: exit 0 21:29:26 INFO - Browser initialized. 21:29:26 INFO - Running cycle 1/1 for dromaeo_css test... 21:29:26 INFO - TEST-INFO | started process 7851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnCYaT_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:29:37 INFO - PROCESS | 7851 | RSS: Main: 156147712 21:29:37 INFO - PROCESS | 7851 | 21:30:29 INFO - PROCESS | 7851 | 1471062629531 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] 21:32:38 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:38953/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38953/tests/dromaeo/cssquery-ext.html) 21:32:40 INFO - PROCESS | 7851 | RSS: Main: 269692928 21:32:40 INFO - PROCESS | 7851 | 21:35:42 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:38953/tests/dromaeo/cssquery-ext.html (next: http://localhost:38953/tests/dromaeo/cssquery-jquery.html) 21:35:43 INFO - PROCESS | 7851 | RSS: Main: 244576256 21:35:43 INFO - PROCESS | 7851 | 21:38:45 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:38953/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38953/tests/dromaeo/cssquery-mootools.html) 21:38:45 INFO - PROCESS | 7851 | RSS: Main: 243748864 21:38:45 INFO - PROCESS | 7851 | 21:41:47 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:38953/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38953/tests/dromaeo/cssquery-prototype.html) 21:41:48 INFO - PROCESS | 7851 | RSS: Main: 227901440 21:41:48 INFO - PROCESS | 7851 | 21:44:51 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:38953/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38953/tests/dromaeo/cssquery-yui.html) 21:44:51 INFO - PROCESS | 7851 | RSS: Main: 182272000 21:44:51 INFO - PROCESS | 7851 | 21:47:54 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:38953/tests/dromaeo/cssquery-yui.html (next: http://localhost:38953/tests/dromaeo/cssquery-dojo.html) 21:47:54 INFO - PROCESS | 7851 | RSS: Main: 274608128 21:47:54 INFO - PROCESS | 7851 | 21:47:54 INFO - PROCESS | 7851 | __start_tp_report 21:47:54 INFO - PROCESS | 7851 | _x_x_mozilla_page_load 21:47:54 INFO - PROCESS | 7851 | _x_x_mozilla_page_load_details 21:47:54 INFO - PROCESS | 7851 | |i|pagename|runs| 21:47:54 INFO - PROCESS | 7851 | |0;dojo.html;3090.582771325871;3112.828794416309;3120.1731541141594;3129.3897689950454;3131.5928929239194;5296.576273898088;5362.490563396481;5408.756605952732;5503.257060296859;5564.9721751391235;5404.054290499166;5455.699936503491;5471.042567550682;5517;5559.610827242094;4865.148598995171;4937.1606826839525;4949.381327334083;4968.180250258703;5122.462141475147;5026.346574945252;5055.115354812911;5058.165402708549;5080.74596270185;5085.1863701807715;4851.611871050325;4882.3408839806525;4895.143349913751;4984.202527595604;5024.321716568253;4879.048585525824;4899.093667671492;4902.240152776325;4946.356973593446;5004.274380214885;4896.387951506062;4930.6795058321095;4931.70409775411;4935.728534930578;4970.105381031413;4988.625853061035;5307.150855863082;5365.061114304981;5426.2674538937135;5506.504414602705;5861.6189947653265;5875.9118613220835;5876.471117599436;5892.292924849045;5916.497097746696;5771.047777116771;5933.703314834241;5950.672713000783;5951.047832346847;5953.3451320354725;5410.377806552218;5444.564434845242;5450.91823622646;5489.917651235235;5532.087205611029;6039.758409663652;6047.606905551125;6050.183225264621;6053.545984051214;6057.757689692451;5508.063629183049;5775.249217601769;5815.040518314515;5822.650640961556;5823.388544202798;5649.604527683023;5702.372738998707;5703.429657034263;5708.0010998076;5773.566982476331;5641.830745077655;5674;5674.120511320752;5683.460071293303;5685.886282274331;5616.241807356037;5713.914291285634;5765.106408506688;5770.913436298459;5778.219940308005;4368.7815609219415;4375.47494300686;4386.627136693417;4427.136708341843;4478.708883922534;3927.371620540757;3938.1139243669945;3940.310445671996;3969.146633473817;3971.622695843948;5523.917141242885;5531.972340138354;5538.778448862;5542.057850165482;5577.860553486195;5676.829695109153;5770.653760774367;5789.681567513743;5790.334111577138;5878.412158784173;5516.172574113915;5521.089020311684;5524.972375138099;5530.419305972815;5531.917021244684;5042.218456139304;5043.3191519145175;5063.316452278968;5065.088284108822;5083.38999320084;5810.331811841608;5984.521238300926;6079.939200608026;6082.635041897412;6122.093225952662;5916.674582897982;5919.289685237799;5920.615160014585;5923.555733319932;5948.078047902582;6049.758009679564;6091.5126789857595;6104.664243466652;6108.144859719731;6117.694115294128;5594.356648985256;5702.971485142713;5736.42635736423;5760.164776107357;5851.882962340645;5857.4435428634215;5896.498797602252;5902.498287645598;5902.881942361043;5907.645541267538;5728.112142617734;5752.741126649395;5755.597108202385;5757.424257574209;5757.596968212185;5561.916571251353;5641.661500309994;5648.943510564842;5678.77284908599;5777.248957635648;5658.20785090096;5660.632058916157;5660.716964151694;5661.858453538694;5662.292213473316;5754.9424505754405;5763.221965034667;5788.739506722123;5797.449242321973;5810.448007439287;5373.032854086302;5489.890202195854;5501.257330260363;5580.107182850725;5610.691411972218 21:47:54 INFO - PROCESS | 7851 | |1;ext.html;591.399729274786;594.9464548190664;598.9401059894009;608.504069183615;626.8338890194098;32799.032058076504;44003.33994990078;44212.77893610527;44979.77510112449;45217.773911130396;42093.36859947096;42979.3553096703;47401;47424;47526.76236618821;8111.229433203836;8960.193582577567;9095.863562046574;9109.544522773867;9111.22554582858;10567.524461399256;10811.35131892085;10815.513301901434;11194.160437967144;11194.440277986108;11104.111671066335;11218.214724969255;11225.045871100967;11233.550657973672;11236.831447528293;10980;11036.337819730761;11042.171837112168;11054.226204165712;11056.502457389397;10696.572137114506;10759.731006724895;10764.407957562331;10770;10771.138308935266;43426.782866085785;43616.563834361565;43730.78134609306;43739.78130109361;43776;3674.540682414698;3791.639794219572;3879.4180872869015;4069.2065047315787;4311.310190369526;34005.489917651255;34158;34470.482942755625;34648.30703385943;35851.64148358509;4231.576842315774;4276.18752437036;4392.824287028547;4487.775611219426;4499.797509112098;258766;259065;259506;260986;261040;61980.69009654923;62190.68904655448;62248.37751622516;62392;62431.6878415605;65683.67158164179;65801.67099164473;65886.67056664686;65913;65951.67024164849;17305.7404138938;17506.387276445264;17546.824531754773;17556.912215438842;17563;13516.459341626225;13545.45818167282;13629.863701363058;13665.658358541115;13674.453021879013;17173.98655691069;18469.168887400097;18583.90708046478;18619.906900465412;18746.343877964206;6675.899861502081;6923.318997167657;7043.225245223021;7107;7114.288571142844;947.9951251673249;1005.4118340770585;1019.2559431614962;1125.9191176470517;1164.67971307891;31200.68799311978;33316.50025249623;33456.49815252773;33587.66412335894;34298;1098.2312381332938;1133.393634405589;1178.552150182925;1196.6529706385224;1249.1568191470722;17332.480025599252;17342.393016244372;17426.738598921027;17641.823581764274;17679.823201767816;581580;585108;585584;586188;586508;61202;61400.07899881505;61440.07839882405;61442;61620.69189654023;1246.2647038247478;1357.3756072206697;1388.0353154557688;1407.4440595964536;1425.102185623051;32067.18152508079;33730.831345843115;34361.82819085888;34429;34451.483227752105;51707.33655497436;52534.73732631312;52578;52596.474035259154;52642.47357526376;423874;425178;426169;426232;426588;35923.640763592026;41230.587694123875;41300.38049429201;41404.58595414007;43167.35248971331;49105;50212.24681629852;50331.24503132529;50784.74607626938;50921.49078509167;41676;41747.7912610435;41980;42291.36562951496;43934.56065439305;41463.37804932868;42212;42618.57381426146;43465.565344347415;43664.56335436732;42413;42526.362104569074;42792.786036070866;42893.14213715646;43737.78131109324;35842.64157358393;37832.190205763225;38187.80906095452;38935.80532097322;39085.609143909336;27122.18633441;27803.44393112086;28102.85948570244;28302;28418.573721393783 21:47:54 INFO - PROCESS | 7851 | |2;jquery.html;393.3391901605302;400.9498812648419;404.3368875044926;408.92639324921515;418.36408658838565;13944.233067181302;19503.902480487595;20390.388288351354;20401.693974590373;21211.151553937823;15389.615259618515;18342.908285458587;18830.435086947415;18925.810741892576;19711.901440492813;5633.8591535211535;5819.62172458791;5838.766449342022;5840.649561026331;5843.561732870031;5638.984982703132;5656.095024796034;5712.428757124296;5757.654540727549;5782.82651520453;5704.828855134353;5709.286339207599;5713.3429655589725;5716.742746576414;5717.399673034334;5606.271184745998;5701.401352857953;5715.971420142893;5728.255326807488;5757.136429535603;5170.302009228782;5183.144781111112;5192.480751924815;5194.27280180775;5197.558207552363;23300;23893.522129557485;24061.87969060161;24353.391165220833;24362.26913192607;2433.476802487456;2492;2506.6616006839026;2711.200195942202;2900.7534359579463;10187.134093602053;10680.198985076151;10708.30396024256;10739.463026848705;10791.244612877103;1910.9904450477798;1941.669916114264;1948.2109745553073;1950.5708744076423;1963.7250784890127;79452;83205.58397208036;83869.16130838735;84070.57964710199;84611.5769421149;10887.891121088687;11058.502367393487;11128.944355278172;11130.554777808797;11378.658640240807;15551.922240388725;15576.532704018897;15613.76579351288;15623.843761562466;15628.296726647328;8326.625301861432;8463.195996380457;8495.490270583661;8617.827643447095;8685.305175585938;7900.328472079823;8070;8093.312068474245;8140.226678465537;8461.873071903927;4455.933161002587;4608.769561521911;4855.32025516428;4905.484924082992;4939.975300123549;1941.3690550570839;1963.9901800490907;1993.312307254024;2010.6782914733571;2095.130520833867;882.5543100734088;965.6330594374093;971.9951400242953;984.8621193032981;1011.2567263061644;18183.272669093087;18342.816571834377;19028.238870445304;20507.8974605129;20522.58954820895;944.1266828183902;959.4003747657714;985.7239972807625;993.9155171810477;1019.607451131305;9490.715278541516;11167.38579378142;11234.166194015728;11350.54597816078;11424.543018279343;497546;500592;515469;528242;531080;89989.55005224932;90237;90320.54839725759;90758.54620726855;92039.53980230055;1007.7128018514835;1034.4310629153936;1067.108964015056;1069.5133714160038;1072.2976450424828;17562.473125806246;17868.55328616795;18538.721919171494;18539.81460185381;18597.163127659016;43348;43794.34308485311;44795.32807007832;45115.097698045196;45723;55971;56569.71715141563;59690;59729.28933452037;61420.692896535234;8269.751907442786;8407.621657025571;8761.956190219264;8801.779955501164;8878.289736821169;9704.320697551104;12348.691282718004;12799.936000320311;13110.541131060367;13876.098053626481;11804.881951180378;11810;11907.52369905194;12061.879381206076;12091.214071085351;11491.253068550517;11541;11545.076393888301;11662.358570278717;11759.706007349885;11599.188056835941;11985;12019.75960480768;12190.146689731633;12224.511019559119;8601.569921504026;8681.262092721936;8762.824743505222;9028.954855225682;9052.456852588866;10953.671389858317;11397.316161030365;11402.657920262405;11642.76714465723;11643.705983723492 21:47:54 INFO - PROCESS | 7851 | |3;mootools.html;1324.3576865220361;1471.7056588682265;1474.5797447727393;1606.9196540172995;1762.7620271263377;8292.585370731462;8587.184217499344;8699.652013919436;8746.60640271187;8811.162939520751;8433.19884610961;8596.656133754643;8801.16388943051;8808.955955220215;8812.559372031388;2136.465883529118;2388.8088952883813;2395.4729959408946;2474.5916923707655;2481.3176376496517;2436.47615762611;2472.0235506974736;2474.616434452663;2478.10788116278;2478.4175718706088;2415.5408776165814;2432.3067925641194;2432.671589335435;2451.595486744685;2466.691663542057;2360.1975328388344;2360.3627020704484;2366.148186652804;2373.098222675372;2453.1291391556097;2415.118481754147;2455.8772061396858;2474.9133780317784;2479.590867506859;2481.702195736505;8747.518886461243;8940.776480587972;8944.10558944107;8949.284057275403;8953.776155596097;5354.330708661418;5490.533304669108;5494.148406996922;5501.284832971688;5501.449855014506;3429.879954201616;3443.139215196201;3467.878624248139;3477.426224672926;3488.8081155536433;1204.0728638948049;1206.8913797758244;1208.6192849252457;1226.4051934811698;1237.85764637067;12446;12593.37033148339;12628.621141365773;12659.493620255178;12662.683432914158;4784.162771514971;4792.257200133985;4926.802927882844;5019.343616606511;5026.170681837456;10681.786364272672;10687.679369618923;10690.679279621623;10693.83959240612;10695.304805187638;5553.805616803393;5566.192902029264;5574.721263936787;5584.246126772834;5584.720763961785;4316.762578058237;4567.680262381601;4900.705957642482;5005.174146265826;5138.023775482647;4088.7342322748927;4090.406891000788;4124.91750164995;4189.91620167601;4204.276246738884;1294.4822071171607;1342.4428862022346;1352.5130952856964;1359.6736783171968;1373.176094343386;908.6320040383655;959.5250351076122;970.9029097090234;1008.0423597582326;1038.4392428088747;5931.228940237827;6146.7233974471255;6170.475509581735;6185.628862268279;6335.4931605472375;980.5489474841653;991.1822746234242;994.4778991029767;1011.231464087299;1015.0914931136739;4100.487439070116;4272.230998420314;4289.227938971015;4292.549282325311;4462.910741785211;11048.281861678965;11344.205905586694;11454.026407755435;11460.713482162846;11467.369294688871;10979.725506862393;11093.667189984151;11343.716407089889;11353.716157095974;11489.42552872353;8205.71280005197;8316.584170791557;8326.167383261747;8422.115677853859;8428.662853485914;6059.878802423838;6301.951865643592;6315.336889626523;6386.648734319657;6398.264199617103;10333.638322658671;10570;10572;10585.52365143555;10591.099756520782;10154.695359139238;10477.895221047997;10529.842052369067;10650.680479585624;10651.934806519286;6940.583564986117;7149;7152.427805775422;7866.567338796421;8067.620052084531;7771.611419429119;8368.079511253636;8669.436486628349;8710.041895391629;8809.42738721981;7704.537727736354;7874.291313781787;7925.167857374892;7957.084935232291;7984.840303193788;7661.080670319598;7724.691012359667;7736.226377362219;7746.30283274508;7894.052713674396;7071.186813516511;7161;7164.176119746296;7165.7850264492145;7170.820729481805;5200.063988482109;5235.345581802275;5265.6840589564745;5277.313949186735;5497.587680923867;5261.684298942076;5277.234800953764;5322.201669749568;5387.595930305164;5447.809326673548 21:47:54 INFO - PROCESS | 7851 | |4;prototype.html;337.59825807289326;340.06651740971034;350.78777339709467;352.23213394799325;354.41344574728816;5350.491703288191;5364.892702145955;5395.163749618806;5403.459654034599;5421.7289135543215;5063.46833582474;5109.6678715883445;5174.826572839407;5183.403908550517;5298.417174110845;4066.755994640316;4129.566395528472;4135.545090040093;4161.0429601191745;4184.665226781865;4126.628603425691;4179.832806687728;4191.685623578229;4192.706510544248;4220.514640816299;4084.264832330179;4140.461739973799;4141.4409054777525;4148.419221309019;4186.476690413699;4145.108801607638;4146.673064619323;4156.937645935313;4163.417121602978;4189.455370801791;3685.7051435885064;3689.8155092245547;3695.7782533048103;3712.3317802795486;3744.895255899516;5025.824096156617;5210.791568337262;5260.184671375943;5265.815696450644;5279.128943724281;4736.786844591968;4752.6910750801435;4759.452662943771;4796.345260884989;4807.975960120212;5487.42382049887;5490.176473528963;5511.917321240185;5528.655163625988;5533.667979921218;3972.3842804365368;4023.3160362738404;4056.59434056592;4071.9592804071876;4079.3473044313064;5589.832305030855;5645.8588535286535;5652.8869422611315;5674.716264186815;5675.801346952878;4144.212599606065;4163.854939891554;4164.208800327928;4167.416561681367;4182.393552934807;4059.715819892579;4213.325867861127;4223.598758117974;4231.894202644959;4232.936505952413;4718.598919091847;4719.560534037083;4738.076075165379;4748.6438517111355;4765.8570242892765;5530.917036244459;5534.4742249486235;5597.076482380443;5606.355269144101;5615.606907516516;1350.162899002605;1454.9233567160436;1456.7523521001456;1465.9633509162143;1471.8740163774721;1009.2388781576196;1027.6146445083093;1034.0900007992918;1042.2704107125044;1052.8997197928184;5333.493318134771;5385.353757549119;5385.892282154335;5390.730463476811;5392.91910621341;5487.64330318528;5614.522765564972;5621.959937411592;5664.716764161775;5683.6643388803595;5323.600729945269;5334.813281535127;5338.412774594792;5371.919421208685;5383.246345511631;2981.86581603824;2991.6110905582136;2991.6836591899496;3005.8797648093832;3012.2619958110404;5619.325680918234;5794.565407594363;5807.5644326675665;5860.941390586125;5885.588008839426;5734.655920644775;5736.598438109292;5759.625624334405;5761;5772.5959182856795;5785.119836053215;5826.359100498942;5848.5321174305955;5855.795047173328;5874.412558744091;5421.647592906448;5643.266375371176;5700.657960522382;5702.315722113373;5705.4009329019855;5674.0354139797155;5679.261695979496;5692.7722891083895;5705.771769129355;5742.942570574241;5741.91387129185;5960.403959604005;5961.821145365646;5969.9701501493955;5977;4043.8180281887976;4049.3521036633997;4056.634902858757;4060.3503439449546;4061.6750659947725;5760.049591817471;5772.278465191851;5824.737886795189;5828.271466066742;5831.475167234969;5493.835184944458;5564.134470747649;5572.85756419941;5590.329160500766;5696.0316746154085;5560.526460487893;5563.221149039218;5565.30433695788;5567.443255674562;5576.275084239023;5296.126139187145;5391.892162156813;5474.2062400950845;5532.336119665505;5533.837894042296;5561.332640083216;5584.636998595079;5591.65800207939;5600.171913183979;5610.100979818987;5454.263674404064;5473.425290344457;5480.205370221375;5575.498205161555;5582.7766889323975 21:47:54 INFO - PROCESS | 7851 | |5;yui.html;713.464901324007;742.907136607924;791.8416316736655;811.2131232704282;816.9019717633885;15289.923550382246;15531.689366212682;15626.29681664325;15754.369825206977;15818.920905395471;15124.924375378136;15490.380384784596;15636.530904072868;15650.217489125554;15701.84298157018;808.9271965523087;824.4476200945381;825.5005721538473;825.6738588257634;825.8513467575834;675.6284043775928;800.6957356204634;826.6197549127409;826.6817275348974;830.6096134816627;857.5797859049052;862.7411776467067;863.2748491267334;864.3733293362325;864.7189663359402;854.2695994924312;854.6837670062055;854.9145085491464;855.0380821575727;855.1662129423825;513.0380536494074;603.9849003774897;620.0729908786349;620.2742790934617;622.9875402491925;14977.700445991128;15015.549533514011;15025.549233523012;15035.173065481395;15039.849601503955;14467.92766036163;14814.259287035606;15146.697066058727;15290.311935962909;15291.464798732102;13366.933165334209;13396;13506.459741610324;13532.391042403115;13576.1854288743;4307.095509942916;4372.650187984954;4406;4458.554144585515;4498.685092043558;80729;81269;81519;81757;84167.5791621044;11592.304461732323;11613.419329033515;11713.631464179145;11869.940650296694;12055.156139070355;22292.777072229394;22296.442588935406;22481.325560232894;22867.542649146922;23249.3025209244;8320.875186872201;8841.071687472851;8961.804357932218;9017.368784185044;9080.909190908007;4551.931721024187;4660.673752837269;4809.422869255712;4830.420349558005;5003.399592048904;3642.7450078494253;3719.2189640175866;3724.6647801697977;3751.981240093782;3757.5866654667966;571.2060236271586;574.5432381256911;581.4011568084879;590.4538302070567;594.2186025376616;527.5673947363202;536.0913252037836;620.2472071536534;621.7626922424344;665.2748504130521;9143.634254629873;9184.265258779282;9560.952195239119;9611.423314601147;9764.414135151772;597.3727586034646;669.7053296549502;679.6533767778468;687.656171914043;687.691612050504;4118.382242663564;4548.727076375428;4555.180067587799;4592.425946756655;4632.2819962905805;96836.51581742187;97122;118402.15978402263;128170.35914820366;129315;95189.52405238069;95649.52175239219;96345.5182724096;96793;97659;70083;71632.2836771636;74401;74883.25116748763;80453;9137.451752894847;9384.765380865532;9405.905940940504;9619;9876.308658393844;50647.74676126596;52164;52947.20579191238;53262.73368633287;54715;52047;72957;73855.63072184604;74256.62871685607;76645;12822.358882056047;13186.208827470382;13335.66660833487;13469.865301347254;14237.572872813833;14252.21612811264;14278.071925325235;14320.713585728436;14424;16298.42955496552;13678.86321136776;13922.72154556883;14310.928445358122;15046.247687615794;15067.773983390038;13696.109752866032;13999.16005039701;14303.141811491343;14382.496612618508;14572.85427145715;13400.731985360433;13401.770997807567;13417.66455838612;13606.183628982293;14101.365438555085;10731.946340268249;11449.255798373079;11703;12145.817812732992;12477.93761031189;11616.128790340927;11697.649070527897;11759.706007349885;11807.881921180679;11954.641360759191 21:47:54 INFO - PROCESS | 7851 | __end_tp_report 21:47:54 INFO - PROCESS | 7851 | __start_cc_report 21:47:54 INFO - PROCESS | 7851 | _x_x_mozilla_cycle_collect,995 21:47:54 INFO - PROCESS | 7851 | __end_cc_report 21:47:54 INFO - PROCESS | 7851 | __startTimestamp1471063674783__endTimestamp 21:47:54 INFO - PROCESS | 7851 | 21:47:54 INFO - PROCESS | 7851 | ------- Summary: start ------- 21:47:54 INFO - PROCESS | 7851 | Number of tests: 6 21:47:54 INFO - PROCESS | 7851 | 21:47:54 INFO - PROCESS | 7851 | [#0] dojo.html Cycles:165 Average:5412.72 Median:5610.69 stddev:627.86 (11.2%) stddev-sans-first:602.78 21:47:54 INFO - PROCESS | 7851 | Values: 3090.6 3112.8 3120.2 3129.4 3131.6 5296.6 5362.5 5408.8 5503.3 5565.0 5404.1 5455.7 5471.0 5517.0 5559.6 4865.1 4937.2 4949.4 4968.2 5122.5 5026.3 5055.1 5058.2 5080.7 5085.2 4851.6 4882.3 4895.1 4984.2 5024.3 4879.0 4899.1 4902.2 4946.4 5004.3 4896.4 4930.7 4931.7 4935.7 4970.1 4988.6 5307.2 5365.1 5426.3 5506.5 5861.6 5875.9 5876.5 5892.3 5916.5 5771.0 5933.7 5950.7 5951.0 5953.3 5410.4 5444.6 5450.9 5489.9 5532.1 6039.8 6047.6 6050.2 6053.5 6057.8 5508.1 5775.2 5815.0 5822.7 5823.4 5649.6 5702.4 5703.4 5708.0 5773.6 5641.8 5674.0 5674.1 5683.5 5685.9 5616.2 5713.9 5765.1 5770.9 5778.2 4368.8 4375.5 4386.6 4427.1 4478.7 3927.4 3938.1 3940.3 3969.1 3971.6 5523.9 5532.0 5538.8 5542.1 5577.9 5676.8 5770.7 5789.7 5790.3 5878.4 5516.2 5521.1 5525.0 5530.4 5531.9 5042.2 5043.3 5063.3 5065.1 5083.4 5810.3 5984.5 6079.9 6082.6 6122.1 5916.7 5919.3 5920.6 5923.6 5948.1 6049.8 6091.5 6104.7 6108.1 6117.7 5594.4 5703.0 5736.4 5760.2 5851.9 5857.4 5896.5 5902.5 5902.9 5907.6 5728.1 5752.7 5755.6 5757.4 5757.6 5561.9 5641.7 5648.9 5678.8 5777.2 5658.2 5660.6 5660.7 5661.9 5662.3 5754.9 5763.2 5788.7 5797.4 5810.4 5373.0 5489.9 5501.3 5580.1 5610.7 21:47:54 INFO - PROCESS | 7851 | 21:47:54 INFO - PROCESS | 7851 | [#1] ext.html Cycles:180 Average:60257.21 Median:41265.48 stddev:117918.48 (285.8%) stddev-sans-first:118164.17 21:47:54 INFO - PROCESS | 7851 | Values: 591.4 594.9 598.9 608.5 626.8 32799.0 44003.3 44212.8 44979.8 45217.8 42093.4 42979.4 47401.0 47424.0 47526.8 8111.2 8960.2 9095.9 9109.5 9111.2 10567.5 10811.4 10815.5 11194.2 11194.4 11104.1 11218.2 11225.0 11233.6 11236.8 10980.0 11036.3 11042.2 11054.2 11056.5 10696.6 10759.7 10764.4 10770.0 10771.1 43426.8 43616.6 43730.8 43739.8 43776.0 3674.5 3791.6 3879.4 4069.2 4311.3 34005.5 34158.0 34470.5 34648.3 35851.6 4231.6 4276.2 4392.8 4487.8 4499.8 258766.0 259065.0 259506.0 260986.0 261040.0 61980.7 62190.7 62248.4 62392.0 62431.7 65683.7 65801.7 65886.7 65913.0 65951.7 17305.7 17506.4 17546.8 17556.9 17563.0 13516.5 13545.5 13629.9 13665.7 13674.5 17174.0 18469.2 18583.9 18619.9 18746.3 6675.9 6923.3 7043.2 7107.0 7114.3 948.0 1005.4 1019.3 1125.9 1164.7 31200.7 33316.5 33456.5 33587.7 34298.0 1098.2 1133.4 1178.6 1196.7 1249.2 17332.5 17342.4 17426.7 17641.8 17679.8 581580.0 585108.0 585584.0 586188.0 586508.0 61202.0 61400.1 61440.1 61442.0 61620.7 1246.3 1357.4 1388.0 1407.4 1425.1 32067.2 33730.8 34361.8 34429.0 34451.5 51707.3 52534.7 52578.0 52596.5 52642.5 423874.0 425178.0 426169.0 426232.0 426588.0 35923.6 41230.6 41300.4 41404.6 43167.4 49105.0 50212.2 50331.2 50784.7 50921.5 41676.0 41747.8 41980.0 42291.4 43934.6 41463.4 42212.0 42618.6 43465.6 43664.6 42413.0 42526.4 42792.8 42893.1 43737.8 35842.6 37832.2 38187.8 38935.8 39085.6 27122.2 27803.4 28102.9 28302.0 28418.6 21:47:54 INFO - PROCESS | 7851 | 21:47:54 INFO - PROCESS | 7851 | [#2] jquery.html Cycles:180 Average:29857.99 Median:397.14 stddev:84765.87 (21343.8%) stddev-sans-first:84974.79 21:47:54 INFO - PROCESS | 7851 | Values: 393.3 400.9 404.3 408.9 418.4 13944.2 19503.9 20390.4 20401.7 21211.2 15389.6 18342.9 18830.4 18925.8 19711.9 5633.9 5819.6 5838.8 5840.6 5843.6 5639.0 5656.1 5712.4 5757.7 5782.8 5704.8 5709.3 5713.3 5716.7 5717.4 5606.3 5701.4 5716.0 5728.3 5757.1 5170.3 5183.1 5192.5 5194.3 5197.6 23300.0 23893.5 24061.9 24353.4 24362.3 2433.5 2492.0 2506.7 2711.2 2900.8 10187.1 10680.2 10708.3 10739.5 10791.2 1911.0 1941.7 1948.2 1950.6 1963.7 79452.0 83205.6 83869.2 84070.6 84611.6 10887.9 11058.5 11128.9 11130.6 11378.7 15551.9 15576.5 15613.8 15623.8 15628.3 8326.6 8463.2 8495.5 8617.8 8685.3 7900.3 8070.0 8093.3 8140.2 8461.9 4455.9 4608.8 4855.3 4905.5 4940.0 1941.4 1964.0 1993.3 2010.7 2095.1 882.6 965.6 972.0 984.9 1011.3 18183.3 18342.8 19028.2 20507.9 20522.6 944.1 959.4 985.7 993.9 1019.6 9490.7 11167.4 11234.2 11350.5 11424.5 497546.0 500592.0 515469.0 528242.0 531080.0 89989.6 90237.0 90320.5 90758.5 92039.5 1007.7 1034.4 1067.1 1069.5 1072.3 17562.5 17868.6 18538.7 18539.8 18597.2 43348.0 43794.3 44795.3 45115.1 45723.0 55971.0 56569.7 59690.0 59729.3 61420.7 8269.8 8407.6 8762.0 8801.8 8878.3 9704.3 12348.7 12799.9 13110.5 13876.1 11804.9 11810.0 11907.5 12061.9 12091.2 11491.3 11541.0 11545.1 11662.4 11759.7 11599.2 11985.0 12019.8 12190.1 12224.5 8601.6 8681.3 8762.8 9029.0 9052.5 10953.7 11397.3 11402.7 11642.8 11643.7 21:47:54 INFO - PROCESS | 7851 | 21:47:54 INFO - PROCESS | 7851 | [#3] mootools.html Cycles:180 Average:5946.29 Median:4675.92 stddev:3355.24 (71.8%) stddev-sans-first:3346.67 21:47:54 INFO - PROCESS | 7851 | Values: 1324.4 1471.7 1474.6 1606.9 1762.8 8292.6 8587.2 8699.7 8746.6 8811.2 8433.2 8596.7 8801.2 8809.0 8812.6 2136.5 2388.8 2395.5 2474.6 2481.3 2436.5 2472.0 2474.6 2478.1 2478.4 2415.5 2432.3 2432.7 2451.6 2466.7 2360.2 2360.4 2366.1 2373.1 2453.1 2415.1 2455.9 2474.9 2479.6 2481.7 8747.5 8940.8 8944.1 8949.3 8953.8 5354.3 5490.5 5494.1 5501.3 5501.4 3429.9 3443.1 3467.9 3477.4 3488.8 1204.1 1206.9 1208.6 1226.4 1237.9 12446.0 12593.4 12628.6 12659.5 12662.7 4784.2 4792.3 4926.8 5019.3 5026.2 10681.8 10687.7 10690.7 10693.8 10695.3 5553.8 5566.2 5574.7 5584.2 5584.7 4316.8 4567.7 4900.7 5005.2 5138.0 4088.7 4090.4 4124.9 4189.9 4204.3 1294.5 1342.4 1352.5 1359.7 1373.2 908.6 959.5 970.9 1008.0 1038.4 5931.2 6146.7 6170.5 6185.6 6335.5 980.5 991.2 994.5 1011.2 1015.1 4100.5 4272.2 4289.2 4292.5 4462.9 11048.3 11344.2 11454.0 11460.7 11467.4 10979.7 11093.7 11343.7 11353.7 11489.4 8205.7 8316.6 8326.2 8422.1 8428.7 6059.9 6302.0 6315.3 6386.6 6398.3 10333.6 10570.0 10572.0 10585.5 10591.1 10154.7 10477.9 10529.8 10650.7 10651.9 6940.6 7149.0 7152.4 7866.6 8067.6 7771.6 8368.1 8669.4 8710.0 8809.4 7704.5 7874.3 7925.2 7957.1 7984.8 7661.1 7724.7 7736.2 7746.3 7894.1 7071.2 7161.0 7164.2 7165.8 7170.8 5200.1 5235.3 5265.7 5277.3 5497.6 5261.7 5277.2 5322.2 5387.6 5447.8 21:47:54 INFO - PROCESS | 7851 | 21:47:54 INFO - PROCESS | 7851 | [#4] prototype.html Cycles:180 Average:4696.74 Median:5357.69 stddev:1360.90 (25.4%) stddev-sans-first:1324.80 21:47:54 INFO - PROCESS | 7851 | Values: 337.6 340.1 350.8 352.2 354.4 5350.5 5364.9 5395.2 5403.5 5421.7 5063.5 5109.7 5174.8 5183.4 5298.4 4066.8 4129.6 4135.5 4161.0 4184.7 4126.6 4179.8 4191.7 4192.7 4220.5 4084.3 4140.5 4141.4 4148.4 4186.5 4145.1 4146.7 4156.9 4163.4 4189.5 3685.7 3689.8 3695.8 3712.3 3744.9 5025.8 5210.8 5260.2 5265.8 5279.1 4736.8 4752.7 4759.5 4796.3 4808.0 5487.4 5490.2 5511.9 5528.7 5533.7 3972.4 4023.3 4056.6 4072.0 4079.3 5589.8 5645.9 5652.9 5674.7 5675.8 4144.2 4163.9 4164.2 4167.4 4182.4 4059.7 4213.3 4223.6 4231.9 4232.9 4718.6 4719.6 4738.1 4748.6 4765.9 5530.9 5534.5 5597.1 5606.4 5615.6 1350.2 1454.9 1456.8 1466.0 1471.9 1009.2 1027.6 1034.1 1042.3 1052.9 5333.5 5385.4 5385.9 5390.7 5392.9 5487.6 5614.5 5622.0 5664.7 5683.7 5323.6 5334.8 5338.4 5371.9 5383.2 2981.9 2991.6 2991.7 3005.9 3012.3 5619.3 5794.6 5807.6 5860.9 5885.6 5734.7 5736.6 5759.6 5761.0 5772.6 5785.1 5826.4 5848.5 5855.8 5874.4 5421.6 5643.3 5700.7 5702.3 5705.4 5674.0 5679.3 5692.8 5705.8 5742.9 5741.9 5960.4 5961.8 5970.0 5977.0 4043.8 4049.4 4056.6 4060.4 4061.7 5760.0 5772.3 5824.7 5828.3 5831.5 5493.8 5564.1 5572.9 5590.3 5696.0 5560.5 5563.2 5565.3 5567.4 5576.3 5296.1 5391.9 5474.2 5532.3 5533.8 5561.3 5584.6 5591.7 5600.2 5610.1 5454.3 5473.4 5480.2 5575.5 5582.8 21:47:54 INFO - PROCESS | 7851 | 21:47:54 INFO - PROCESS | 7851 | [#5] yui.html Cycles:180 Average:20658.12 Median:4819.92 stddev:29180.51 (605.4%) stddev-sans-first:29223.94 21:47:54 INFO - PROCESS | 7851 | Values: 713.5 742.9 791.8 811.2 816.9 15289.9 15531.7 15626.3 15754.4 15818.9 15124.9 15490.4 15636.5 15650.2 15701.8 808.9 824.4 825.5 825.7 825.9 675.6 800.7 826.6 826.7 830.6 857.6 862.7 863.3 864.4 864.7 854.3 854.7 854.9 855.0 855.2 513.0 604.0 620.1 620.3 623.0 14977.7 15015.5 15025.5 15035.2 15039.8 14467.9 14814.3 15146.7 15290.3 15291.5 13366.9 13396.0 13506.5 13532.4 13576.2 4307.1 4372.7 4406.0 4458.6 4498.7 80729.0 81269.0 81519.0 81757.0 84167.6 11592.3 11613.4 11713.6 11869.9 12055.2 22292.8 22296.4 22481.3 22867.5 23249.3 8320.9 8841.1 8961.8 9017.4 9080.9 4551.9 4660.7 4809.4 4830.4 5003.4 3642.7 3719.2 3724.7 3752.0 3757.6 571.2 574.5 581.4 590.5 594.2 527.6 536.1 620.2 621.8 665.3 9143.6 9184.3 9561.0 9611.4 9764.4 597.4 669.7 679.7 687.7 687.7 4118.4 4548.7 4555.2 4592.4 4632.3 96836.5 97122.0 118402.2 128170.4 129315.0 95189.5 95649.5 96345.5 96793.0 97659.0 70083.0 71632.3 74401.0 74883.3 80453.0 9137.5 9384.8 9405.9 9619.0 9876.3 50647.7 52164.0 52947.2 53262.7 54715.0 52047.0 72957.0 73855.6 74256.6 76645.0 12822.4 13186.2 13335.7 13469.9 14237.6 14252.2 14278.1 14320.7 14424.0 16298.4 13678.9 13922.7 14310.9 15046.2 15067.8 13696.1 13999.2 14303.1 14382.5 14572.9 13400.7 13401.8 13417.7 13606.2 14101.4 10731.9 11449.3 11703.0 12145.8 12477.9 11616.1 11697.6 11759.7 11807.9 11954.6 21:47:54 INFO - PROCESS | 7851 | -------- Summary: end -------- 21:47:54 INFO - PROCESS | 7851 | 21:47:55 INFO - TEST-INFO | 7851: exit 0 21:47:55 INFO - TEST-OK | dromaeo_css | took 1115165ms 21:47:55 INFO - TEST-START | kraken 21:47:55 INFO - operating with platform_type : linux_ 21:47:55 INFO - Initialising browser for kraken test... 21:47:55 INFO - TEST-INFO | started process 8152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeZan7s/profile http://localhost:38953/getInfo.html) 21:47:59 INFO - PROCESS | 8152 | __metrics Screen width/height:1600/1200 21:47:59 INFO - PROCESS | 8152 | colorDepth:24 21:47:59 INFO - PROCESS | 8152 | Browser inner width/height: 1024/697 21:47:59 INFO - PROCESS | 8152 | __metrics 21:48:00 INFO - PROCESS | 8152 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:48:00 INFO - PROCESS | 8152 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:48:00 INFO - PROCESS | 8152 | console.error: PushService: 21:48:00 INFO - PROCESS | 8152 | stateChangeProcessEnqueue: Error transitioning state 21:48:00 INFO - PROCESS | 8152 | UnknownError 21:48:01 INFO - TEST-INFO | 8152: exit 0 21:48:01 INFO - Browser initialized. 21:48:01 INFO - Running cycle 1/1 for kraken test... 21:48:01 INFO - TEST-INFO | started process 8235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeZan7s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:48:13 INFO - PROCESS | 8235 | RSS: Main: 155971584 21:48:13 INFO - PROCESS | 8235 | 21:48:15 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38953/tests/kraken/driver.html?testName=audio-beat-detection) 21:48:16 INFO - PROCESS | 8235 | RSS: Main: 204140544 21:48:16 INFO - PROCESS | 8235 | 21:48:19 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38953/tests/kraken/driver.html?testName=audio-dft) 21:48:19 INFO - PROCESS | 8235 | RSS: Main: 195305472 21:48:19 INFO - PROCESS | 8235 | 21:48:22 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38953/tests/kraken/driver.html?testName=audio-fft) 21:48:23 INFO - PROCESS | 8235 | RSS: Main: 275894272 21:48:23 INFO - PROCESS | 8235 | 21:48:25 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38953/tests/kraken/driver.html?testName=audio-oscillator) 21:48:26 INFO - PROCESS | 8235 | RSS: Main: 186400768 21:48:26 INFO - PROCESS | 8235 | 21:48:28 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38953/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:48:29 INFO - PROCESS | 8235 | RSS: Main: 190668800 21:48:29 INFO - PROCESS | 8235 | 21:48:32 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38953/tests/kraken/driver.html?testName=imaging-darkroom) 21:48:32 INFO - PROCESS | 8235 | RSS: Main: 226123776 21:48:32 INFO - PROCESS | 8235 | 21:48:35 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38953/tests/kraken/driver.html?testName=imaging-desaturate) 21:48:36 INFO - PROCESS | 8235 | RSS: Main: 226103296 21:48:36 INFO - PROCESS | 8235 | 21:48:39 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38953/tests/kraken/driver.html?testName=json-parse-financial) 21:48:40 INFO - PROCESS | 8235 | RSS: Main: 226385920 21:48:40 INFO - PROCESS | 8235 | 21:48:41 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38953/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:48:42 INFO - PROCESS | 8235 | RSS: Main: 188465152 21:48:42 INFO - PROCESS | 8235 | 21:48:43 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38953/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:48:44 INFO - PROCESS | 8235 | RSS: Main: 196161536 21:48:44 INFO - PROCESS | 8235 | 21:48:46 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38953/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:48:47 INFO - PROCESS | 8235 | RSS: Main: 192827392 21:48:47 INFO - PROCESS | 8235 | 21:48:49 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:48:50 INFO - PROCESS | 8235 | RSS: Main: 187236352 21:48:50 INFO - PROCESS | 8235 | 21:48:53 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:48:53 INFO - PROCESS | 8235 | RSS: Main: 192118784 21:48:53 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | Cycle 1(1): loaded http://localhost:38953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38953/tests/kraken/driver.html?testName=ai-astar) 21:48:55 INFO - PROCESS | 8235 | RSS: Main: 242704384 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | __start_tp_report 21:48:55 INFO - PROCESS | 8235 | _x_x_mozilla_page_load 21:48:55 INFO - PROCESS | 8235 | _x_x_mozilla_page_load_details 21:48:55 INFO - PROCESS | 8235 | |i|pagename|runs| 21:48:55 INFO - PROCESS | 8235 | |0;ai-astar;104;112;113;112;110;111;112;112;114;112 21:48:55 INFO - PROCESS | 8235 | |1;audio-beat-detection;144;122;121;197;123;118;143;118;159;117 21:48:55 INFO - PROCESS | 8235 | |2;audio-dft;161;161;163;162;160;162;160;161;160;162 21:48:55 INFO - PROCESS | 8235 | |3;audio-fft;74;74;75;112;75;75;75;75;99;74 21:48:55 INFO - PROCESS | 8235 | |4;audio-oscillator;83;83;135;84;83;84;118;84;85;132 21:48:55 INFO - PROCESS | 8235 | |5;imaging-gaussian-blur;117;117;117;116;117;118;117;117;117;117 21:48:55 INFO - PROCESS | 8235 | |6;imaging-darkroom;146;146;146;146;145;145;145;150;146;146 21:48:55 INFO - PROCESS | 8235 | |7;imaging-desaturate;94;95;94;95;94;95;95;94;95;95 21:48:55 INFO - PROCESS | 8235 | |8;json-parse-financial;52;50;52;51;50;53;52;51;53;52 21:48:55 INFO - PROCESS | 8235 | |9;json-stringify-tinderbox;62;63;61;62;63;62;62;62;62;62 21:48:55 INFO - PROCESS | 8235 | |10;stanford-crypto-aes;79;78;77;78;77;78;77;77;76;78 21:48:55 INFO - PROCESS | 8235 | |11;stanford-crypto-ccm;127;123;130;121;122;133;124;133;144;123 21:48:55 INFO - PROCESS | 8235 | |12;stanford-crypto-pbkdf2;162;165;168;165;166;163;168;166;166;161 21:48:55 INFO - PROCESS | 8235 | |13;stanford-crypto-sha256-iterative;64;65;65;64;64;68;63;63;62;66 21:48:55 INFO - PROCESS | 8235 | __end_tp_report 21:48:55 INFO - PROCESS | 8235 | __start_cc_report 21:48:55 INFO - PROCESS | 8235 | _x_x_mozilla_cycle_collect,1673 21:48:55 INFO - PROCESS | 8235 | __end_cc_report 21:48:55 INFO - PROCESS | 8235 | __startTimestamp1471063735596__endTimestamp 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | ------- Summary: start ------- 21:48:55 INFO - PROCESS | 8235 | Number of tests: 14 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.74 (2.4%) stddev-sans-first:1.12 21:48:55 INFO - PROCESS | 8235 | Values: 104.0 112.0 113.0 112.0 110.0 111.0 112.0 112.0 114.0 112.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:133.00 stddev:25.74 (19.4%) stddev-sans-first:27.14 21:48:55 INFO - PROCESS | 8235 | Values: 144.0 122.0 121.0 197.0 123.0 118.0 143.0 118.0 159.0 117.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.09 21:48:55 INFO - PROCESS | 8235 | Values: 161.0 161.0 163.0 162.0 160.0 162.0 160.0 161.0 160.0 162.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:13.38 (17.8%) stddev-sans-first:13.97 21:48:55 INFO - PROCESS | 8235 | Values: 74.0 74.0 75.0 112.0 75.0 75.0 75.0 75.0 99.0 74.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:83.50 stddev:21.98 (26.3%) stddev-sans-first:22.72 21:48:55 INFO - PROCESS | 8235 | Values: 83.0 83.0 135.0 84.0 83.0 84.0 118.0 84.0 85.0 132.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 21:48:55 INFO - PROCESS | 8235 | Values: 117.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:1.45 (1.0%) stddev-sans-first:1.54 21:48:55 INFO - PROCESS | 8235 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 145.0 150.0 146.0 146.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 21:48:55 INFO - PROCESS | 8235 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:1.07 (2.1%) stddev-sans-first:1.13 21:48:55 INFO - PROCESS | 8235 | Values: 52.0 50.0 52.0 51.0 50.0 53.0 52.0 51.0 53.0 52.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 21:48:55 INFO - PROCESS | 8235 | Values: 62.0 63.0 61.0 62.0 63.0 62.0 62.0 62.0 62.0 62.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:78.00 stddev:0.85 (1.1%) stddev-sans-first:0.71 21:48:55 INFO - PROCESS | 8235 | Values: 79.0 78.0 77.0 78.0 77.0 78.0 77.0 77.0 76.0 78.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:128.50 stddev:7.16 (5.6%) stddev-sans-first:7.59 21:48:55 INFO - PROCESS | 8235 | Values: 127.0 123.0 130.0 121.0 122.0 133.0 124.0 133.0 144.0 123.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:166.00 stddev:2.36 (1.4%) stddev-sans-first:2.24 21:48:55 INFO - PROCESS | 8235 | Values: 162.0 165.0 168.0 165.0 166.0 163.0 168.0 166.0 166.0 161.0 21:48:55 INFO - PROCESS | 8235 | 21:48:55 INFO - PROCESS | 8235 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.71 (2.7%) stddev-sans-first:1.81 21:48:55 INFO - PROCESS | 8235 | Values: 64.0 65.0 65.0 64.0 64.0 68.0 63.0 63.0 62.0 66.0 21:48:55 INFO - PROCESS | 8235 | -------- Summary: end -------- 21:48:55 INFO - PROCESS | 8235 | 21:48:56 INFO - TEST-INFO | 8235: exit 0 21:48:56 INFO - TEST-OK | kraken | took 61077ms 21:48:56 INFO - SUITE-END | took 1176s 21:48:56 INFO - Completed test suite (00:19:36) 21:48:56 INFO - javascript benchmark 21:48:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.582771325871, 3112.828794416309, 3120.1731541141594, 3129.3897689950454, 3131.5928929239194, 5296.576273898088, 5362.490563396481, 5408.756605952732, 5503.257060296859, 5564.9721751391235, 5404.054290499166, 5455.699936503491, 5471.042567550682, 5517.0, 5559.610827242094, 4865.148598995171, 4937.1606826839525, 4949.381327334083, 4968.180250258703, 5122.462141475147, 5026.346574945252, 5055.115354812911, 5058.165402708549, 5080.74596270185, 5085.1863701807715, 4851.611871050325, 4882.3408839806525, 4895.143349913751, 4984.202527595604, 5024.321716568253, 4879.048585525824, 4899.093667671492, 4902.240152776325, 4946.356973593446, 5004.274380214885, 4896.387951506062, 4930.6795058321095, 4931.70409775411, 4935.728534930578, 4970.105381031413, 4988.625853061035, 5307.150855863082, 5365.061114304981, 5426.2674538937135, 5506.504414602705, 5861.6189947653265, 5875.9118613220835, 5876.471117599436, 5892.292924849045, 5916.497097746696, 5771.047777116771, 5933.703314834241, 5950.672713000783, 5951.047832346847, 5953.3451320354725, 5410.377806552218, 5444.564434845242, 5450.91823622646, 5489.917651235235, 5532.087205611029, 6039.758409663652, 6047.606905551125, 6050.183225264621, 6053.545984051214, 6057.757689692451, 5508.063629183049, 5775.249217601769, 5815.040518314515, 5822.650640961556, 5823.388544202798, 5649.604527683023, 5702.372738998707, 5703.429657034263, 5708.0010998076, 5773.566982476331, 5641.830745077655, 5674.0, 5674.120511320752, 5683.460071293303, 5685.886282274331, 5616.241807356037, 5713.914291285634, 5765.106408506688, 5770.913436298459, 5778.219940308005, 4368.7815609219415, 4375.47494300686, 4386.627136693417, 4427.136708341843, 4478.708883922534, 3927.371620540757, 3938.1139243669945, 3940.310445671996, 3969.146633473817, 3971.622695843948, 5523.917141242885, 5531.972340138354, 5538.778448862, 5542.057850165482, 5577.860553486195, 5676.829695109153, 5770.653760774367, 5789.681567513743, 5790.334111577138, 5878.412158784173, 5516.172574113915, 5521.089020311684, 5524.972375138099, 5530.419305972815, 5531.917021244684, 5042.218456139304, 5043.3191519145175, 5063.316452278968, 5065.088284108822, 5083.38999320084, 5810.331811841608, 5984.521238300926, 6079.939200608026, 6082.635041897412, 6122.093225952662, 5916.674582897982, 5919.289685237799, 5920.615160014585, 5923.555733319932, 5948.078047902582, 6049.758009679564, 6091.5126789857595, 6104.664243466652, 6108.144859719731, 6117.694115294128, 5594.356648985256, 5702.971485142713, 5736.42635736423, 5760.164776107357, 5851.882962340645, 5857.4435428634215, 5896.498797602252, 5902.498287645598, 5902.881942361043, 5907.645541267538, 5728.112142617734, 5752.741126649395, 5755.597108202385, 5757.424257574209, 5757.596968212185, 5561.916571251353, 5641.661500309994, 5648.943510564842, 5678.77284908599, 5777.248957635648, 5658.20785090096, 5660.632058916157, 5660.716964151694, 5661.858453538694, 5662.292213473316, 5754.9424505754405, 5763.221965034667, 5788.739506722123, 5797.449242321973, 5810.448007439287, 5373.032854086302, 5489.890202195854, 5501.257330260363, 5580.107182850725, 5610.691411972218], "value": 5369.410853994268, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.399729274786, 594.9464548190664, 598.9401059894009, 608.504069183615, 626.8338890194098, 32799.032058076504, 44003.33994990078, 44212.77893610527, 44979.77510112449, 45217.773911130396, 42093.36859947096, 42979.3553096703, 47401.0, 47424.0, 47526.76236618821, 8111.229433203836, 8960.193582577567, 9095.863562046574, 9109.544522773867, 9111.22554582858, 10567.524461399256, 10811.35131892085, 10815.513301901434, 11194.160437967144, 11194.440277986108, 11104.111671066335, 11218.214724969255, 11225.045871100967, 11233.550657973672, 11236.831447528293, 10980.0, 11036.337819730761, 11042.171837112168, 11054.226204165712, 11056.502457389397, 10696.572137114506, 10759.731006724895, 10764.407957562331, 10770.0, 10771.138308935266, 43426.782866085785, 43616.563834361565, 43730.78134609306, 43739.78130109361, 43776.0, 3674.540682414698, 3791.639794219572, 3879.4180872869015, 4069.2065047315787, 4311.310190369526, 34005.489917651255, 34158.0, 34470.482942755625, 34648.30703385943, 35851.64148358509, 4231.576842315774, 4276.18752437036, 4392.824287028547, 4487.775611219426, 4499.797509112098, 258766.0, 259065.0, 259506.0, 260986.0, 261040.0, 61980.69009654923, 62190.68904655448, 62248.37751622516, 62392.0, 62431.6878415605, 65683.67158164179, 65801.67099164473, 65886.67056664686, 65913.0, 65951.67024164849, 17305.7404138938, 17506.387276445264, 17546.824531754773, 17556.912215438842, 17563.0, 13516.459341626225, 13545.45818167282, 13629.863701363058, 13665.658358541115, 13674.453021879013, 17173.98655691069, 18469.168887400097, 18583.90708046478, 18619.906900465412, 18746.343877964206, 6675.899861502081, 6923.318997167657, 7043.225245223021, 7107.0, 7114.288571142844, 947.9951251673249, 1005.4118340770585, 1019.2559431614962, 1125.9191176470517, 1164.67971307891, 31200.68799311978, 33316.50025249623, 33456.49815252773, 33587.66412335894, 34298.0, 1098.2312381332938, 1133.393634405589, 1178.552150182925, 1196.6529706385224, 1249.1568191470722, 17332.480025599252, 17342.393016244372, 17426.738598921027, 17641.823581764274, 17679.823201767816, 581580.0, 585108.0, 585584.0, 586188.0, 586508.0, 61202.0, 61400.07899881505, 61440.07839882405, 61442.0, 61620.69189654023, 1246.2647038247478, 1357.3756072206697, 1388.0353154557688, 1407.4440595964536, 1425.102185623051, 32067.18152508079, 33730.831345843115, 34361.82819085888, 34429.0, 34451.483227752105, 51707.33655497436, 52534.73732631312, 52578.0, 52596.474035259154, 52642.47357526376, 423874.0, 425178.0, 426169.0, 426232.0, 426588.0, 35923.640763592026, 41230.587694123875, 41300.38049429201, 41404.58595414007, 43167.35248971331, 49105.0, 50212.24681629852, 50331.24503132529, 50784.74607626938, 50921.49078509167, 41676.0, 41747.7912610435, 41980.0, 42291.36562951496, 43934.56065439305, 41463.37804932868, 42212.0, 42618.57381426146, 43465.565344347415, 43664.56335436732, 42413.0, 42526.362104569074, 42792.786036070866, 42893.14213715646, 43737.78131109324, 35842.64157358393, 37832.190205763225, 38187.80906095452, 38935.80532097322, 39085.609143909336, 27122.18633441, 27803.44393112086, 28102.85948570244, 28302.0, 28418.573721393783], "value": 21203.88573185736, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.3391901605302, 400.9498812648419, 404.3368875044926, 408.92639324921515, 418.36408658838565, 13944.233067181302, 19503.902480487595, 20390.388288351354, 20401.693974590373, 21211.151553937823, 15389.615259618515, 18342.908285458587, 18830.435086947415, 18925.810741892576, 19711.901440492813, 5633.8591535211535, 5819.62172458791, 5838.766449342022, 5840.649561026331, 5843.561732870031, 5638.984982703132, 5656.095024796034, 5712.428757124296, 5757.654540727549, 5782.82651520453, 5704.828855134353, 5709.286339207599, 5713.3429655589725, 5716.742746576414, 5717.399673034334, 5606.271184745998, 5701.401352857953, 5715.971420142893, 5728.255326807488, 5757.136429535603, 5170.302009228782, 5183.144781111112, 5192.480751924815, 5194.27280180775, 5197.558207552363, 23300.0, 23893.522129557485, 24061.87969060161, 24353.391165220833, 24362.26913192607, 2433.476802487456, 2492.0, 2506.6616006839026, 2711.200195942202, 2900.7534359579463, 10187.134093602053, 10680.198985076151, 10708.30396024256, 10739.463026848705, 10791.244612877103, 1910.9904450477798, 1941.669916114264, 1948.2109745553073, 1950.5708744076423, 1963.7250784890127, 79452.0, 83205.58397208036, 83869.16130838735, 84070.57964710199, 84611.5769421149, 10887.891121088687, 11058.502367393487, 11128.944355278172, 11130.554777808797, 11378.658640240807, 15551.922240388725, 15576.532704018897, 15613.76579351288, 15623.843761562466, 15628.296726647328, 8326.625301861432, 8463.195996380457, 8495.490270583661, 8617.827643447095, 8685.305175585938, 7900.328472079823, 8070.0, 8093.312068474245, 8140.226678465537, 8461.873071903927, 4455.933161002587, 4608.769561521911, 4855.32025516428, 4905.484924082992, 4939.975300123549, 1941.3690550570839, 1963.9901800490907, 1993.312307254024, 2010.6782914733571, 2095.130520833867, 882.5543100734088, 965.6330594374093, 971.9951400242953, 984.8621193032981, 1011.2567263061644, 18183.272669093087, 18342.816571834377, 19028.238870445304, 20507.8974605129, 20522.58954820895, 944.1266828183902, 959.4003747657714, 985.7239972807625, 993.9155171810477, 1019.607451131305, 9490.715278541516, 11167.38579378142, 11234.166194015728, 11350.54597816078, 11424.543018279343, 497546.0, 500592.0, 515469.0, 528242.0, 531080.0, 89989.55005224932, 90237.0, 90320.54839725759, 90758.54620726855, 92039.53980230055, 1007.7128018514835, 1034.4310629153936, 1067.108964015056, 1069.5133714160038, 1072.2976450424828, 17562.473125806246, 17868.55328616795, 18538.721919171494, 18539.81460185381, 18597.163127659016, 43348.0, 43794.34308485311, 44795.32807007832, 45115.097698045196, 45723.0, 55971.0, 56569.71715141563, 59690.0, 59729.28933452037, 61420.692896535234, 8269.751907442786, 8407.621657025571, 8761.956190219264, 8801.779955501164, 8878.289736821169, 9704.320697551104, 12348.691282718004, 12799.936000320311, 13110.541131060367, 13876.098053626481, 11804.881951180378, 11810.0, 11907.52369905194, 12061.879381206076, 12091.214071085351, 11491.253068550517, 11541.0, 11545.076393888301, 11662.358570278717, 11759.706007349885, 11599.188056835941, 11985.0, 12019.75960480768, 12190.146689731633, 12224.511019559119, 8601.569921504026, 8681.262092721936, 8762.824743505222, 9028.954855225682, 9052.456852588866, 10953.671389858317, 11397.316161030365, 11402.657920262405, 11642.76714465723, 11643.705983723492], "value": 9325.006201856948, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.3576865220361, 1471.7056588682265, 1474.5797447727393, 1606.9196540172995, 1762.7620271263377, 8292.585370731462, 8587.184217499344, 8699.652013919436, 8746.60640271187, 8811.162939520751, 8433.19884610961, 8596.656133754643, 8801.16388943051, 8808.955955220215, 8812.559372031388, 2136.465883529118, 2388.8088952883813, 2395.4729959408946, 2474.5916923707655, 2481.3176376496517, 2436.47615762611, 2472.0235506974736, 2474.616434452663, 2478.10788116278, 2478.4175718706088, 2415.5408776165814, 2432.3067925641194, 2432.671589335435, 2451.595486744685, 2466.691663542057, 2360.1975328388344, 2360.3627020704484, 2366.148186652804, 2373.098222675372, 2453.1291391556097, 2415.118481754147, 2455.8772061396858, 2474.9133780317784, 2479.590867506859, 2481.702195736505, 8747.518886461243, 8940.776480587972, 8944.10558944107, 8949.284057275403, 8953.776155596097, 5354.330708661418, 5490.533304669108, 5494.148406996922, 5501.284832971688, 5501.449855014506, 3429.879954201616, 3443.139215196201, 3467.878624248139, 3477.426224672926, 3488.8081155536433, 1204.0728638948049, 1206.8913797758244, 1208.6192849252457, 1226.4051934811698, 1237.85764637067, 12446.0, 12593.37033148339, 12628.621141365773, 12659.493620255178, 12662.683432914158, 4784.162771514971, 4792.257200133985, 4926.802927882844, 5019.343616606511, 5026.170681837456, 10681.786364272672, 10687.679369618923, 10690.679279621623, 10693.83959240612, 10695.304805187638, 5553.805616803393, 5566.192902029264, 5574.721263936787, 5584.246126772834, 5584.720763961785, 4316.762578058237, 4567.680262381601, 4900.705957642482, 5005.174146265826, 5138.023775482647, 4088.7342322748927, 4090.406891000788, 4124.91750164995, 4189.91620167601, 4204.276246738884, 1294.4822071171607, 1342.4428862022346, 1352.5130952856964, 1359.6736783171968, 1373.176094343386, 908.6320040383655, 959.5250351076122, 970.9029097090234, 1008.0423597582326, 1038.4392428088747, 5931.228940237827, 6146.7233974471255, 6170.475509581735, 6185.628862268279, 6335.4931605472375, 980.5489474841653, 991.1822746234242, 994.4778991029767, 1011.231464087299, 1015.0914931136739, 4100.487439070116, 4272.230998420314, 4289.227938971015, 4292.549282325311, 4462.910741785211, 11048.281861678965, 11344.205905586694, 11454.026407755435, 11460.713482162846, 11467.369294688871, 10979.725506862393, 11093.667189984151, 11343.716407089889, 11353.716157095974, 11489.42552872353, 8205.71280005197, 8316.584170791557, 8326.167383261747, 8422.115677853859, 8428.662853485914, 6059.878802423838, 6301.951865643592, 6315.336889626523, 6386.648734319657, 6398.264199617103, 10333.638322658671, 10570.0, 10572.0, 10585.52365143555, 10591.099756520782, 10154.695359139238, 10477.895221047997, 10529.842052369067, 10650.680479585624, 10651.934806519286, 6940.583564986117, 7149.0, 7152.427805775422, 7866.567338796421, 8067.620052084531, 7771.611419429119, 8368.079511253636, 8669.436486628349, 8710.041895391629, 8809.42738721981, 7704.537727736354, 7874.291313781787, 7925.167857374892, 7957.084935232291, 7984.840303193788, 7661.080670319598, 7724.691012359667, 7736.226377362219, 7746.30283274508, 7894.052713674396, 7071.186813516511, 7161.0, 7164.176119746296, 7165.7850264492145, 7170.820729481805, 5200.063988482109, 5235.345581802275, 5265.6840589564745, 5277.313949186735, 5497.587680923867, 5261.684298942076, 5277.234800953764, 5322.201669749568, 5387.595930305164, 5447.809326673548], "value": 4779.7710735376295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.59825807289326, 340.06651740971034, 350.78777339709467, 352.23213394799325, 354.41344574728816, 5350.491703288191, 5364.892702145955, 5395.163749618806, 5403.459654034599, 5421.7289135543215, 5063.46833582474, 5109.6678715883445, 5174.826572839407, 5183.403908550517, 5298.417174110845, 4066.755994640316, 4129.566395528472, 4135.545090040093, 4161.0429601191745, 4184.665226781865, 4126.628603425691, 4179.832806687728, 4191.685623578229, 4192.706510544248, 4220.514640816299, 4084.264832330179, 4140.461739973799, 4141.4409054777525, 4148.419221309019, 4186.476690413699, 4145.108801607638, 4146.673064619323, 4156.937645935313, 4163.417121602978, 4189.455370801791, 3685.7051435885064, 3689.8155092245547, 3695.7782533048103, 3712.3317802795486, 3744.895255899516, 5025.824096156617, 5210.791568337262, 5260.184671375943, 5265.815696450644, 5279.128943724281, 4736.786844591968, 4752.6910750801435, 4759.452662943771, 4796.345260884989, 4807.975960120212, 5487.42382049887, 5490.176473528963, 5511.917321240185, 5528.655163625988, 5533.667979921218, 3972.3842804365368, 4023.3160362738404, 4056.59434056592, 4071.9592804071876, 4079.3473044313064, 5589.832305030855, 5645.8588535286535, 5652.8869422611315, 5674.716264186815, 5675.801346952878, 4144.212599606065, 4163.854939891554, 4164.208800327928, 4167.416561681367, 4182.393552934807, 4059.715819892579, 4213.325867861127, 4223.598758117974, 4231.894202644959, 4232.936505952413, 4718.598919091847, 4719.560534037083, 4738.076075165379, 4748.6438517111355, 4765.8570242892765, 5530.917036244459, 5534.4742249486235, 5597.076482380443, 5606.355269144101, 5615.606907516516, 1350.162899002605, 1454.9233567160436, 1456.7523521001456, 1465.9633509162143, 1471.8740163774721, 1009.2388781576196, 1027.6146445083093, 1034.0900007992918, 1042.2704107125044, 1052.8997197928184, 5333.493318134771, 5385.353757549119, 5385.892282154335, 5390.730463476811, 5392.91910621341, 5487.64330318528, 5614.522765564972, 5621.959937411592, 5664.716764161775, 5683.6643388803595, 5323.600729945269, 5334.813281535127, 5338.412774594792, 5371.919421208685, 5383.246345511631, 2981.86581603824, 2991.6110905582136, 2991.6836591899496, 3005.8797648093832, 3012.2619958110404, 5619.325680918234, 5794.565407594363, 5807.5644326675665, 5860.941390586125, 5885.588008839426, 5734.655920644775, 5736.598438109292, 5759.625624334405, 5761.0, 5772.5959182856795, 5785.119836053215, 5826.359100498942, 5848.5321174305955, 5855.795047173328, 5874.412558744091, 5421.647592906448, 5643.266375371176, 5700.657960522382, 5702.315722113373, 5705.4009329019855, 5674.0354139797155, 5679.261695979496, 5692.7722891083895, 5705.771769129355, 5742.942570574241, 5741.91387129185, 5960.403959604005, 5961.821145365646, 5969.9701501493955, 5977.0, 4043.8180281887976, 4049.3521036633997, 4056.634902858757, 4060.3503439449546, 4061.6750659947725, 5760.049591817471, 5772.278465191851, 5824.737886795189, 5828.271466066742, 5831.475167234969, 5493.835184944458, 5564.134470747649, 5572.85756419941, 5590.329160500766, 5696.0316746154085, 5560.526460487893, 5563.221149039218, 5565.30433695788, 5567.443255674562, 5576.275084239023, 5296.126139187145, 5391.892162156813, 5474.2062400950845, 5532.336119665505, 5533.837894042296, 5561.332640083216, 5584.636998595079, 5591.65800207939, 5600.171913183979, 5610.100979818987, 5454.263674404064, 5473.425290344457, 5480.205370221375, 5575.498205161555, 5582.7766889323975], "value": 4271.941563585666, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.464901324007, 742.907136607924, 791.8416316736655, 811.2131232704282, 816.9019717633885, 15289.923550382246, 15531.689366212682, 15626.29681664325, 15754.369825206977, 15818.920905395471, 15124.924375378136, 15490.380384784596, 15636.530904072868, 15650.217489125554, 15701.84298157018, 808.9271965523087, 824.4476200945381, 825.5005721538473, 825.6738588257634, 825.8513467575834, 675.6284043775928, 800.6957356204634, 826.6197549127409, 826.6817275348974, 830.6096134816627, 857.5797859049052, 862.7411776467067, 863.2748491267334, 864.3733293362325, 864.7189663359402, 854.2695994924312, 854.6837670062055, 854.9145085491464, 855.0380821575727, 855.1662129423825, 513.0380536494074, 603.9849003774897, 620.0729908786349, 620.2742790934617, 622.9875402491925, 14977.700445991128, 15015.549533514011, 15025.549233523012, 15035.173065481395, 15039.849601503955, 14467.92766036163, 14814.259287035606, 15146.697066058727, 15290.311935962909, 15291.464798732102, 13366.933165334209, 13396.0, 13506.459741610324, 13532.391042403115, 13576.1854288743, 4307.095509942916, 4372.650187984954, 4406.0, 4458.554144585515, 4498.685092043558, 80729.0, 81269.0, 81519.0, 81757.0, 84167.5791621044, 11592.304461732323, 11613.419329033515, 11713.631464179145, 11869.940650296694, 12055.156139070355, 22292.777072229394, 22296.442588935406, 22481.325560232894, 22867.542649146922, 23249.3025209244, 8320.875186872201, 8841.071687472851, 8961.804357932218, 9017.368784185044, 9080.909190908007, 4551.931721024187, 4660.673752837269, 4809.422869255712, 4830.420349558005, 5003.399592048904, 3642.7450078494253, 3719.2189640175866, 3724.6647801697977, 3751.981240093782, 3757.5866654667966, 571.2060236271586, 574.5432381256911, 581.4011568084879, 590.4538302070567, 594.2186025376616, 527.5673947363202, 536.0913252037836, 620.2472071536534, 621.7626922424344, 665.2748504130521, 9143.634254629873, 9184.265258779282, 9560.952195239119, 9611.423314601147, 9764.414135151772, 597.3727586034646, 669.7053296549502, 679.6533767778468, 687.656171914043, 687.691612050504, 4118.382242663564, 4548.727076375428, 4555.180067587799, 4592.425946756655, 4632.2819962905805, 96836.51581742187, 97122.0, 118402.15978402263, 128170.35914820366, 129315.0, 95189.52405238069, 95649.52175239219, 96345.5182724096, 96793.0, 97659.0, 70083.0, 71632.2836771636, 74401.0, 74883.25116748763, 80453.0, 9137.451752894847, 9384.765380865532, 9405.905940940504, 9619.0, 9876.308658393844, 50647.74676126596, 52164.0, 52947.20579191238, 53262.73368633287, 54715.0, 52047.0, 72957.0, 73855.63072184604, 74256.62871685607, 76645.0, 12822.358882056047, 13186.208827470382, 13335.66660833487, 13469.865301347254, 14237.572872813833, 14252.21612811264, 14278.071925325235, 14320.713585728436, 14424.0, 16298.42955496552, 13678.86321136776, 13922.72154556883, 14310.928445358122, 15046.247687615794, 15067.773983390038, 13696.109752866032, 13999.16005039701, 14303.141811491343, 14382.496612618508, 14572.85427145715, 13400.731985360433, 13401.770997807567, 13417.66455838612, 13606.183628982293, 14101.365438555085, 10731.946340268249, 11449.255798373079, 11703.0, 12145.817812732992, 12477.93761031189, 11616.128790340927, 11697.649070527897, 11759.706007349885, 11807.881921180679, 11954.641360759191], "value": 7604.414513139513, "unit": "score"}], "name": "dromaeo_css", "value": 7404.956494434254, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 112.0, 110.0, 111.0, 112.0, 112.0, 114.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 122.0, 121.0, 197.0, 123.0, 118.0, 143.0, 118.0, 159.0, 117.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 162.0, 160.0, 162.0, 160.0, 161.0, 160.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 112.0, 75.0, 75.0, 75.0, 75.0, 99.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 135.0, 84.0, 83.0, 84.0, 118.0, 84.0, 85.0, 132.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 150.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 52.0, 51.0, 50.0, 53.0, 52.0, 51.0, 53.0, 52.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 78.0, 77.0, 78.0, 77.0, 77.0, 76.0, 78.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 123.0, 130.0, 121.0, 122.0, 133.0, 124.0, 133.0, 144.0, 123.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 168.0, 165.0, 166.0, 163.0, 168.0, 166.0, 166.0, 161.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 64.0, 68.0, 63.0, 63.0, 62.0, 66.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1492.8000000000002, "alertThreshold": 2.0}]} 21:48:56 INFO - Return code: 0 21:48:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:48:56 INFO - # TBPL SUCCESS # 21:48:56 INFO - Running post-action listener: _resource_record_post_action 21:48:56 INFO - [mozharness: 2016-08-13 04:48:56.910624Z] Finished run-tests step (success) 21:48:56 INFO - Running post-run listener: _resource_record_post_run 21:48:56 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 418959360; Read time: 28; Write time: 241584 21:48:56 INFO - TinderboxPrint: CPU usage
12.9% 21:48:56 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 28 21:48:56 INFO - TinderboxPrint: I/O write bytes / time
418,959,360 / 241,584 21:48:56 INFO - TinderboxPrint: CPU idle
8,297.0 (87.1%) 21:48:56 INFO - TinderboxPrint: CPU user
1,187.4 (12.5%) 21:48:56 INFO - TinderboxPrint: Swap in / out
0 / 0 21:48:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 8192; Write bytes: 129392640; Read time: 16; Write time: 75164 21:48:57 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289566720; Read time: 0; Write time: 166420 21:48:57 INFO - Running post-run listener: _upload_blobber_files 21:48:57 INFO - Blob upload gear active. 21:48:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:48:57 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 21:48:57 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:48:57 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:48:57 INFO - (blobuploader) - INFO - Open directory for files ... 21:48:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:48:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:48:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:48:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:48:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:48:58 INFO - (blobuploader) - INFO - Done attempting. 21:48:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:48:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:48:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:48:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:48:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:48:59 INFO - (blobuploader) - INFO - Done attempting. 21:48:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:48:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:48:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:49:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:02 INFO - (blobuploader) - INFO - Done attempting. 21:49:02 INFO - (blobuploader) - INFO - Iteration through files over. 21:49:02 INFO - Return code: 0 21:49:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:49:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:49:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ff755813c4fa8c6d4e17d428f8348c3f1d6cc93f136f500e63ce4fac74d2af803b47475ceee83d9f52e4d09defcb7fe76c0e22d9f8e17086b917a7b6af06e48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/91eca03b6785939a98e0c1907a40f3d46181c60d81d961d4f1a4d00316d3c1982edf37298391ae6a19b127d933e06759ec1759d912f709dffa07060d05c567c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a4be9befdf69a7de50b1595ab7ee201fab2f82024dabdb10f859abaeaeaf22253dc158b3a1e36837c45589843f25f95a168db6d894523a6dd608bb88d2f13113"} 21:49:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:49:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:49:02 INFO - Contents: 21:49:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ff755813c4fa8c6d4e17d428f8348c3f1d6cc93f136f500e63ce4fac74d2af803b47475ceee83d9f52e4d09defcb7fe76c0e22d9f8e17086b917a7b6af06e48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/91eca03b6785939a98e0c1907a40f3d46181c60d81d961d4f1a4d00316d3c1982edf37298391ae6a19b127d933e06759ec1759d912f709dffa07060d05c567c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a4be9befdf69a7de50b1595ab7ee201fab2f82024dabdb10f859abaeaeaf22253dc158b3a1e36837c45589843f25f95a168db6d894523a6dd608bb88d2f13113"} 21:49:02 INFO - Running post-run listener: copy_logs_to_upload_dir 21:49:02 INFO - Copying logs to upload dir... 21:49:02 INFO - mkdir: /builds/slave/test/build/upload/logs 21:49:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.342014 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-12 21:49:02.756455) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 21:49:02.759675) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ff755813c4fa8c6d4e17d428f8348c3f1d6cc93f136f500e63ce4fac74d2af803b47475ceee83d9f52e4d09defcb7fe76c0e22d9f8e17086b917a7b6af06e48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/91eca03b6785939a98e0c1907a40f3d46181c60d81d961d4f1a4d00316d3c1982edf37298391ae6a19b127d933e06759ec1759d912f709dffa07060d05c567c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a4be9befdf69a7de50b1595ab7ee201fab2f82024dabdb10f859abaeaeaf22253dc158b3a1e36837c45589843f25f95a168db6d894523a6dd608bb88d2f13113"} build_url:https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/Dwdb-P53RWScisKSc90F_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ff755813c4fa8c6d4e17d428f8348c3f1d6cc93f136f500e63ce4fac74d2af803b47475ceee83d9f52e4d09defcb7fe76c0e22d9f8e17086b917a7b6af06e48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/91eca03b6785939a98e0c1907a40f3d46181c60d81d961d4f1a4d00316d3c1982edf37298391ae6a19b127d933e06759ec1759d912f709dffa07060d05c567c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a4be9befdf69a7de50b1595ab7ee201fab2f82024dabdb10f859abaeaeaf22253dc158b3a1e36837c45589843f25f95a168db6d894523a6dd608bb88d2f13113"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 21:49:02.787129) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:49:02.787491) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1471059322.2305-1631071917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:49:02.870840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 21:49:02.871552) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 21:49:02.872273) ========= ========= Total master_lag: 0.16 =========