builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1472678055.84 results: success (0) buildid: 20160831125821 builduid: ce4f2544975f4132893902791ded70cb revision: 7eac2acb63a5b28940bb8801e02ccab5c83c078c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:15.842282) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:15.842728) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:15.843013) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:15.859362) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:15.859678) ========= 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=0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-31 14:14:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-08-31 14:14:16 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093025 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:15.974996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:15.975359) ========= 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=0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015476 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:16.046927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:16.047262) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7eac2acb63a5b28940bb8801e02ccab5c83c078c --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 7eac2acb63a5b28940bb8801e02ccab5c83c078c --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=0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-31 14:14:16,192 truncating revision to first 12 chars 2016-08-31 14:14:16,192 Setting DEBUG logging. 2016-08-31 14:14:16,192 attempt 1/10 2016-08-31 14:14:16,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7eac2acb63a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 14:14:16,466 unpacking tar archive at: autoland-7eac2acb63a5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535769 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:16.630317) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:16.630845) ========= script_repo_revision: 7eac2acb63a5b28940bb8801e02ccab5c83c078c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:16.631419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:16.631804) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 14:14:16.642563) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-31 14:14:16.642955) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:14:16 INFO - MultiFileLogger online at 20160831 14:14:16 in /builds/slave/test 14:14:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 14:14:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:14:16 INFO - {'append_to_log': False, 14:14:16 INFO - 'base_work_dir': '/builds/slave/test', 14:14:16 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 14:14:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:14:16 INFO - 'branch': 'Autoland-Non-PGO', 14:14:16 INFO - 'buildbot_json_path': 'buildprops.json', 14:14:16 INFO - 'config_files': ('talos/linux_config.py',), 14:14:16 INFO - 'default_actions': ('clobber', 14:14:16 INFO - 'read-buildbot-config', 14:14:16 INFO - 'download-and-extract', 14:14:16 INFO - 'populate-webroot', 14:14:16 INFO - 'create-virtualenv', 14:14:16 INFO - 'install', 14:14:16 INFO - 'run-tests'), 14:14:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:14:16 INFO - 'download_minidump_stackwalk': True, 14:14:16 INFO - 'download_symbols': 'ondemand', 14:14:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:14:16 INFO - 'tooltool.py': '/tools/tooltool.py', 14:14:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:14:16 INFO - '/tools/misc-python/virtualenv.py')}, 14:14:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:14:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:14:16 INFO - 'installer_path': 'installer.exe', 14:14:16 INFO - 'log_level': 'info', 14:14:16 INFO - 'log_name': 'talos', 14:14:16 INFO - 'log_to_console': True, 14:14:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:14:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:14:16 INFO - 'opt_config_files': (), 14:14:16 INFO - 'pip_index': False, 14:14:16 INFO - 'sps_profile': False, 14:14:16 INFO - 'sps_profile_interval': 0, 14:14:16 INFO - 'suite': 'dromaeojs', 14:14:16 INFO - 'system_bits': '32', 14:14:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:14:16 INFO - 'title': 'talos-linux64-ix-058', 14:14:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:14:16 INFO - 'use_talos_json': True, 14:14:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:14:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:14:16 INFO - 'work_dir': 'build'} 14:14:16 INFO - [mozharness: 2016-08-31 21:14:16.852642Z] Running clobber step. 14:14:16 INFO - Running pre-action listener: _resource_record_pre_action 14:14:16 INFO - Running main action method: clobber 14:14:16 INFO - rmtree: /builds/slave/test/build 14:14:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:14:17 INFO - Running post-action listener: _resource_record_post_action 14:14:17 INFO - [mozharness: 2016-08-31 21:14:17.295986Z] Finished clobber step (success) 14:14:17 INFO - [mozharness: 2016-08-31 21:14:17.296088Z] Running read-buildbot-config step. 14:14:17 INFO - Running pre-action listener: _resource_record_pre_action 14:14:17 INFO - Running main action method: read_buildbot_config 14:14:17 INFO - Using buildbot properties: 14:14:17 INFO - { 14:14:17 INFO - "project": "", 14:14:17 INFO - "product": "firefox", 14:14:17 INFO - "script_repo_revision": "production", 14:14:17 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 14:14:17 INFO - "repository": "", 14:14:17 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 14:14:17 INFO - "buildid": "20160831125821", 14:14:17 INFO - "pgo_build": "False", 14:14:17 INFO - "basedir": "/builds/slave/test", 14:14:17 INFO - "buildnumber": 371, 14:14:17 INFO - "slavename": "talos-linux64-ix-058", 14:14:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:14:17 INFO - "platform": "ubuntu64_hw", 14:14:17 INFO - "scheduler": "tests-autoland-linux64-talos", 14:14:17 INFO - "branch": "autoland", 14:14:17 INFO - "repo_path": "integration/autoland", 14:14:17 INFO - "revision": "7eac2acb63a5b28940bb8801e02ccab5c83c078c", 14:14:17 INFO - "stage_platform": "linux64", 14:14:17 INFO - "builduid": "ce4f2544975f4132893902791ded70cb", 14:14:17 INFO - "slavebuilddir": "test" 14:14:17 INFO - } 14:14:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:14:17 INFO - Running post-action listener: _resource_record_post_action 14:14:17 INFO - [mozharness: 2016-08-31 21:14:17.298547Z] Finished read-buildbot-config step (success) 14:14:17 INFO - [mozharness: 2016-08-31 21:14:17.298638Z] Running download-and-extract step. 14:14:17 INFO - Running pre-action listener: _resource_record_pre_action 14:14:17 INFO - Running main action method: download_and_extract 14:14:17 INFO - mkdir: /builds/slave/test/build/tests 14:14:17 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')]} 14:14:17 INFO - trying https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:14:17 INFO - Downloading https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/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 14:14:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/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 14:14:17 INFO - Downloaded 1361 bytes. 14:14:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:14:17 INFO - Using the following test package requirements: 14:14:17 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:14:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:14:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:14:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:17 INFO - u'jsshell-linux-x86_64.zip'], 14:14:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:14:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:14:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:14:17 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:14:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:14:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:14:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:14:17 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')]} 14:14:17 INFO - trying https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:14:17 INFO - Downloading https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/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 14:14:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/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 14:14:18 INFO - Downloaded 20332247 bytes. 14:14:18 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 14:14:22 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 14:14:22 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')]} 14:14:22 INFO - trying https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:14:22 INFO - Downloading https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/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 14:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/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 14:14:23 INFO - Downloaded 20332247 bytes. 14:14:23 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 14:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:28 INFO - trying https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:14:28 INFO - Downloading https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/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 14:14:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/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 14:14:29 INFO - Downloaded 14413998 bytes. 14:14:29 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 14:14:29 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')]} 14:14:29 INFO - trying https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:14:29 INFO - Downloading https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/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 14:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/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 14:14:30 INFO - Downloaded 55865129 bytes. 14:14:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:14:30 INFO - mkdir: /builds/slave/test/properties 14:14:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:14:30 INFO - Writing to file /builds/slave/test/properties/build_url 14:14:30 INFO - Contents: 14:14:30 INFO - build_url:https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:14:31 INFO - Running post-action listener: _resource_record_post_action 14:14:31 INFO - Running post-action listener: set_extra_try_arguments 14:14:31 INFO - [mozharness: 2016-08-31 21:14:31.298292Z] Finished download-and-extract step (success) 14:14:31 INFO - [mozharness: 2016-08-31 21:14:31.298559Z] Running populate-webroot step. 14:14:31 INFO - Running pre-action listener: _resource_record_pre_action 14:14:31 INFO - Running main action method: populate_webroot 14:14:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:14:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:14:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:14:31 INFO - '--tppagecycles', 14:14:31 INFO - '7'], 14:14:31 INFO - 'tests': ['tsvgm']}}, 14:14:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:14:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:14:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:14:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:14:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:14:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:14:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:31 INFO - 'talos_options': ['--disable-e10s'], 14:14:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:31 INFO - 'talos_options': ['--disable-e10s'], 14:14:31 INFO - 'tests': ['damp', 'tps']}, 14:14:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:31 INFO - 'tests': ['damp', 'tps']}, 14:14:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:14:31 INFO - 'tests': ['dromaeo_dom']}, 14:14:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:14:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:14:31 INFO - 'tests': ['basic_compositor_video']}, 14:14:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:14:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:14:31 INFO - 'tests': ['a11yr', 14:14:31 INFO - 'ts_paint', 14:14:31 INFO - 'tpaint', 14:14:31 INFO - 'sessionrestore', 14:14:31 INFO - 'sessionrestore_no_auto_restore', 14:14:31 INFO - 'tabpaint']}, 14:14:31 INFO - 'other-e10s': {'tests': ['a11yr', 14:14:31 INFO - 'ts_paint', 14:14:31 INFO - 'tpaint', 14:14:31 INFO - 'sessionrestore', 14:14:31 INFO - 'sessionrestore_no_auto_restore', 14:14:31 INFO - 'tabpaint']}, 14:14:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:14:31 INFO - 'ts_paint', 14:14:31 INFO - 'tpaint', 14:14:31 INFO - 'sessionrestore', 14:14:31 INFO - 'sessionrestore_no_auto_restore', 14:14:31 INFO - 'tabpaint']}, 14:14:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:14:31 INFO - 'ts_paint', 14:14:31 INFO - 'tpaint', 14:14:31 INFO - 'sessionrestore', 14:14:31 INFO - 'sessionrestore_no_auto_restore', 14:14:31 INFO - 'tabpaint']}, 14:14:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:14:31 INFO - 'tests': ['a11yr', 14:14:31 INFO - 'ts_paint', 14:14:31 INFO - 'tpaint', 14:14:31 INFO - 'sessionrestore', 14:14:31 INFO - 'sessionrestore_no_auto_restore', 14:14:31 INFO - 'tabpaint']}, 14:14:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:14:31 INFO - 'tests': ['a11yr', 14:14:31 INFO - 'ts_paint', 14:14:31 INFO - 'tpaint', 14:14:31 INFO - 'sessionrestore', 14:14:31 INFO - 'sessionrestore_no_auto_restore', 14:14:31 INFO - 'tabpaint']}, 14:14:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:14:31 INFO - 'tests': ['tsvgx', 14:14:31 INFO - 'tsvgr_opacity', 14:14:31 INFO - 'tart', 14:14:31 INFO - 'tscrollx', 14:14:31 INFO - 'cart']}, 14:14:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:14:31 INFO - 'tsvgr_opacity', 14:14:31 INFO - 'tart', 14:14:31 INFO - 'tscrollx', 14:14:31 INFO - 'cart']}, 14:14:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:31 INFO - 'talos_options': ['--disable-e10s'], 14:14:31 INFO - 'tests': ['tp5o']}, 14:14:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:31 INFO - 'tests': ['tp5o']}, 14:14:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:31 INFO - 'talos_options': ['--disable-e10s', 14:14:31 INFO - '--xperf_path', 14:14:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:31 INFO - 'tests': ['tp5n']}, 14:14:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:31 INFO - 'talos_options': ['--xperf_path', 14:14:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:31 INFO - 'tests': ['tp5n']}}, 14:14:31 INFO - 'talos.zip': {'path': '', 14:14:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:14:31 INFO - Running post-action listener: _resource_record_post_action 14:14:31 INFO - [mozharness: 2016-08-31 21:14:31.319317Z] Finished populate-webroot step (success) 14:14:31 INFO - [mozharness: 2016-08-31 21:14:31.319407Z] Running create-virtualenv step. 14:14:31 INFO - Running pre-action listener: _resource_record_pre_action 14:14:31 INFO - Running main action method: create_virtualenv 14:14:31 INFO - Creating virtualenv /builds/slave/test/build/venv 14:14:31 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 14:14:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:14:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:14:31 INFO - Using real prefix '/usr' 14:14:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:14:31 INFO - Installing distribute.............................................................................................................................................................................................done. 14:14:33 INFO - Installing pip.................done. 14:14:33 INFO - Return code: 0 14:14:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:33 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 0x7f1320c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6090>, '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 0x10a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e40>, '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': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', '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 14:14:33 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 14:14:33 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 14:14:33 INFO - Using env: {'DISPLAY': ':0', 14:14:33 INFO - 'HOME': '/home/cltbld', 14:14:33 INFO - 'LANG': 'en_US.UTF-8', 14:14:33 INFO - 'LANGUAGE': 'en_US:en', 14:14:33 INFO - 'LOGNAME': 'cltbld', 14:14:33 INFO - 'MAIL': '/var/mail/cltbld', 14:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:33 INFO - 'MOZ_NO_REMOTE': '1', 14:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:33 INFO - 'NO_EM_RESTART': '1', 14:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:33 INFO - 'PWD': '/builds/slave/test', 14:14:33 INFO - 'SHELL': '/bin/bash', 14:14:33 INFO - 'SHLVL': '1', 14:14:33 INFO - 'TERM': 'linux', 14:14:33 INFO - 'TMOUT': '86400', 14:14:33 INFO - 'USER': 'cltbld', 14:14:33 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', 14:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:33 INFO - '_': '/tools/buildbot/bin/python'} 14:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:34 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 14:14:34 INFO - Cleaning up... 14:14:34 INFO - Return code: 0 14:14:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:34 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 0x7f1320c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6090>, '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 0x10a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e40>, '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': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', '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 14:14:34 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 14:14:34 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 14:14:34 INFO - Using env: {'DISPLAY': ':0', 14:14:34 INFO - 'HOME': '/home/cltbld', 14:14:34 INFO - 'LANG': 'en_US.UTF-8', 14:14:34 INFO - 'LANGUAGE': 'en_US:en', 14:14:34 INFO - 'LOGNAME': 'cltbld', 14:14:34 INFO - 'MAIL': '/var/mail/cltbld', 14:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:34 INFO - 'MOZ_NO_REMOTE': '1', 14:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:34 INFO - 'NO_EM_RESTART': '1', 14:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:34 INFO - 'PWD': '/builds/slave/test', 14:14:34 INFO - 'SHELL': '/bin/bash', 14:14:34 INFO - 'SHLVL': '1', 14:14:34 INFO - 'TERM': 'linux', 14:14:34 INFO - 'TMOUT': '86400', 14:14:34 INFO - 'USER': 'cltbld', 14:14:34 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', 14:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:34 INFO - '_': '/tools/buildbot/bin/python'} 14:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:34 INFO - Downloading/unpacking psutil>=3.1.1 14:14:34 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 14:14:34 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 14:14:34 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 14:14:34 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 14:14:34 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 14:14:34 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 14:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:14:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:36 INFO - Installing collected packages: psutil 14:14:36 INFO - Running setup.py install for psutil 14:14:36 INFO - building 'psutil._psutil_linux' extension 14:14:36 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 14:14:36 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 14:14:36 INFO - building 'psutil._psutil_posix' extension 14:14:36 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 14:14:36 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 14:14:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:36 INFO - Successfully installed psutil 14:14:36 INFO - Cleaning up... 14:14:36 INFO - Return code: 0 14:14:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:36 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 0x7f1320c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6090>, '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 0x10a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e40>, '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': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', '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 14:14:36 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 14:14:36 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 14:14:36 INFO - Using env: {'DISPLAY': ':0', 14:14:36 INFO - 'HOME': '/home/cltbld', 14:14:36 INFO - 'LANG': 'en_US.UTF-8', 14:14:36 INFO - 'LANGUAGE': 'en_US:en', 14:14:36 INFO - 'LOGNAME': 'cltbld', 14:14:36 INFO - 'MAIL': '/var/mail/cltbld', 14:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:36 INFO - 'MOZ_NO_REMOTE': '1', 14:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:36 INFO - 'NO_EM_RESTART': '1', 14:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:36 INFO - 'PWD': '/builds/slave/test', 14:14:36 INFO - 'SHELL': '/bin/bash', 14:14:36 INFO - 'SHLVL': '1', 14:14:36 INFO - 'TERM': 'linux', 14:14:36 INFO - 'TMOUT': '86400', 14:14:36 INFO - 'USER': 'cltbld', 14:14:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', 14:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:36 INFO - '_': '/tools/buildbot/bin/python'} 14:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:14:37 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 14:14:37 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 14:14:37 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 14:14:37 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 14:14:37 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 14:14:37 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 14:14:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:14:39 INFO - Installing collected packages: mozsystemmonitor 14:14:39 INFO - Running setup.py install for mozsystemmonitor 14:14:39 INFO - Successfully installed mozsystemmonitor 14:14:39 INFO - Cleaning up... 14:14:39 INFO - Return code: 0 14:14:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:14: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')]} 14:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14: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')]} 14:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:39 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 0x7f1320c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6090>, '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 0x10a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e40>, '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': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', '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 14:14:39 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 14:14:39 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 14:14:39 INFO - Using env: {'DISPLAY': ':0', 14:14:39 INFO - 'HOME': '/home/cltbld', 14:14:39 INFO - 'LANG': 'en_US.UTF-8', 14:14:39 INFO - 'LANGUAGE': 'en_US:en', 14:14:39 INFO - 'LOGNAME': 'cltbld', 14:14:39 INFO - 'MAIL': '/var/mail/cltbld', 14:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:39 INFO - 'MOZ_NO_REMOTE': '1', 14:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:39 INFO - 'NO_EM_RESTART': '1', 14:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:39 INFO - 'PWD': '/builds/slave/test', 14:14:39 INFO - 'SHELL': '/bin/bash', 14:14:39 INFO - 'SHLVL': '1', 14:14:39 INFO - 'TERM': 'linux', 14:14:39 INFO - 'TMOUT': '86400', 14:14:39 INFO - 'USER': 'cltbld', 14:14:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', 14:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:39 INFO - '_': '/tools/buildbot/bin/python'} 14:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:39 INFO - Downloading/unpacking jsonschema==2.5.1 14:14:39 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 14:14:39 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 14:14:39 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 14:14:39 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 14:14:39 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 14:14:39 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 14:14:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:14:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:41 INFO - Downloading functools32-3.2.3-2.tar.gz 14:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:14:41 INFO - warning: no files found matching '*.txt' 14:14:41 INFO - no previously-included directories found matching 'build' 14:14:41 INFO - no previously-included directories found matching 'dist' 14:14:41 INFO - no previously-included directories found matching '.git*' 14:14:41 INFO - Installing collected packages: jsonschema, functools32 14:14:41 INFO - Running setup.py install for functools32 14:14:41 INFO - warning: no files found matching '*.txt' 14:14:41 INFO - no previously-included directories found matching 'build' 14:14:41 INFO - no previously-included directories found matching 'dist' 14:14:41 INFO - no previously-included directories found matching '.git*' 14:14:41 INFO - Successfully installed jsonschema functools32 14:14:41 INFO - Cleaning up... 14:14:41 INFO - Return code: 0 14:14:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1320c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6090>, '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 0x10a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e40>, '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': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', '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 14:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:14:41 INFO - Using env: {'DISPLAY': ':0', 14:14:41 INFO - 'HOME': '/home/cltbld', 14:14:41 INFO - 'LANG': 'en_US.UTF-8', 14:14:41 INFO - 'LANGUAGE': 'en_US:en', 14:14:41 INFO - 'LOGNAME': 'cltbld', 14:14:41 INFO - 'MAIL': '/var/mail/cltbld', 14:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:41 INFO - 'MOZ_NO_REMOTE': '1', 14:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:41 INFO - 'NO_EM_RESTART': '1', 14:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:41 INFO - 'PWD': '/builds/slave/test', 14:14:41 INFO - 'SHELL': '/bin/bash', 14:14:41 INFO - 'SHLVL': '1', 14:14:41 INFO - 'TERM': 'linux', 14:14:41 INFO - 'TMOUT': '86400', 14:14:41 INFO - 'USER': 'cltbld', 14:14:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', 14:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:41 INFO - '_': '/tools/buildbot/bin/python'} 14:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:14:41 INFO - Cleaning up... 14:14:41 INFO - Return code: 0 14:14:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1320c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6090>, '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 0x10a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e40>, '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': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', '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 14:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:14:41 INFO - Using env: {'DISPLAY': ':0', 14:14:41 INFO - 'HOME': '/home/cltbld', 14:14:41 INFO - 'LANG': 'en_US.UTF-8', 14:14:41 INFO - 'LANGUAGE': 'en_US:en', 14:14:41 INFO - 'LOGNAME': 'cltbld', 14:14:41 INFO - 'MAIL': '/var/mail/cltbld', 14:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:41 INFO - 'MOZ_NO_REMOTE': '1', 14:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:41 INFO - 'NO_EM_RESTART': '1', 14:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:41 INFO - 'PWD': '/builds/slave/test', 14:14:41 INFO - 'SHELL': '/bin/bash', 14:14:41 INFO - 'SHLVL': '1', 14:14:41 INFO - 'TERM': 'linux', 14:14:41 INFO - 'TMOUT': '86400', 14:14:41 INFO - 'USER': 'cltbld', 14:14:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', 14:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:41 INFO - '_': '/tools/buildbot/bin/python'} 14:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:14:42 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 14:14:42 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 14:14:42 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 14:14:42 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 14:14:42 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 14:14:42 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 14:14:44 INFO - Downloading blobuploader-1.2.4.tar.gz 14:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:14:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:14: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 14:14: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 14:14: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 14:14: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 14:14: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 14:14: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 14:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:14:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:14: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 14:14: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 14:14: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 14:14: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 14:14: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 14:14: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 14:14:44 INFO - Downloading docopt-0.6.1.tar.gz 14:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:14:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:14:44 INFO - Running setup.py install for blobuploader 14:14:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:14:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:14:44 INFO - Running setup.py install for requests 14:14:45 INFO - Running setup.py install for docopt 14:14:45 INFO - Successfully installed blobuploader requests docopt 14:14:45 INFO - Cleaning up... 14:14:45 INFO - Return code: 0 14:14:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:45 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 0x7f1320c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6090>, '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 0x10a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e40>, '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': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', '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 14:14:45 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 14:14:45 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 14:14:45 INFO - Using env: {'DISPLAY': ':0', 14:14:45 INFO - 'HOME': '/home/cltbld', 14:14:45 INFO - 'LANG': 'en_US.UTF-8', 14:14:45 INFO - 'LANGUAGE': 'en_US:en', 14:14:45 INFO - 'LOGNAME': 'cltbld', 14:14:45 INFO - 'MAIL': '/var/mail/cltbld', 14:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:45 INFO - 'MOZ_NO_REMOTE': '1', 14:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:45 INFO - 'NO_EM_RESTART': '1', 14:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:45 INFO - 'PWD': '/builds/slave/test', 14:14:45 INFO - 'SHELL': '/bin/bash', 14:14:45 INFO - 'SHLVL': '1', 14:14:45 INFO - 'TERM': 'linux', 14:14:45 INFO - 'TMOUT': '86400', 14:14:45 INFO - 'USER': 'cltbld', 14:14:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', 14:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:45 INFO - '_': '/tools/buildbot/bin/python'} 14:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:14:45 INFO - Running setup.py (path:/tmp/pip-Udk9g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:14:45 INFO - Running setup.py (path:/tmp/pip-9Px7iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:14:45 INFO - Running setup.py (path:/tmp/pip-N4D7Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:14:45 INFO - Running setup.py (path:/tmp/pip-BBAAoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:14:45 INFO - Running setup.py (path:/tmp/pip-2s_bHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:14:46 INFO - Running setup.py (path:/tmp/pip-z_jLaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:14:46 INFO - Running setup.py (path:/tmp/pip-9BAzbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:14:46 INFO - Running setup.py (path:/tmp/pip-wJGsE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:14:46 INFO - Running setup.py (path:/tmp/pip-Rgp0YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:14:46 INFO - Running setup.py (path:/tmp/pip-RuWC_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:14:46 INFO - Running setup.py (path:/tmp/pip-uu4Gbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:14:46 INFO - Running setup.py (path:/tmp/pip-dgfSF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:14:46 INFO - Running setup.py (path:/tmp/pip-BjqucK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:14:46 INFO - Running setup.py (path:/tmp/pip-kLnGd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:46 INFO - Running setup.py (path:/tmp/pip-Ha9bvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:14:46 INFO - Running setup.py (path:/tmp/pip-wv30Lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:14:46 INFO - Running setup.py (path:/tmp/pip-I5ZyhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:14:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:14:46 INFO - Running setup.py install for manifestparser 14:14:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:14:47 INFO - Running setup.py install for mozcrash 14:14:47 INFO - Running setup.py install for mozdebug 14:14:47 INFO - Running setup.py install for mozdevice 14:14:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:14:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:14:47 INFO - Running setup.py install for mozfile 14:14:47 INFO - Running setup.py install for mozhttpd 14:14:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:14:47 INFO - Running setup.py install for mozinfo 14:14:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:14:47 INFO - Running setup.py install for mozInstall 14:14:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:14:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:14:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:14:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:14:47 INFO - Running setup.py install for mozleak 14:14:47 INFO - Running setup.py install for mozlog 14:14:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:14:47 INFO - Running setup.py install for moznetwork 14:14:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:14:48 INFO - Running setup.py install for mozprocess 14:14:48 INFO - Running setup.py install for mozprofile 14:14:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:14:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:14:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:14:48 INFO - Running setup.py install for mozrunner 14:14:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:14:48 INFO - Running setup.py install for mozscreenshot 14:14:48 INFO - Running setup.py install for moztest 14:14:48 INFO - Running setup.py install for mozversion 14:14:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:14:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:14:48 INFO - Cleaning up... 14:14:48 INFO - Return code: 0 14:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:48 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 0x7f1320c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6090>, '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 0x10a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e40>, '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': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', '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 14:14:48 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 14:14:48 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 14:14:48 INFO - Using env: {'DISPLAY': ':0', 14:14:48 INFO - 'HOME': '/home/cltbld', 14:14:48 INFO - 'LANG': 'en_US.UTF-8', 14:14:48 INFO - 'LANGUAGE': 'en_US:en', 14:14:48 INFO - 'LOGNAME': 'cltbld', 14:14:48 INFO - 'MAIL': '/var/mail/cltbld', 14:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:48 INFO - 'MOZ_NO_REMOTE': '1', 14:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:48 INFO - 'NO_EM_RESTART': '1', 14:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:48 INFO - 'PWD': '/builds/slave/test', 14:14:48 INFO - 'SHELL': '/bin/bash', 14:14:48 INFO - 'SHLVL': '1', 14:14:48 INFO - 'TERM': 'linux', 14:14:48 INFO - 'TMOUT': '86400', 14:14:48 INFO - 'USER': 'cltbld', 14:14:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', 14:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:48 INFO - '_': '/tools/buildbot/bin/python'} 14:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:14:48 INFO - Running setup.py (path:/tmp/pip-IbXE9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:14:49 INFO - Running setup.py (path:/tmp/pip-WpCETl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:14:49 INFO - Running setup.py (path:/tmp/pip-Oo0KtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:14:49 INFO - Running setup.py (path:/tmp/pip-uypmJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:14:49 INFO - Running setup.py (path:/tmp/pip-wgRy6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:14:49 INFO - Running setup.py (path:/tmp/pip-yZpBN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:14:49 INFO - Running setup.py (path:/tmp/pip-QsEcyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:14:49 INFO - Running setup.py (path:/tmp/pip-4hLknB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:14:49 INFO - Running setup.py (path:/tmp/pip-CYLAE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:14:49 INFO - Running setup.py (path:/tmp/pip-cfdtKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:14:49 INFO - Running setup.py (path:/tmp/pip-gTXVen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:14:49 INFO - Running setup.py (path:/tmp/pip-yFlMH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:14:49 INFO - Running setup.py (path:/tmp/pip-gtJh1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:14:49 INFO - Running setup.py (path:/tmp/pip-iyujzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:14:49 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)) 14:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:49 INFO - Running setup.py (path:/tmp/pip-4fEJrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:50 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)) 14:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:14:50 INFO - Running setup.py (path:/tmp/pip-VHXzPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:14:50 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)) 14:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:14:50 INFO - Running setup.py (path:/tmp/pip-zHtQxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:14:50 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)) 14:14:50 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)) 14:14:50 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)) 14:14:50 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)) 14:14:50 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)) 14:14:50 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)) 14:14:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:52 INFO - Downloading blessings-1.6.tar.gz 14:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:14:52 INFO - Installing collected packages: blessings 14:14:52 INFO - Running setup.py install for blessings 14:14:52 INFO - Successfully installed blessings 14:14:52 INFO - Cleaning up... 14:14:52 INFO - Return code: 0 14:14:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:14:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:14:52 INFO - Reading from file tmpfile_stdout 14:14:52 INFO - Current package versions: 14:14:52 INFO - argparse == 1.2.1 14:14:52 INFO - blessings == 1.6 14:14:52 INFO - blobuploader == 1.2.4 14:14:52 INFO - docopt == 0.6.1 14:14:52 INFO - functools32 == 3.2.3-2 14:14:52 INFO - jsonschema == 2.5.1 14:14:52 INFO - manifestparser == 1.1 14:14:52 INFO - mozInstall == 1.12 14:14:52 INFO - mozcrash == 0.17 14:14:52 INFO - mozdebug == 0.1 14:14:52 INFO - mozdevice == 0.48 14:14:52 INFO - mozfile == 1.2 14:14:52 INFO - mozhttpd == 0.7 14:14:52 INFO - mozinfo == 0.9 14:14:52 INFO - mozleak == 0.1 14:14:52 INFO - mozlog == 3.3 14:14:52 INFO - moznetwork == 0.27 14:14:52 INFO - mozprocess == 0.23 14:14:52 INFO - mozprofile == 0.28 14:14:52 INFO - mozrunner == 6.12 14:14:52 INFO - mozscreenshot == 0.1 14:14:52 INFO - mozsystemmonitor == 0.3 14:14:52 INFO - moztest == 0.7 14:14:52 INFO - mozversion == 1.4 14:14:52 INFO - psutil == 3.1.1 14:14:52 INFO - requests == 1.2.3 14:14:52 INFO - wsgiref == 0.1.2 14:14:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:52 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 0x7f1320c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6090>, '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 0x10a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e40>, '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': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', '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 14:14:52 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 14:14:52 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 14:14:52 INFO - Using env: {'DISPLAY': ':0', 14:14:52 INFO - 'HOME': '/home/cltbld', 14:14:52 INFO - 'LANG': 'en_US.UTF-8', 14:14:52 INFO - 'LANGUAGE': 'en_US:en', 14:14:52 INFO - 'LOGNAME': 'cltbld', 14:14:52 INFO - 'MAIL': '/var/mail/cltbld', 14:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:52 INFO - 'MOZ_NO_REMOTE': '1', 14:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:52 INFO - 'NO_EM_RESTART': '1', 14:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:52 INFO - 'PWD': '/builds/slave/test', 14:14:52 INFO - 'SHELL': '/bin/bash', 14:14:52 INFO - 'SHLVL': '1', 14:14:52 INFO - 'TERM': 'linux', 14:14:52 INFO - 'TMOUT': '86400', 14:14:52 INFO - 'USER': 'cltbld', 14:14:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', 14:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:52 INFO - '_': '/tools/buildbot/bin/python'} 14:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:52 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)) 14:14:52 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)) 14:14:52 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)) 14:14:52 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)) 14:14:52 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)) 14:14:52 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)) 14:14:52 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)) 14:14:52 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)) 14:14:52 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)) 14:14:52 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)) 14:14:52 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)) 14:14:52 INFO - Cleaning up... 14:14:52 INFO - Return code: 0 14:14:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1320c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6090>, '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 0x10a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e40>, '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': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', '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 14:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:14:52 INFO - Using env: {'DISPLAY': ':0', 14:14:52 INFO - 'HOME': '/home/cltbld', 14:14:52 INFO - 'LANG': 'en_US.UTF-8', 14:14:52 INFO - 'LANGUAGE': 'en_US:en', 14:14:52 INFO - 'LOGNAME': 'cltbld', 14:14:52 INFO - 'MAIL': '/var/mail/cltbld', 14:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:52 INFO - 'MOZ_NO_REMOTE': '1', 14:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:52 INFO - 'NO_EM_RESTART': '1', 14:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:52 INFO - 'PWD': '/builds/slave/test', 14:14:52 INFO - 'SHELL': '/bin/bash', 14:14:52 INFO - 'SHLVL': '1', 14:14:52 INFO - 'TERM': 'linux', 14:14:52 INFO - 'TMOUT': '86400', 14:14:52 INFO - 'USER': 'cltbld', 14:14:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', 14:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:52 INFO - '_': '/tools/buildbot/bin/python'} 14:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:14:52 INFO - Cleaning up... 14:14:52 INFO - Return code: 0 14:14:52 INFO - Running post-action listener: _resource_record_post_action 14:14:52 INFO - Running post-action listener: _start_resource_monitoring 14:14:53 INFO - Starting resource monitoring. 14:14:53 INFO - [mozharness: 2016-08-31 21:14:53.022725Z] Finished create-virtualenv step (success) 14:14:53 INFO - [mozharness: 2016-08-31 21:14:53.023304Z] Running install step. 14:14:53 INFO - Running pre-action listener: _resource_record_pre_action 14:14:53 INFO - Running main action method: install 14:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:14:53 INFO - Reading from file tmpfile_stdout 14:14:53 INFO - Detecting whether we're running mozinstall >=1.0... 14:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:14:53 INFO - Reading from file tmpfile_stdout 14:14:53 INFO - Output received: 14:14:53 INFO - Usage: mozinstall [options] installer 14:14:53 INFO - Options: 14:14:53 INFO - -h, --help show this help message and exit 14:14:53 INFO - -d DEST, --destination=DEST 14:14:53 INFO - Directory to install application into. [default: 14:14:53 INFO - "/builds/slave/test"] 14:14:53 INFO - --app=APP Application being installed. [default: firefox] 14:14:53 INFO - mkdir: /builds/slave/test/build/application 14:14:53 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'] 14:14:53 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 14:15:09 INFO - Reading from file tmpfile_stdout 14:15:09 INFO - Output received: 14:15:09 INFO - /builds/slave/test/build/application/firefox/firefox 14:15:09 INFO - Running post-action listener: _resource_record_post_action 14:15:09 INFO - [mozharness: 2016-08-31 21:15:09.485405Z] Finished install step (success) 14:15:09 INFO - [mozharness: 2016-08-31 21:15:09.485684Z] Running run-tests step. 14:15:09 INFO - Running pre-action listener: _resource_record_pre_action 14:15:09 INFO - Running main action method: run_tests 14:15:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:15:09 INFO - Python 2.7.3 14:15:09 INFO - Return code: 0 14:15:09 INFO - grabbing minidump binary from tooltool 14:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:09 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 0x10a6090>, '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 0x10a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:15:09 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 14:15:09 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 14:15:09 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 14:15:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:15:09 INFO - Return code: 0 14:15:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:15:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:15:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:15:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:15:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:15:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 14:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 14:15:09 INFO - Using env: {'DISPLAY': ':0', 14:15:09 INFO - 'HOME': '/home/cltbld', 14:15:09 INFO - 'LANG': 'en_US.UTF-8', 14:15:09 INFO - 'LANGUAGE': 'en_US:en', 14:15:09 INFO - 'LOGNAME': 'cltbld', 14:15:09 INFO - 'MAIL': '/var/mail/cltbld', 14:15:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:15:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:09 INFO - 'MOZ_NO_REMOTE': '1', 14:15:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:09 INFO - 'NO_EM_RESTART': '1', 14:15:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:09 INFO - 'PWD': '/builds/slave/test', 14:15:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:15:09 INFO - 'SHELL': '/bin/bash', 14:15:09 INFO - 'SHLVL': '1', 14:15:09 INFO - 'TERM': 'linux', 14:15:09 INFO - 'TMOUT': '86400', 14:15:09 INFO - 'USER': 'cltbld', 14:15:09 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106', 14:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:09 INFO - '_': '/tools/buildbot/bin/python'} 14:15:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 14:15:09 INFO - mozversion application_buildid: 20160831125821 14:15:09 INFO - mozversion application_changeset: 7eac2acb63a5b28940bb8801e02ccab5c83c078c 14:15:09 INFO - mozversion application_display_name: Nightly 14:15:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:15:09 INFO - mozversion application_name: Firefox 14:15:09 INFO - mozversion application_remotingname: firefox 14:15:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:15:09 INFO - mozversion application_vendor: Mozilla 14:15:09 INFO - mozversion application_version: 51.0a1 14:15:09 INFO - mozversion platform_buildid: 20160831125821 14:15:09 INFO - mozversion platform_changeset: 7eac2acb63a5b28940bb8801e02ccab5c83c078c 14:15:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:15:09 INFO - mozversion platform_version: 51.0a1 14:15:09 INFO - using testdate: 1472678109 14:15:09 INFO - actual date: 1472678109 14:15:09 INFO - starting webserver on 'localhost:41845' 14:15:09 INFO - SUITE-START | Running 2 tests 14:15:09 INFO - TEST-START | dromaeo_css 14:15:09 INFO - operating with platform_type : linux_ 14:15:09 INFO - Initialising browser for dromaeo_css test... 14:15:09 INFO - TEST-INFO | started process 13844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6bEpo8/profile http://localhost:41845/getInfo.html) 14:15:14 INFO - PROCESS | 13844 | __metrics Screen width/height:1600/1200 14:15:14 INFO - PROCESS | 13844 | colorDepth:24 14:15:14 INFO - PROCESS | 13844 | Browser inner width/height: 1024/697 14:15:14 INFO - PROCESS | 13844 | __metrics 14:15:15 INFO - PROCESS | 13844 | 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" 14:15:15 INFO - PROCESS | 13844 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:15:15 INFO - PROCESS | 13844 | console.error: PushService: 14:15:15 INFO - PROCESS | 13844 | stateChangeProcessEnqueue: Error transitioning state 14:15:15 INFO - PROCESS | 13844 | UnknownError 14:15:16 INFO - TEST-INFO | 13844: exit 0 14:15:16 INFO - Browser initialized. 14:15:16 INFO - Running cycle 1/1 for dromaeo_css test... 14:15:16 INFO - TEST-INFO | started process 13926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6bEpo8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:28 INFO - PROCESS | 13926 | RSS: Main: 182329344 14:15:28 INFO - PROCESS | 13926 | 14:16:20 INFO - PROCESS | 13926 | 1472678180183 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] 14:18:31 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:41845/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41845/tests/dromaeo/cssquery-ext.html) 14:18:32 INFO - PROCESS | 13926 | RSS: Main: 263499776 14:18:32 INFO - PROCESS | 13926 | 14:21:35 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:41845/tests/dromaeo/cssquery-ext.html (next: http://localhost:41845/tests/dromaeo/cssquery-jquery.html) 14:21:36 INFO - PROCESS | 13926 | RSS: Main: 275701760 14:21:36 INFO - PROCESS | 13926 | 14:24:38 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:41845/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41845/tests/dromaeo/cssquery-mootools.html) 14:24:39 INFO - PROCESS | 13926 | RSS: Main: 260698112 14:24:39 INFO - PROCESS | 13926 | 14:27:41 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:41845/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41845/tests/dromaeo/cssquery-prototype.html) 14:27:41 INFO - PROCESS | 13926 | RSS: Main: 218988544 14:27:41 INFO - PROCESS | 13926 | 14:30:44 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:41845/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41845/tests/dromaeo/cssquery-yui.html) 14:30:45 INFO - PROCESS | 13926 | RSS: Main: 222441472 14:30:45 INFO - PROCESS | 13926 | 14:33:48 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:41845/tests/dromaeo/cssquery-yui.html (next: http://localhost:41845/tests/dromaeo/cssquery-dojo.html) 14:33:49 INFO - PROCESS | 13926 | RSS: Main: 306282496 14:33:49 INFO - PROCESS | 13926 | 14:33:49 INFO - PROCESS | 13926 | __start_tp_report 14:33:49 INFO - PROCESS | 13926 | _x_x_mozilla_page_load 14:33:49 INFO - PROCESS | 13926 | _x_x_mozilla_page_load_details 14:33:49 INFO - PROCESS | 13926 | |i|pagename|runs| 14:33:49 INFO - PROCESS | 13926 | |0;dojo.html;2543.4277287610284;2552.400185956301;2570.665813444252;2584.28932043688;2596.026490066224;4421.977890110553;4444.666650001254;4616.722996620201;4629.0510445358705;4665.9066818663605;4513.2101882170655;4517.774111294439;4535.3877226574405;4601.60886324662;4667.20657488227;4231.048014196796;4271.572842715735;4277.165952639244;4283.271843786548;4305.138972205556;4219.725717828332;4290.635295999844;4302.806373713191;4304.203722311382;4354.97822510887;4297.226499230137;4354.695171338008;4368.148211098837;4369.71596846204;4370.4755429348525;4115.053537686319;4164.7709375984305;4211.515675697304;4256.638185754215;4261.701680882339;4091.284025295591;4112.712110152291;4163.770992595406;4184.163167366539;4211.368294755781;4414.977925110386;4465.732056076613;4499.910001799978;4500.054988452429;4503.369528266046;4711.882202944919;4800.687955282895;4822.734749588772;4825.806967721287;4881.316615673773;4887.780049897763;4926.1379258629595;4947.752612369403;4958.975205123951;4960.503949605047;4617.307403889444;4624.283236098444;4631.02748422835;4635.976820115878;4688.64835137366;4871.902561948741;4925.359703238628;5061.2661164131;5065.594752419871;5066.265391518209;4767.070421267819;4770.713757174581;4790.688605240718;4856.198727210041;4858.8299409521205;4874.439439464507;4881.4142302923165;4887.755612219375;4941.654084214142;4947.925781113287;4738.8341408050555;4802.975985120052;4828.589569886529;4836.028262117315;4894.3147959285725;4767.213409787416;4807.326974223612;4819.156647586658;4878.07316609843;4913.680610760289;4089.8977525561504;4097.323941549671;4102.3026085565525;4103.671706263492;4152.501699796044;3609.8917032489067;3617.782933024027;3633.2733453309443;3643.417053271517;3687.078230442389;4119.0526178979;4176.979115104466;4192.161567686414;4199.580041995776;4243.618074373321;4847.151748444008;4856.95143048572;4869.586085182728;4881.267809828554;4929.06347793918;4189.518205406417;4197.769122698281;4200.537940826506;4201.97899010503;4255.6169944705125;4286;4308.116836048603;4343.956560434355;4347.108842687241;4406.25093734066;4555.772211389417;4562.817487300604;4594.7702614869795;4597.816087356468;4597.977010114928;4900.828471003498;4901.6323775716255;4910.337104490991;4910.8772280693265;4969.726665033458;4505.954940450553;4522;4537.478190008192;4569.634429245719;4608.5621865922685;4789.976050119727;4791.233402655558;4803.639727020557;4815.675689185502;4863.34344863453;4832.44426890912;4845.5881250094135;4863.34344863453;4867.756612169306;4917.827876024322;4627.884302892455;4726;4757.09615173116;4779.402574678165;4849.563539281482;4754.904901902012;4782.378290822171;4784.258439941815;4788.066327066189;4845.75771211445;4718.433787945469;4722.598579120676;4726.598239149711;4733.258280970269;4770.546798054179;4737.597304229179;4751.477337492804;4789.090072886141;4813.302071199727;4882.487338829514;4675.13510000651;4678.461976872703;4695.5539223773685;4697.859064228079;4752.809887604457 14:33:49 INFO - PROCESS | 13926 | |1;ext.html;561.1834780394527;570.985725356866;572.627791935242;580.9419058094192;589.8938191125595;27461.176164715067;30646.241838234553;30661.846690766542;30708.539371909384;30727.539086913686;30797.692023079817;31564.526532102038;38824.805875970655;40318.59681403185;40393.79803100981;7460.440466964986;7572.659230334621;7580.241975802403;7583.317501424871;7587.127480339776;7585.1656317805;7669.8082547936465;7681.462297639167;7681.692732290701;7693.346065584432;7175.103112110986;7674.424418168632;9699.806003879918;9945.10494055535;9946.104850563484;9719.708408747678;9737.902620973771;9800.117989380919;9807.999999999964;9808.21534277256;9708.90291097087;9758.268129890286;9770.071843174957;9782.119609235204;9793.608255669764;28145;37323.81338093319;38286;38328.61671383278;40876.59123408757;2804.467151241258;2839.2475993861644;2839.3469502014445;2891.6530016397955;3299.1092405050504;28267.15198544047;28282.434351313063;28375.57436638452;28704.712952870414;28746.568801467994;3229.128135403428;3233.3856567252146;3238.8218647974354;3276.393867134564;3300.1914530939835;249586;252037.6583053767;252396;253490;254069.72965135242;44573.55426445759;46078;46355.304670429294;50238.49761502411;52362;54823;55489.44510554923;55497;55499.72250138724;55543.722281388335;12914.22514649124;13036.739265214643;13102.279374634296;13112.737745245042;13117.60647180586;9966.551505182284;10143.492825358702;10148.644797432202;10149.949250253849;10150.847737283946;15176.317065732068;16725.6654866902;16737.246823892954;16762.58093547671;16772.161391930356;5126.307948426989;6157.599756015845;6228.28374736902;6252.249730032334;6277.121203031579;768.3200367674536;821.6138414944967;830.33158307563;862.5557837713457;868.2186032570737;26537.203883883514;27533;28014.43971120566;28510;28563.714362856106;896.3814967672286;946.6875930942772;962.138885697311;968.1963969904962;985.0445068283753;13584.388702508411;14303.356348964113;14483.203423811581;14514.854851451562;14646.926765366105;383692;387034;387168;387233;387580;41618.79190604028;46057.7697111519;46432;46811;47204;1154.3997121496775;1162.8023236049892;1164.5341863254766;1172.536847945057;1201.537408097871;27543.449131017667;28744.71255287504;28916.7108328914;29255.414891702472;29555.113346599635;42306;42743.3588496179;42777;42822.35766463568;42834.785826071915;353463.65363463445;363720;364191;513066;513819;24756;24784.786586280738;25198.74801251964;25288.74711252864;25557;41034;41476.37785433161;41707.37438938479;41808.1638367237;42633;35446.46830297599;35478.29043419169;35540;35628;36183.27633447263;35106.824465878526;35382.46926296056;35573.644263557035;35906.64093359033;36095.639043609226;34288.314233714686;35161.47257791084;35242.64757352394;35513.46729799107;35702.28595428129;30501.694983049885;32764;32795.83602081974;33029.834850825595;33379.165520862174;24675.8766206175;25021;25081.372965676004;25475.36311592225;25536.489270214865 14:33:49 INFO - PROCESS | 13926 | |2;jquery.html;338.81703879904853;369.55099554041834;371.6803548947905;374.25336453774713;389.91616802387483;12381.690457738561;15813.920930395347;16187.27157277921;16572.751408728847;17487.912560437213;13529.120607160528;13783.931080344584;13836.23900685462;13894.652633684163;13955.651108722286;4598.241290187132;4989.625778066641;5098.903735696825;5192.740362981855;5203.19350500673;4901.852944411673;5010.72441015744;5012.523810238022;5017.64876458648;5018.422881368635;4843.443004054526;4981.206765564394;4985.52637499437;4987.276844857493;4995.400551933773;5018.146915024437;5092.414372347191;5097.388313402415;5103.56619687327;5106.08090543702;4419.911601767979;4586.197415452282;4589.2886602576655;4592.494825569184;4593;20349.389518314474;20819.271325503534;20841.68737468924;20925.790742092537;20955.68566471504;1810.4025671528364;1955.892425916574;1962.107241205248;1998.6402447559433;2022.0597422198748;12680.74638507234;13251.271180085092;13315.201087934754;13811.654708632264;13877.37551810161;1703.7955445346638;1708.7266037433951;1730.7144321187116;1759.3138675916402;1781.4566557200048;68565.65717171432;68644.31355686429;69648;69834;72093;9462.195713364441;9706;9837;9872.703818885446;10137.087662110445;13583.52457663977;13626.454941802414;13635.863641363658;13636.727265454636;13642.386092625657;6646.302138275508;6734.831629209211;6885.965570172117;6913.827154321182;6924.272951340137;6175.660338681416;6244.125822384779;6394.200724909387;6425.518086143558;6427.453666438405;6016.69916504173;6153.707766344984;6165.0098528671215;6168.814935551941;6173.506119510428;1764.2590112152927;1767.8939263644222;1797.91010449477;1802.044916194419;1805.810389909067;833.4249367936104;899.1963992312554;900.2887718702152;902.9683961061331;964.344245912786;16746.74879876803;16888.915555422143;17551.561210969827;17825.821741782416;17991.031479805686;824.3405275779353;841.2218697704599;849.8725191221242;852.0592260793828;853.6585365853584;6471.9029214561815;9415.811683766286;9506.382085164441;10021.048000439947;10205.642802501878;324708;370298;370722;370727;371544;70158.64920675466;70455;70579.64710176416;71223;72886.271137289;903.1510380242551;911.2709832134266;924.2652091587204;927.0868194828089;937.9437233765996;15210.847891520943;15309.46416875404;15625.218739062773;15827.762583561025;16317.428889989269;34102;34409;35473.29053418866;36086;36457.08857278483;41188.794056029525;50489.74755126201;51681.483185167664;51742;53922.19116713331;6891.552049116792;7474.701011959461;7745.225477452435;7773.3004029637605;7820.726274580363;11382.54469821231;12141.332226727614;12172.634820955385;12248.87751122513;12741.10812243134;10117.140043096419;10213.029762172582;10234.897651023395;10511.737206569896;10557.736056598647;9337.159655631025;9625.56684949165;9925.751856203653;10117.696469105938;10450.320729152885;7585.658645361083;7669.466106778555;7798.727044553413;8173.427860049739;11091.778164436504;10755.946220269161;11114.444277785917;11261.436928153396;11702.473388697359;11707.307319316775;11350.375729334966;11359;11448.084153267886;11488.827667584826;11772.17594768358 14:33:49 INFO - PROCESS | 13926 | |3;mootools.html;1210.8425904632397;1343.4223283987885;1377.8553251908552;1451.1873350923483;1690.3407671008308;7230.674619642115;7533.171351151376;7600.581967991759;7607.049118860135;7791.3377362924075;7593.77218683439;7761.534307941513;7977.800554986128;7983.441159118864;7985.081715602708;2208.1719355241826;2256.0975609756147;2256.5599708056934;2256.7856053674873;2257.142285931352;2214.490667146549;2251.6847641330146;2269.931902042933;2272.0457407888644;2276.3171048685413;2193.6928829963817;2215.4793623498463;2261.231181398324;2266.614675505168;2272.6477396003565;2140.2295173737443;2150.7526634436927;2151.107290474451;2153.364757396572;2154.892255387232;2140.9464763380884;2145.4850835799452;2146.1308170191096;2147.903344349508;2150.677398390254;7709.7301594443925;7889.289963903277;7943.285104340579;7990.440669153161;7990.720324788663;4257.787110644455;4389.4513185851765;4404.581564751344;4406.69153159279;4407.07451435199;2875.353045564752;3054.3585846972164;3074.969250307513;3088.058142266608;3100.922476938072;936.9625214991393;946.8248374050822;951.8048799995984;977.9070988256104;988.0909563201872;10884.673459796219;11124.888751112467;11125.221234513669;11145.944270278596;11180.776384472347;4324.308110702273;4385.451818522684;4472.485664148599;4491.146682130385;4515.277555591089;9508.47703376307;9509.33434659581;9514.04859514043;9528.95235523818;9558.28312876537;4532.456105267323;4538.795754191069;4541.500434952152;4548.113117942035;4557.111363284128;3687.2625474905126;3963.742356746802;4079.89800254996;4093.795310234536;4099.9180016399505;3674.191677830873;3695.1870588470492;3836.5779764225913;3850.268448994682;3867.61323867611;1202.4949521201117;1221.8900298973135;1236.5733821831454;1237.900967922564;1248.2073883084306;588.6732863260846;631.5105793010454;698.8916717908733;728.6757392960188;757.2730179028194;5029.874253143627;5087.804365973993;5107.284980102789;5256.9737151314;5308.256844041837;799.2606838674203;803.7910143362768;809.70041084799;862.7670528957146;873.3319010956624;3574.1422058706244;3586.264815712773;3604.3692353837973;3637.2361804021452;3777.546694396635;9578.233741300819;9709.174720148867;9972.152367048737;9982.600695972225;10126.746831329128;9871.950640246896;9956;10080.294379393372;10111.7472063199;10121.69634910954;7180.497365184491;7200.423966082805;7274.236205198484;7302.1967583565765;7313.12242530889;5155.53600175986;5231.947680523146;5232.659877107976;5291;5364.7585858635675;8780.341474389319;8892.599833007402;9127.77180570491;9154.130357616015;9162.541872906195;9007.954960225157;9272.072792720674;9277.350585458953;9342.159205671522;9350.859737103812;5695.686737229492;6197.907031394442;6303.432691057827;6365.331640177715;6422.518311126778;7441.367483763941;7566.810829729301;7567.091948966159;7568.508046976929;7575.128860180929;6675.532712710064;6811.523193376416;6833.58998460094;6839.829004274933;7010.193827709879;6437.742490300336;6463.57986730861;6566.573172743756;6566.967165164335;6773.322667733188;6124.969375153274;6215.098810672517;6215.502759779297;6215.906761398493;6222.533310001678;4285.957140428556;4377.9781101094295;4406.118776244828;4456.844010459618;4477.574630410106;4490.528494508029;4518.254488009442;4598.26427771555;4622.907541849211;4738.289256611536 14:33:49 INFO - PROCESS | 13926 | |4;prototype.html;291.38517727594774;296.4589623936316;303.81770937437534;304.45502550434725;304.8400834823497;4682.555157260059;4702.717836929786;4728.858134255969;4731.976340118304;4736.834210802623;4645.930311045328;4670.789814458349;4689.507601701824;4695.436547614291;4718.598919091873;3759.5488541375075;3760.8683696070643;3766.736328457009;3783.5459744830523;3788.9810550947345;3511.5610548681416;3749.737518373715;3753.1930634913488;3768.8693391982297;3789.2989796887664;3643.1620727232753;3694.482772411851;3715.2012317351764;3716.2939041582013;3731.253749250161;3671.2657468506404;3678.8160591970563;3684.2263124743704;3688.889333320005;3688.981555092221;3114.567299042443;3181.300113974945;3299.7525185611175;3313.4698448248164;3320.153360892981;4549.909001819979;4556.658250631182;4558.931616025762;4567.931481027787;4593.816247350102;4189.811458484375;4233.23801715691;4253.298680527782;4257.552956939508;4268.548693444212;4628.190066738341;4711.032049808633;4852;4868.63485238605;4920.3111564381015;3581.803000834953;3608.2422691234874;3615.493830863681;3616.2044350242904;3627.6916462100753;5099.59203263738;5102.974485127587;5104.2088476286235;5125.359330083739;5137.768800403954;3616.4936908832783;3689.2805902849223;3690.6493883081066;3707.776433776847;3720.2187540616774;3726.31063253299;3752.4746535485056;3756.7933763642714;3757.530308711411;3757.8308976095595;4171.311733563928;4202.306619407825;4212.726172798758;4213.241616508996;4224.774815303589;4853.417589889236;4856.150173719585;4863.878403039952;4869.780859861315;4872.4883887192045;1233.3155098920006;1281.51943021367;1282.8005814563412;1290.5289569307135;1302.8534889297357;843.4770442325797;846.289117141604;866.787637028932;867.6746220167437;870.9912900871037;3897.824597893102;3898.8050597470015;3911.6283953024417;3914.706397020235;3922.3920292354733;4416.977915110404;4463.486699029653;4479.395281637003;4508.774561271924;4514.413126293626;3877.65101140893;3888.1446081861945;3899.512560929884;3903.4535165076913;3919.6668283195677;2344.308429013445;2384.3800611841048;2472.5796614575565;2672.679278486594;2688.5698288274175;4553.567411095941;4635.976820115878;4753.191957367256;4781.306710527024;4803.903921921542;5200.257913598986;5222.686638801684;5243.79392739672;5261.947380526222;5270.604704647167;4751.23980163186;4783.904321913542;4806.894414284734;4828.106800241966;4828.203346447796;4944.656772720476;4988.80044798204;5034.949650503448;5047.400588696897;5077.466865979019;4930.482299358516;4935.407751069894;4935.97532012352;4953.157963146202;4954.157793175241;4779.259214821708;4781.7609119543185;4785.468650031957;4818.734969576707;4828.806847726051;3536.628653991294;3570.2680950405625;3579.3915034443685;3602.6217247189716;3610.4764809102007;5012.147934851011;5042.697438153723;5048;5056.64603477753;5058.519440653132;4954.653174277766;4966.701997880139;4967.850964471072;4972.204447288416;4987.950120498894;4744.715317080848;4885.193942999507;4889.364382630235;4920.827771027997;4984.750762461935;4798.5441383068555;4818.831340903052;4822.445418776885;4838.225883858707;4842.951570484391;4886.340344053508;4898.216285394462;4901.803927842846;4902;4908.730019848943;4607.815687372467;4794.568488835882;4813.15769740287;4820.71075735457;4867.58625516835 14:33:49 INFO - PROCESS | 13926 | |5;yui.html;590.366963343488;601.4737105033095;611.8011646214982;650.073645055796;667.1926968368274;12332.876671233285;12759.362031898414;13136.868631313684;13208.867911320884;13655.931720341385;12980.091393602452;13278.93360533196;13335.599932002031;13342.132761370503;13345.799813002814;601.3925934805834;733.1165945036219;750.3172113376828;756.3684323589781;756.6519401075512;727.2400341642996;755.6335177438938;756.5611945071872;763.4884627299723;764.0716529416758;801.4870482890955;806.2904643913378;806.3267171911461;806.9556174410405;807.4307613132756;623.8471574464286;795.7811601809491;795.9681612735484;797.4178849439942;797.5932274539969;548.4049805960498;562.3954249182104;562.9071203251459;566.1338152626488;567.1068067793242;12908;12974.286414247212;12983.09118361715;13025.283609401478;13049.217046977212;11810.645680629596;12446.875531244663;12549.560765373259;12561.681023492492;12720.936395317964;11524.711882202928;11593.072554195644;11759;11900.166988310822;11952;4059.6549293310104;4075.347944328893;4139.172165566899;4269.444972153631;4271.829126834954;64693.67653161751;67022.9946550807;67209.32790672079;67901.66049169723;68214.65892670554;10046.196304295785;10155.12130255905;10184.115938551391;10197.082262596401;10320.43237621938;19083.427497175107;19097.140628671743;19106;19109.522261943286;19118.2352705893;6511.544191906616;6578.375054369827;6626.105475760807;6886.449084073262;6899.17209934801;3691.446283057509;3699.3341198583976;3790.1851102013197;3790.8294126764363;3860.478835357247;2702.297402675279;2805.088346287465;2807.859607019641;2813.4795062913427;2818.3517790908204;545.7080461952836;559.6250512156864;571.5856004396862;578.3897987623014;580.1645630292365;505.5450094914533;532.8756324156028;582;587.5446528940106;600.4685853020109;8217.342612591097;8224.259816616533;8387.370947178864;8447.239748422671;8812.07473215316;510.4410670315998;559.9216109744558;572.9942700573024;586.9031609784423;620.4478014567039;3931.233409485123;3981.3828856527284;4159.334506478949;4244.617984381359;4277.379779931893;95408;103935;104838;105576.47211763891;105928.94071059345;90434;91354;93524;93995;95428;54003.72998134984;71393.28606713866;77113.22886771061;77241;78669.60665196752;8448.873266900879;8735.606897689491;8784.78038049054;8806.867896981423;8869.512176830336;31901;38827.6117238824;42757.57242427536;43229.13541729085;45735.771321143184;55142.44857551373;59795;62379.6881015592;62669.37330626635;62893.68553157388;10793.838092428463;11139.777204456028;11210.607628732956;11298.60454884075;11824.586139485076;12371.381430928237;12777.808332874829;12809.674884882117;13683.452661893412;13688.589342319747;9619.663311784054;11769;11957.760844782882;12214.450349734105;12358.011359091432;11956.402179891145;12183.878161218274;12275;12535.788134245471;13100.082994190316;11175.161862860155;11712.531498739954;11909.52361905514;12416.441260143496;12433.564825231073;9676.806463870824;10286.485675716334;10405;10413.375197487872;10485.16118710486;9753.9024609753;10488.580456781643;10551.736206594896;10644.787104257717;10922.12622990143 14:33:49 INFO - PROCESS | 13926 | __end_tp_report 14:33:49 INFO - PROCESS | 13926 | __start_cc_report 14:33:49 INFO - PROCESS | 13926 | _x_x_mozilla_cycle_collect,1068 14:33:49 INFO - PROCESS | 13926 | __end_cc_report 14:33:49 INFO - PROCESS | 13926 | __startTimestamp1472679229106__endTimestamp 14:33:49 INFO - PROCESS | 13926 | 14:33:49 INFO - PROCESS | 13926 | ------- Summary: start ------- 14:33:49 INFO - PROCESS | 13926 | Number of tests: 6 14:33:49 INFO - PROCESS | 13926 | 14:33:49 INFO - PROCESS | 13926 | [#0] dojo.html Cycles:165 Average:4516.72 Median:4635.98 stddev:466.36 (10.1%) stddev-sans-first:441.35 14:33:49 INFO - PROCESS | 13926 | Values: 2543.4 2552.4 2570.7 2584.3 2596.0 4422.0 4444.7 4616.7 4629.1 4665.9 4513.2 4517.8 4535.4 4601.6 4667.2 4231.0 4271.6 4277.2 4283.3 4305.1 4219.7 4290.6 4302.8 4304.2 4355.0 4297.2 4354.7 4368.1 4369.7 4370.5 4115.1 4164.8 4211.5 4256.6 4261.7 4091.3 4112.7 4163.8 4184.2 4211.4 4415.0 4465.7 4499.9 4500.1 4503.4 4711.9 4800.7 4822.7 4825.8 4881.3 4887.8 4926.1 4947.8 4959.0 4960.5 4617.3 4624.3 4631.0 4636.0 4688.6 4871.9 4925.4 5061.3 5065.6 5066.3 4767.1 4770.7 4790.7 4856.2 4858.8 4874.4 4881.4 4887.8 4941.7 4947.9 4738.8 4803.0 4828.6 4836.0 4894.3 4767.2 4807.3 4819.2 4878.1 4913.7 4089.9 4097.3 4102.3 4103.7 4152.5 3609.9 3617.8 3633.3 3643.4 3687.1 4119.1 4177.0 4192.2 4199.6 4243.6 4847.2 4857.0 4869.6 4881.3 4929.1 4189.5 4197.8 4200.5 4202.0 4255.6 4286.0 4308.1 4344.0 4347.1 4406.3 4555.8 4562.8 4594.8 4597.8 4598.0 4900.8 4901.6 4910.3 4910.9 4969.7 4506.0 4522.0 4537.5 4569.6 4608.6 4790.0 4791.2 4803.6 4815.7 4863.3 4832.4 4845.6 4863.3 4867.8 4917.8 4627.9 4726.0 4757.1 4779.4 4849.6 4754.9 4782.4 4784.3 4788.1 4845.8 4718.4 4722.6 4726.6 4733.3 4770.5 4737.6 4751.5 4789.1 4813.3 4882.5 4675.1 4678.5 4695.6 4697.9 4752.8 14:33:49 INFO - PROCESS | 13926 | 14:33:49 INFO - PROCESS | 13926 | [#1] ext.html Cycles:180 Average:49568.83 Median:36001.14 stddev:96355.98 (267.6%) stddev-sans-first:96556.03 14:33:49 INFO - PROCESS | 13926 | Values: 561.2 571.0 572.6 580.9 589.9 27461.2 30646.2 30661.8 30708.5 30727.5 30797.7 31564.5 38824.8 40318.6 40393.8 7460.4 7572.7 7580.2 7583.3 7587.1 7585.2 7669.8 7681.5 7681.7 7693.3 7175.1 7674.4 9699.8 9945.1 9946.1 9719.7 9737.9 9800.1 9808.0 9808.2 9708.9 9758.3 9770.1 9782.1 9793.6 28145.0 37323.8 38286.0 38328.6 40876.6 2804.5 2839.2 2839.3 2891.7 3299.1 28267.2 28282.4 28375.6 28704.7 28746.6 3229.1 3233.4 3238.8 3276.4 3300.2 249586.0 252037.7 252396.0 253490.0 254069.7 44573.6 46078.0 46355.3 50238.5 52362.0 54823.0 55489.4 55497.0 55499.7 55543.7 12914.2 13036.7 13102.3 13112.7 13117.6 9966.6 10143.5 10148.6 10149.9 10150.8 15176.3 16725.7 16737.2 16762.6 16772.2 5126.3 6157.6 6228.3 6252.2 6277.1 768.3 821.6 830.3 862.6 868.2 26537.2 27533.0 28014.4 28510.0 28563.7 896.4 946.7 962.1 968.2 985.0 13584.4 14303.4 14483.2 14514.9 14646.9 383692.0 387034.0 387168.0 387233.0 387580.0 41618.8 46057.8 46432.0 46811.0 47204.0 1154.4 1162.8 1164.5 1172.5 1201.5 27543.4 28744.7 28916.7 29255.4 29555.1 42306.0 42743.4 42777.0 42822.4 42834.8 353463.7 363720.0 364191.0 513066.0 513819.0 24756.0 24784.8 25198.7 25288.7 25557.0 41034.0 41476.4 41707.4 41808.2 42633.0 35446.5 35478.3 35540.0 35628.0 36183.3 35106.8 35382.5 35573.6 35906.6 36095.6 34288.3 35161.5 35242.6 35513.5 35702.3 30501.7 32764.0 32795.8 33029.8 33379.2 24675.9 25021.0 25081.4 25475.4 25536.5 14:33:49 INFO - PROCESS | 13926 | 14:33:49 INFO - PROCESS | 13926 | [#2] jquery.html Cycles:180 Average:23343.07 Median:20789.36 stddev:59820.74 (287.7%) stddev-sans-first:59963.62 14:33:49 INFO - PROCESS | 13926 | Values: 338.8 369.6 371.7 374.3 389.9 12381.7 15813.9 16187.3 16572.8 17487.9 13529.1 13783.9 13836.2 13894.7 13955.7 4598.2 4989.6 5098.9 5192.7 5203.2 4901.9 5010.7 5012.5 5017.6 5018.4 4843.4 4981.2 4985.5 4987.3 4995.4 5018.1 5092.4 5097.4 5103.6 5106.1 4419.9 4586.2 4589.3 4592.5 4593.0 20349.4 20819.3 20841.7 20925.8 20955.7 1810.4 1955.9 1962.1 1998.6 2022.1 12680.7 13251.3 13315.2 13811.7 13877.4 1703.8 1708.7 1730.7 1759.3 1781.5 68565.7 68644.3 69648.0 69834.0 72093.0 9462.2 9706.0 9837.0 9872.7 10137.1 13583.5 13626.5 13635.9 13636.7 13642.4 6646.3 6734.8 6886.0 6913.8 6924.3 6175.7 6244.1 6394.2 6425.5 6427.5 6016.7 6153.7 6165.0 6168.8 6173.5 1764.3 1767.9 1797.9 1802.0 1805.8 833.4 899.2 900.3 903.0 964.3 16746.7 16888.9 17551.6 17825.8 17991.0 824.3 841.2 849.9 852.1 853.7 6471.9 9415.8 9506.4 10021.0 10205.6 324708.0 370298.0 370722.0 370727.0 371544.0 70158.6 70455.0 70579.6 71223.0 72886.3 903.2 911.3 924.3 927.1 937.9 15210.8 15309.5 15625.2 15827.8 16317.4 34102.0 34409.0 35473.3 36086.0 36457.1 41188.8 50489.7 51681.5 51742.0 53922.2 6891.6 7474.7 7745.2 7773.3 7820.7 11382.5 12141.3 12172.6 12248.9 12741.1 10117.1 10213.0 10234.9 10511.7 10557.7 9337.2 9625.6 9925.8 10117.7 10450.3 7585.7 7669.5 7798.7 8173.4 11091.8 10755.9 11114.4 11261.4 11702.5 11707.3 11350.4 11359.0 11448.1 11488.8 11772.2 14:33:49 INFO - PROCESS | 13926 | 14:33:49 INFO - PROCESS | 13926 | [#3] mootools.html Cycles:180 Average:5168.41 Median:5097.54 stddev:2950.95 (57.9%) stddev-sans-first:2944.24 14:33:49 INFO - PROCESS | 13926 | Values: 1210.8 1343.4 1377.9 1451.2 1690.3 7230.7 7533.2 7600.6 7607.0 7791.3 7593.8 7761.5 7977.8 7983.4 7985.1 2208.2 2256.1 2256.6 2256.8 2257.1 2214.5 2251.7 2269.9 2272.0 2276.3 2193.7 2215.5 2261.2 2266.6 2272.6 2140.2 2150.8 2151.1 2153.4 2154.9 2140.9 2145.5 2146.1 2147.9 2150.7 7709.7 7889.3 7943.3 7990.4 7990.7 4257.8 4389.5 4404.6 4406.7 4407.1 2875.4 3054.4 3075.0 3088.1 3100.9 937.0 946.8 951.8 977.9 988.1 10884.7 11124.9 11125.2 11145.9 11180.8 4324.3 4385.5 4472.5 4491.1 4515.3 9508.5 9509.3 9514.0 9529.0 9558.3 4532.5 4538.8 4541.5 4548.1 4557.1 3687.3 3963.7 4079.9 4093.8 4099.9 3674.2 3695.2 3836.6 3850.3 3867.6 1202.5 1221.9 1236.6 1237.9 1248.2 588.7 631.5 698.9 728.7 757.3 5029.9 5087.8 5107.3 5257.0 5308.3 799.3 803.8 809.7 862.8 873.3 3574.1 3586.3 3604.4 3637.2 3777.5 9578.2 9709.2 9972.2 9982.6 10126.7 9872.0 9956.0 10080.3 10111.7 10121.7 7180.5 7200.4 7274.2 7302.2 7313.1 5155.5 5231.9 5232.7 5291.0 5364.8 8780.3 8892.6 9127.8 9154.1 9162.5 9008.0 9272.1 9277.4 9342.2 9350.9 5695.7 6197.9 6303.4 6365.3 6422.5 7441.4 7566.8 7567.1 7568.5 7575.1 6675.5 6811.5 6833.6 6839.8 7010.2 6437.7 6463.6 6566.6 6567.0 6773.3 6125.0 6215.1 6215.5 6215.9 6222.5 4286.0 4378.0 4406.1 4456.8 4477.6 4490.5 4518.3 4598.3 4622.9 4738.3 14:33:49 INFO - PROCESS | 13926 | 14:33:49 INFO - PROCESS | 13926 | [#4] prototype.html Cycles:180 Average:4057.36 Median:4600.82 stddev:1169.22 (25.4%) stddev-sans-first:1137.82 14:33:49 INFO - PROCESS | 13926 | Values: 291.4 296.5 303.8 304.5 304.8 4682.6 4702.7 4728.9 4732.0 4736.8 4645.9 4670.8 4689.5 4695.4 4718.6 3759.5 3760.9 3766.7 3783.5 3789.0 3511.6 3749.7 3753.2 3768.9 3789.3 3643.2 3694.5 3715.2 3716.3 3731.3 3671.3 3678.8 3684.2 3688.9 3689.0 3114.6 3181.3 3299.8 3313.5 3320.2 4549.9 4556.7 4558.9 4567.9 4593.8 4189.8 4233.2 4253.3 4257.6 4268.5 4628.2 4711.0 4852.0 4868.6 4920.3 3581.8 3608.2 3615.5 3616.2 3627.7 5099.6 5103.0 5104.2 5125.4 5137.8 3616.5 3689.3 3690.6 3707.8 3720.2 3726.3 3752.5 3756.8 3757.5 3757.8 4171.3 4202.3 4212.7 4213.2 4224.8 4853.4 4856.2 4863.9 4869.8 4872.5 1233.3 1281.5 1282.8 1290.5 1302.9 843.5 846.3 866.8 867.7 871.0 3897.8 3898.8 3911.6 3914.7 3922.4 4417.0 4463.5 4479.4 4508.8 4514.4 3877.7 3888.1 3899.5 3903.5 3919.7 2344.3 2384.4 2472.6 2672.7 2688.6 4553.6 4636.0 4753.2 4781.3 4803.9 5200.3 5222.7 5243.8 5261.9 5270.6 4751.2 4783.9 4806.9 4828.1 4828.2 4944.7 4988.8 5034.9 5047.4 5077.5 4930.5 4935.4 4936.0 4953.2 4954.2 4779.3 4781.8 4785.5 4818.7 4828.8 3536.6 3570.3 3579.4 3602.6 3610.5 5012.1 5042.7 5048.0 5056.6 5058.5 4954.7 4966.7 4967.9 4972.2 4988.0 4744.7 4885.2 4889.4 4920.8 4984.8 4798.5 4818.8 4822.4 4838.2 4843.0 4886.3 4898.2 4901.8 4902.0 4908.7 4607.8 4794.6 4813.2 4820.7 4867.6 14:33:49 INFO - PROCESS | 13926 | 14:33:49 INFO - PROCESS | 13926 | [#5] yui.html Cycles:180 Average:18170.35 Median:4270.64 stddev:26392.44 (618.0%) stddev-sans-first:26433.46 14:33:49 INFO - PROCESS | 13926 | Values: 590.4 601.5 611.8 650.1 667.2 12332.9 12759.4 13136.9 13208.9 13655.9 12980.1 13278.9 13335.6 13342.1 13345.8 601.4 733.1 750.3 756.4 756.7 727.2 755.6 756.6 763.5 764.1 801.5 806.3 806.3 807.0 807.4 623.8 795.8 796.0 797.4 797.6 548.4 562.4 562.9 566.1 567.1 12908.0 12974.3 12983.1 13025.3 13049.2 11810.6 12446.9 12549.6 12561.7 12720.9 11524.7 11593.1 11759.0 11900.2 11952.0 4059.7 4075.3 4139.2 4269.4 4271.8 64693.7 67023.0 67209.3 67901.7 68214.7 10046.2 10155.1 10184.1 10197.1 10320.4 19083.4 19097.1 19106.0 19109.5 19118.2 6511.5 6578.4 6626.1 6886.4 6899.2 3691.4 3699.3 3790.2 3790.8 3860.5 2702.3 2805.1 2807.9 2813.5 2818.4 545.7 559.6 571.6 578.4 580.2 505.5 532.9 582.0 587.5 600.5 8217.3 8224.3 8387.4 8447.2 8812.1 510.4 559.9 573.0 586.9 620.4 3931.2 3981.4 4159.3 4244.6 4277.4 95408.0 103935.0 104838.0 105576.5 105928.9 90434.0 91354.0 93524.0 93995.0 95428.0 54003.7 71393.3 77113.2 77241.0 78669.6 8448.9 8735.6 8784.8 8806.9 8869.5 31901.0 38827.6 42757.6 43229.1 45735.8 55142.4 59795.0 62379.7 62669.4 62893.7 10793.8 11139.8 11210.6 11298.6 11824.6 12371.4 12777.8 12809.7 13683.5 13688.6 9619.7 11769.0 11957.8 12214.5 12358.0 11956.4 12183.9 12275.0 12535.8 13100.1 11175.2 11712.5 11909.5 12416.4 12433.6 9676.8 10286.5 10405.0 10413.4 10485.2 9753.9 10488.6 10551.7 10644.8 10922.1 14:33:49 INFO - PROCESS | 13926 | -------- Summary: end -------- 14:33:49 INFO - PROCESS | 13926 | 14:33:50 INFO - TEST-INFO | 13926: exit 0 14:33:50 INFO - TEST-OK | dromaeo_css | took 1120374ms 14:33:50 INFO - TEST-START | kraken 14:33:50 INFO - operating with platform_type : linux_ 14:33:50 INFO - Initialising browser for kraken test... 14:33:50 INFO - TEST-INFO | started process 14232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph9J9ag/profile http://localhost:41845/getInfo.html) 14:33:54 INFO - PROCESS | 14232 | __metrics Screen width/height:1600/1200 14:33:54 INFO - PROCESS | 14232 | colorDepth:24 14:33:54 INFO - PROCESS | 14232 | Browser inner width/height: 1024/697 14:33:54 INFO - PROCESS | 14232 | __metrics 14:33:55 INFO - PROCESS | 14232 | 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" 14:33:55 INFO - PROCESS | 14232 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:33:55 INFO - PROCESS | 14232 | console.error: PushService: 14:33:55 INFO - PROCESS | 14232 | stateChangeProcessEnqueue: Error transitioning state 14:33:55 INFO - PROCESS | 14232 | UnknownError 14:33:56 INFO - TEST-INFO | 14232: exit 0 14:33:56 INFO - Browser initialized. 14:33:56 INFO - Running cycle 1/1 for kraken test... 14:33:56 INFO - TEST-INFO | started process 14315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph9J9ag/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:08 INFO - PROCESS | 14315 | RSS: Main: 181899264 14:34:08 INFO - PROCESS | 14315 | 14:34:11 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41845/tests/kraken/driver.html?testName=audio-beat-detection) 14:34:12 INFO - PROCESS | 14315 | RSS: Main: 243601408 14:34:12 INFO - PROCESS | 14315 | 14:34:15 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41845/tests/kraken/driver.html?testName=audio-dft) 14:34:15 INFO - PROCESS | 14315 | RSS: Main: 225705984 14:34:15 INFO - PROCESS | 14315 | 14:34:19 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41845/tests/kraken/driver.html?testName=audio-fft) 14:34:19 INFO - PROCESS | 14315 | RSS: Main: 303132672 14:34:19 INFO - PROCESS | 14315 | 14:34:21 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41845/tests/kraken/driver.html?testName=audio-oscillator) 14:34:22 INFO - PROCESS | 14315 | RSS: Main: 213495808 14:34:22 INFO - PROCESS | 14315 | 14:34:24 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41845/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:34:25 INFO - PROCESS | 14315 | RSS: Main: 215293952 14:34:25 INFO - PROCESS | 14315 | 14:34:28 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41845/tests/kraken/driver.html?testName=imaging-darkroom) 14:34:29 INFO - PROCESS | 14315 | RSS: Main: 253112320 14:34:29 INFO - PROCESS | 14315 | 14:34:32 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41845/tests/kraken/driver.html?testName=imaging-desaturate) 14:34:33 INFO - PROCESS | 14315 | RSS: Main: 247640064 14:34:33 INFO - PROCESS | 14315 | 14:34:36 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41845/tests/kraken/driver.html?testName=json-parse-financial) 14:34:36 INFO - PROCESS | 14315 | RSS: Main: 250912768 14:34:36 INFO - PROCESS | 14315 | 14:34:38 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41845/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:34:39 INFO - PROCESS | 14315 | RSS: Main: 214454272 14:34:39 INFO - PROCESS | 14315 | 14:34:41 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41845/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:34:41 INFO - PROCESS | 14315 | RSS: Main: 221847552 14:34:41 INFO - PROCESS | 14315 | 14:34:43 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41845/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:34:44 INFO - PROCESS | 14315 | RSS: Main: 222814208 14:34:44 INFO - PROCESS | 14315 | 14:34:47 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:34:48 INFO - PROCESS | 14315 | RSS: Main: 223719424 14:34:48 INFO - PROCESS | 14315 | 14:34:51 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:34:51 INFO - PROCESS | 14315 | RSS: Main: 221126656 14:34:51 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | Cycle 1(1): loaded http://localhost:41845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41845/tests/kraken/driver.html?testName=ai-astar) 14:34:53 INFO - PROCESS | 14315 | RSS: Main: 272474112 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | __start_tp_report 14:34:53 INFO - PROCESS | 14315 | _x_x_mozilla_page_load 14:34:53 INFO - PROCESS | 14315 | _x_x_mozilla_page_load_details 14:34:53 INFO - PROCESS | 14315 | |i|pagename|runs| 14:34:53 INFO - PROCESS | 14315 | |0;ai-astar;116;113;135;117;115;113;113;113;112;115 14:34:53 INFO - PROCESS | 14315 | |1;audio-beat-detection;152;134;151;178;123;149;152;127;182;124 14:34:53 INFO - PROCESS | 14315 | |2;audio-dft;162;162;162;161;159;161;164;163;163;164 14:34:53 INFO - PROCESS | 14315 | |3;audio-fft;77;76;75;170;78;78;76;75;165;75 14:34:53 INFO - PROCESS | 14315 | |4;audio-oscillator;83;83;160;84;84;82;143;83;84;144 14:34:53 INFO - PROCESS | 14315 | |5;imaging-gaussian-blur;117;117;116;117;117;118;118;118;119;118 14:34:53 INFO - PROCESS | 14315 | |6;imaging-darkroom;147;149;148;148;149;149;148;148;148;148 14:34:53 INFO - PROCESS | 14315 | |7;imaging-desaturate;95;96;95;95;95;96;95;96;95;95 14:34:53 INFO - PROCESS | 14315 | |8;json-parse-financial;65;65;65;65;67;66;66;65;68;65 14:34:53 INFO - PROCESS | 14315 | |9;json-stringify-tinderbox;66;68;67;68;68;67;67;67;67;68 14:34:53 INFO - PROCESS | 14315 | |10;stanford-crypto-aes;83;82;82;83;81;90;86;82;81;82 14:34:53 INFO - PROCESS | 14315 | |11;stanford-crypto-ccm;142;131;130;131;133;134;135;145;171;131 14:34:53 INFO - PROCESS | 14315 | |12;stanford-crypto-pbkdf2;175;177;173;170;175;179;173;175;173;172 14:34:53 INFO - PROCESS | 14315 | |13;stanford-crypto-sha256-iterative;74;77;71;70;70;71;68;69;67;68 14:34:53 INFO - PROCESS | 14315 | __end_tp_report 14:34:53 INFO - PROCESS | 14315 | __start_cc_report 14:34:53 INFO - PROCESS | 14315 | _x_x_mozilla_cycle_collect,2013 14:34:53 INFO - PROCESS | 14315 | __end_cc_report 14:34:53 INFO - PROCESS | 14315 | __startTimestamp1472679293765__endTimestamp 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | ------- Summary: start ------- 14:34:53 INFO - PROCESS | 14315 | Number of tests: 14 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#0] ai-astar Cycles:10 Average:116.20 Median:115.00 stddev:6.80 (5.9%) stddev-sans-first:7.21 14:34:53 INFO - PROCESS | 14315 | Values: 116.0 113.0 135.0 117.0 115.0 113.0 113.0 113.0 112.0 115.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:151.50 stddev:20.90 (13.8%) stddev-sans-first:22.09 14:34:53 INFO - PROCESS | 14315 | Values: 152.0 134.0 151.0 178.0 123.0 149.0 152.0 127.0 182.0 124.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.52 (0.9%) stddev-sans-first:1.62 14:34:53 INFO - PROCESS | 14315 | Values: 162.0 162.0 162.0 161.0 159.0 161.0 164.0 163.0 163.0 164.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:38.51 (50.7%) stddev-sans-first:40.32 14:34:53 INFO - PROCESS | 14315 | Values: 77.0 76.0 75.0 170.0 78.0 78.0 76.0 75.0 165.0 75.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:83.00 stddev:32.07 (38.6%) stddev-sans-first:33.18 14:34:53 INFO - PROCESS | 14315 | Values: 83.0 83.0 160.0 84.0 84.0 82.0 143.0 83.0 84.0 144.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 14:34:53 INFO - PROCESS | 14315 | Values: 117.0 117.0 116.0 117.0 117.0 118.0 118.0 118.0 119.0 118.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 14:34:53 INFO - PROCESS | 14315 | Values: 147.0 149.0 148.0 148.0 149.0 149.0 148.0 148.0 148.0 148.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:34:53 INFO - PROCESS | 14315 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.50 stddev:1.06 (1.6%) stddev-sans-first:1.09 14:34:53 INFO - PROCESS | 14315 | Values: 65.0 65.0 65.0 65.0 67.0 66.0 66.0 65.0 68.0 65.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 14:34:53 INFO - PROCESS | 14315 | Values: 66.0 68.0 67.0 68.0 68.0 67.0 67.0 67.0 67.0 68.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:82.50 stddev:2.78 (3.4%) stddev-sans-first:2.95 14:34:53 INFO - PROCESS | 14315 | Values: 83.0 82.0 82.0 83.0 81.0 90.0 86.0 82.0 81.0 82.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:134.50 stddev:12.53 (9.3%) stddev-sans-first:13.22 14:34:53 INFO - PROCESS | 14315 | Values: 142.0 131.0 130.0 131.0 133.0 134.0 135.0 145.0 171.0 131.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:175.00 stddev:2.57 (1.5%) stddev-sans-first:2.71 14:34:53 INFO - PROCESS | 14315 | Values: 175.0 177.0 173.0 170.0 175.0 179.0 173.0 175.0 173.0 172.0 14:34:53 INFO - PROCESS | 14315 | 14:34:53 INFO - PROCESS | 14315 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.50 stddev:3.03 (4.3%) stddev-sans-first:2.93 14:34:53 INFO - PROCESS | 14315 | Values: 74.0 77.0 71.0 70.0 70.0 71.0 68.0 69.0 67.0 68.0 14:34:53 INFO - PROCESS | 14315 | -------- Summary: end -------- 14:34:53 INFO - PROCESS | 14315 | 14:34:55 INFO - TEST-INFO | 14315: exit 0 14:34:55 INFO - TEST-OK | kraken | took 64927ms 14:34:55 INFO - SUITE-END | took 1185s 14:34:55 INFO - Completed test suite (00:19:45) 14:34:55 INFO - javascript benchmark 14:34:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2543.4277287610284, 2552.400185956301, 2570.665813444252, 2584.28932043688, 2596.026490066224, 4421.977890110553, 4444.666650001254, 4616.722996620201, 4629.0510445358705, 4665.9066818663605, 4513.2101882170655, 4517.774111294439, 4535.3877226574405, 4601.60886324662, 4667.20657488227, 4231.048014196796, 4271.572842715735, 4277.165952639244, 4283.271843786548, 4305.138972205556, 4219.725717828332, 4290.635295999844, 4302.806373713191, 4304.203722311382, 4354.97822510887, 4297.226499230137, 4354.695171338008, 4368.148211098837, 4369.71596846204, 4370.4755429348525, 4115.053537686319, 4164.7709375984305, 4211.515675697304, 4256.638185754215, 4261.701680882339, 4091.284025295591, 4112.712110152291, 4163.770992595406, 4184.163167366539, 4211.368294755781, 4414.977925110386, 4465.732056076613, 4499.910001799978, 4500.054988452429, 4503.369528266046, 4711.882202944919, 4800.687955282895, 4822.734749588772, 4825.806967721287, 4881.316615673773, 4887.780049897763, 4926.1379258629595, 4947.752612369403, 4958.975205123951, 4960.503949605047, 4617.307403889444, 4624.283236098444, 4631.02748422835, 4635.976820115878, 4688.64835137366, 4871.902561948741, 4925.359703238628, 5061.2661164131, 5065.594752419871, 5066.265391518209, 4767.070421267819, 4770.713757174581, 4790.688605240718, 4856.198727210041, 4858.8299409521205, 4874.439439464507, 4881.4142302923165, 4887.755612219375, 4941.654084214142, 4947.925781113287, 4738.8341408050555, 4802.975985120052, 4828.589569886529, 4836.028262117315, 4894.3147959285725, 4767.213409787416, 4807.326974223612, 4819.156647586658, 4878.07316609843, 4913.680610760289, 4089.8977525561504, 4097.323941549671, 4102.3026085565525, 4103.671706263492, 4152.501699796044, 3609.8917032489067, 3617.782933024027, 3633.2733453309443, 3643.417053271517, 3687.078230442389, 4119.0526178979, 4176.979115104466, 4192.161567686414, 4199.580041995776, 4243.618074373321, 4847.151748444008, 4856.95143048572, 4869.586085182728, 4881.267809828554, 4929.06347793918, 4189.518205406417, 4197.769122698281, 4200.537940826506, 4201.97899010503, 4255.6169944705125, 4286.0, 4308.116836048603, 4343.956560434355, 4347.108842687241, 4406.25093734066, 4555.772211389417, 4562.817487300604, 4594.7702614869795, 4597.816087356468, 4597.977010114928, 4900.828471003498, 4901.6323775716255, 4910.337104490991, 4910.8772280693265, 4969.726665033458, 4505.954940450553, 4522.0, 4537.478190008192, 4569.634429245719, 4608.5621865922685, 4789.976050119727, 4791.233402655558, 4803.639727020557, 4815.675689185502, 4863.34344863453, 4832.44426890912, 4845.5881250094135, 4863.34344863453, 4867.756612169306, 4917.827876024322, 4627.884302892455, 4726.0, 4757.09615173116, 4779.402574678165, 4849.563539281482, 4754.904901902012, 4782.378290822171, 4784.258439941815, 4788.066327066189, 4845.75771211445, 4718.433787945469, 4722.598579120676, 4726.598239149711, 4733.258280970269, 4770.546798054179, 4737.597304229179, 4751.477337492804, 4789.090072886141, 4813.302071199727, 4882.487338829514, 4675.13510000651, 4678.461976872703, 4695.5539223773685, 4697.859064228079, 4752.809887604457], "value": 4487.385935504297, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1834780394527, 570.985725356866, 572.627791935242, 580.9419058094192, 589.8938191125595, 27461.176164715067, 30646.241838234553, 30661.846690766542, 30708.539371909384, 30727.539086913686, 30797.692023079817, 31564.526532102038, 38824.805875970655, 40318.59681403185, 40393.79803100981, 7460.440466964986, 7572.659230334621, 7580.241975802403, 7583.317501424871, 7587.127480339776, 7585.1656317805, 7669.8082547936465, 7681.462297639167, 7681.692732290701, 7693.346065584432, 7175.103112110986, 7674.424418168632, 9699.806003879918, 9945.10494055535, 9946.104850563484, 9719.708408747678, 9737.902620973771, 9800.117989380919, 9807.999999999964, 9808.21534277256, 9708.90291097087, 9758.268129890286, 9770.071843174957, 9782.119609235204, 9793.608255669764, 28145.0, 37323.81338093319, 38286.0, 38328.61671383278, 40876.59123408757, 2804.467151241258, 2839.2475993861644, 2839.3469502014445, 2891.6530016397955, 3299.1092405050504, 28267.15198544047, 28282.434351313063, 28375.57436638452, 28704.712952870414, 28746.568801467994, 3229.128135403428, 3233.3856567252146, 3238.8218647974354, 3276.393867134564, 3300.1914530939835, 249586.0, 252037.6583053767, 252396.0, 253490.0, 254069.72965135242, 44573.55426445759, 46078.0, 46355.304670429294, 50238.49761502411, 52362.0, 54823.0, 55489.44510554923, 55497.0, 55499.72250138724, 55543.722281388335, 12914.22514649124, 13036.739265214643, 13102.279374634296, 13112.737745245042, 13117.60647180586, 9966.551505182284, 10143.492825358702, 10148.644797432202, 10149.949250253849, 10150.847737283946, 15176.317065732068, 16725.6654866902, 16737.246823892954, 16762.58093547671, 16772.161391930356, 5126.307948426989, 6157.599756015845, 6228.28374736902, 6252.249730032334, 6277.121203031579, 768.3200367674536, 821.6138414944967, 830.33158307563, 862.5557837713457, 868.2186032570737, 26537.203883883514, 27533.0, 28014.43971120566, 28510.0, 28563.714362856106, 896.3814967672286, 946.6875930942772, 962.138885697311, 968.1963969904962, 985.0445068283753, 13584.388702508411, 14303.356348964113, 14483.203423811581, 14514.854851451562, 14646.926765366105, 383692.0, 387034.0, 387168.0, 387233.0, 387580.0, 41618.79190604028, 46057.7697111519, 46432.0, 46811.0, 47204.0, 1154.3997121496775, 1162.8023236049892, 1164.5341863254766, 1172.536847945057, 1201.537408097871, 27543.449131017667, 28744.71255287504, 28916.7108328914, 29255.414891702472, 29555.113346599635, 42306.0, 42743.3588496179, 42777.0, 42822.35766463568, 42834.785826071915, 353463.65363463445, 363720.0, 364191.0, 513066.0, 513819.0, 24756.0, 24784.786586280738, 25198.74801251964, 25288.74711252864, 25557.0, 41034.0, 41476.37785433161, 41707.37438938479, 41808.1638367237, 42633.0, 35446.46830297599, 35478.29043419169, 35540.0, 35628.0, 36183.27633447263, 35106.824465878526, 35382.46926296056, 35573.644263557035, 35906.64093359033, 36095.639043609226, 34288.314233714686, 35161.47257791084, 35242.64757352394, 35513.46729799107, 35702.28595428129, 30501.694983049885, 32764.0, 32795.83602081974, 33029.834850825595, 33379.165520862174, 24675.8766206175, 25021.0, 25081.372965676004, 25475.36311592225, 25536.489270214865], "value": 17268.52508925255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.81703879904853, 369.55099554041834, 371.6803548947905, 374.25336453774713, 389.91616802387483, 12381.690457738561, 15813.920930395347, 16187.27157277921, 16572.751408728847, 17487.912560437213, 13529.120607160528, 13783.931080344584, 13836.23900685462, 13894.652633684163, 13955.651108722286, 4598.241290187132, 4989.625778066641, 5098.903735696825, 5192.740362981855, 5203.19350500673, 4901.852944411673, 5010.72441015744, 5012.523810238022, 5017.64876458648, 5018.422881368635, 4843.443004054526, 4981.206765564394, 4985.52637499437, 4987.276844857493, 4995.400551933773, 5018.146915024437, 5092.414372347191, 5097.388313402415, 5103.56619687327, 5106.08090543702, 4419.911601767979, 4586.197415452282, 4589.2886602576655, 4592.494825569184, 4593.0, 20349.389518314474, 20819.271325503534, 20841.68737468924, 20925.790742092537, 20955.68566471504, 1810.4025671528364, 1955.892425916574, 1962.107241205248, 1998.6402447559433, 2022.0597422198748, 12680.74638507234, 13251.271180085092, 13315.201087934754, 13811.654708632264, 13877.37551810161, 1703.7955445346638, 1708.7266037433951, 1730.7144321187116, 1759.3138675916402, 1781.4566557200048, 68565.65717171432, 68644.31355686429, 69648.0, 69834.0, 72093.0, 9462.195713364441, 9706.0, 9837.0, 9872.703818885446, 10137.087662110445, 13583.52457663977, 13626.454941802414, 13635.863641363658, 13636.727265454636, 13642.386092625657, 6646.302138275508, 6734.831629209211, 6885.965570172117, 6913.827154321182, 6924.272951340137, 6175.660338681416, 6244.125822384779, 6394.200724909387, 6425.518086143558, 6427.453666438405, 6016.69916504173, 6153.707766344984, 6165.0098528671215, 6168.814935551941, 6173.506119510428, 1764.2590112152927, 1767.8939263644222, 1797.91010449477, 1802.044916194419, 1805.810389909067, 833.4249367936104, 899.1963992312554, 900.2887718702152, 902.9683961061331, 964.344245912786, 16746.74879876803, 16888.915555422143, 17551.561210969827, 17825.821741782416, 17991.031479805686, 824.3405275779353, 841.2218697704599, 849.8725191221242, 852.0592260793828, 853.6585365853584, 6471.9029214561815, 9415.811683766286, 9506.382085164441, 10021.048000439947, 10205.642802501878, 324708.0, 370298.0, 370722.0, 370727.0, 371544.0, 70158.64920675466, 70455.0, 70579.64710176416, 71223.0, 72886.271137289, 903.1510380242551, 911.2709832134266, 924.2652091587204, 927.0868194828089, 937.9437233765996, 15210.847891520943, 15309.46416875404, 15625.218739062773, 15827.762583561025, 16317.428889989269, 34102.0, 34409.0, 35473.29053418866, 36086.0, 36457.08857278483, 41188.794056029525, 50489.74755126201, 51681.483185167664, 51742.0, 53922.19116713331, 6891.552049116792, 7474.701011959461, 7745.225477452435, 7773.3004029637605, 7820.726274580363, 11382.54469821231, 12141.332226727614, 12172.634820955385, 12248.87751122513, 12741.10812243134, 10117.140043096419, 10213.029762172582, 10234.897651023395, 10511.737206569896, 10557.736056598647, 9337.159655631025, 9625.56684949165, 9925.751856203653, 10117.696469105938, 10450.320729152885, 7585.658645361083, 7669.466106778555, 7798.727044553413, 8173.427860049739, 11091.778164436504, 10755.946220269161, 11114.444277785917, 11261.436928153396, 11702.473388697359, 11707.307319316775, 11350.375729334966, 11359.0, 11448.084153267886, 11488.827667584826, 11772.17594768358], "value": 8196.148711057327, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1210.8425904632397, 1343.4223283987885, 1377.8553251908552, 1451.1873350923483, 1690.3407671008308, 7230.674619642115, 7533.171351151376, 7600.581967991759, 7607.049118860135, 7791.3377362924075, 7593.77218683439, 7761.534307941513, 7977.800554986128, 7983.441159118864, 7985.081715602708, 2208.1719355241826, 2256.0975609756147, 2256.5599708056934, 2256.7856053674873, 2257.142285931352, 2214.490667146549, 2251.6847641330146, 2269.931902042933, 2272.0457407888644, 2276.3171048685413, 2193.6928829963817, 2215.4793623498463, 2261.231181398324, 2266.614675505168, 2272.6477396003565, 2140.2295173737443, 2150.7526634436927, 2151.107290474451, 2153.364757396572, 2154.892255387232, 2140.9464763380884, 2145.4850835799452, 2146.1308170191096, 2147.903344349508, 2150.677398390254, 7709.7301594443925, 7889.289963903277, 7943.285104340579, 7990.440669153161, 7990.720324788663, 4257.787110644455, 4389.4513185851765, 4404.581564751344, 4406.69153159279, 4407.07451435199, 2875.353045564752, 3054.3585846972164, 3074.969250307513, 3088.058142266608, 3100.922476938072, 936.9625214991393, 946.8248374050822, 951.8048799995984, 977.9070988256104, 988.0909563201872, 10884.673459796219, 11124.888751112467, 11125.221234513669, 11145.944270278596, 11180.776384472347, 4324.308110702273, 4385.451818522684, 4472.485664148599, 4491.146682130385, 4515.277555591089, 9508.47703376307, 9509.33434659581, 9514.04859514043, 9528.95235523818, 9558.28312876537, 4532.456105267323, 4538.795754191069, 4541.500434952152, 4548.113117942035, 4557.111363284128, 3687.2625474905126, 3963.742356746802, 4079.89800254996, 4093.795310234536, 4099.9180016399505, 3674.191677830873, 3695.1870588470492, 3836.5779764225913, 3850.268448994682, 3867.61323867611, 1202.4949521201117, 1221.8900298973135, 1236.5733821831454, 1237.900967922564, 1248.2073883084306, 588.6732863260846, 631.5105793010454, 698.8916717908733, 728.6757392960188, 757.2730179028194, 5029.874253143627, 5087.804365973993, 5107.284980102789, 5256.9737151314, 5308.256844041837, 799.2606838674203, 803.7910143362768, 809.70041084799, 862.7670528957146, 873.3319010956624, 3574.1422058706244, 3586.264815712773, 3604.3692353837973, 3637.2361804021452, 3777.546694396635, 9578.233741300819, 9709.174720148867, 9972.152367048737, 9982.600695972225, 10126.746831329128, 9871.950640246896, 9956.0, 10080.294379393372, 10111.7472063199, 10121.69634910954, 7180.497365184491, 7200.423966082805, 7274.236205198484, 7302.1967583565765, 7313.12242530889, 5155.53600175986, 5231.947680523146, 5232.659877107976, 5291.0, 5364.7585858635675, 8780.341474389319, 8892.599833007402, 9127.77180570491, 9154.130357616015, 9162.541872906195, 9007.954960225157, 9272.072792720674, 9277.350585458953, 9342.159205671522, 9350.859737103812, 5695.686737229492, 6197.907031394442, 6303.432691057827, 6365.331640177715, 6422.518311126778, 7441.367483763941, 7566.810829729301, 7567.091948966159, 7568.508046976929, 7575.128860180929, 6675.532712710064, 6811.523193376416, 6833.58998460094, 6839.829004274933, 7010.193827709879, 6437.742490300336, 6463.57986730861, 6566.573172743756, 6566.967165164335, 6773.322667733188, 6124.969375153274, 6215.098810672517, 6215.502759779297, 6215.906761398493, 6222.533310001678, 4285.957140428556, 4377.9781101094295, 4406.118776244828, 4456.844010459618, 4477.574630410106, 4490.528494508029, 4518.254488009442, 4598.26427771555, 4622.907541849211, 4738.289256611536], "value": 4133.888089753012, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.38517727594774, 296.4589623936316, 303.81770937437534, 304.45502550434725, 304.8400834823497, 4682.555157260059, 4702.717836929786, 4728.858134255969, 4731.976340118304, 4736.834210802623, 4645.930311045328, 4670.789814458349, 4689.507601701824, 4695.436547614291, 4718.598919091873, 3759.5488541375075, 3760.8683696070643, 3766.736328457009, 3783.5459744830523, 3788.9810550947345, 3511.5610548681416, 3749.737518373715, 3753.1930634913488, 3768.8693391982297, 3789.2989796887664, 3643.1620727232753, 3694.482772411851, 3715.2012317351764, 3716.2939041582013, 3731.253749250161, 3671.2657468506404, 3678.8160591970563, 3684.2263124743704, 3688.889333320005, 3688.981555092221, 3114.567299042443, 3181.300113974945, 3299.7525185611175, 3313.4698448248164, 3320.153360892981, 4549.909001819979, 4556.658250631182, 4558.931616025762, 4567.931481027787, 4593.816247350102, 4189.811458484375, 4233.23801715691, 4253.298680527782, 4257.552956939508, 4268.548693444212, 4628.190066738341, 4711.032049808633, 4852.0, 4868.63485238605, 4920.3111564381015, 3581.803000834953, 3608.2422691234874, 3615.493830863681, 3616.2044350242904, 3627.6916462100753, 5099.59203263738, 5102.974485127587, 5104.2088476286235, 5125.359330083739, 5137.768800403954, 3616.4936908832783, 3689.2805902849223, 3690.6493883081066, 3707.776433776847, 3720.2187540616774, 3726.31063253299, 3752.4746535485056, 3756.7933763642714, 3757.530308711411, 3757.8308976095595, 4171.311733563928, 4202.306619407825, 4212.726172798758, 4213.241616508996, 4224.774815303589, 4853.417589889236, 4856.150173719585, 4863.878403039952, 4869.780859861315, 4872.4883887192045, 1233.3155098920006, 1281.51943021367, 1282.8005814563412, 1290.5289569307135, 1302.8534889297357, 843.4770442325797, 846.289117141604, 866.787637028932, 867.6746220167437, 870.9912900871037, 3897.824597893102, 3898.8050597470015, 3911.6283953024417, 3914.706397020235, 3922.3920292354733, 4416.977915110404, 4463.486699029653, 4479.395281637003, 4508.774561271924, 4514.413126293626, 3877.65101140893, 3888.1446081861945, 3899.512560929884, 3903.4535165076913, 3919.6668283195677, 2344.308429013445, 2384.3800611841048, 2472.5796614575565, 2672.679278486594, 2688.5698288274175, 4553.567411095941, 4635.976820115878, 4753.191957367256, 4781.306710527024, 4803.903921921542, 5200.257913598986, 5222.686638801684, 5243.79392739672, 5261.947380526222, 5270.604704647167, 4751.23980163186, 4783.904321913542, 4806.894414284734, 4828.106800241966, 4828.203346447796, 4944.656772720476, 4988.80044798204, 5034.949650503448, 5047.400588696897, 5077.466865979019, 4930.482299358516, 4935.407751069894, 4935.97532012352, 4953.157963146202, 4954.157793175241, 4779.259214821708, 4781.7609119543185, 4785.468650031957, 4818.734969576707, 4828.806847726051, 3536.628653991294, 3570.2680950405625, 3579.3915034443685, 3602.6217247189716, 3610.4764809102007, 5012.147934851011, 5042.697438153723, 5048.0, 5056.64603477753, 5058.519440653132, 4954.653174277766, 4966.701997880139, 4967.850964471072, 4972.204447288416, 4987.950120498894, 4744.715317080848, 4885.193942999507, 4889.364382630235, 4920.827771027997, 4984.750762461935, 4798.5441383068555, 4818.831340903052, 4822.445418776885, 4838.225883858707, 4842.951570484391, 4886.340344053508, 4898.216285394462, 4901.803927842846, 4902.0, 4908.730019848943, 4607.815687372467, 4794.568488835882, 4813.15769740287, 4820.71075735457, 4867.58625516835], "value": 3691.3331247794713, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.366963343488, 601.4737105033095, 611.8011646214982, 650.073645055796, 667.1926968368274, 12332.876671233285, 12759.362031898414, 13136.868631313684, 13208.867911320884, 13655.931720341385, 12980.091393602452, 13278.93360533196, 13335.599932002031, 13342.132761370503, 13345.799813002814, 601.3925934805834, 733.1165945036219, 750.3172113376828, 756.3684323589781, 756.6519401075512, 727.2400341642996, 755.6335177438938, 756.5611945071872, 763.4884627299723, 764.0716529416758, 801.4870482890955, 806.2904643913378, 806.3267171911461, 806.9556174410405, 807.4307613132756, 623.8471574464286, 795.7811601809491, 795.9681612735484, 797.4178849439942, 797.5932274539969, 548.4049805960498, 562.3954249182104, 562.9071203251459, 566.1338152626488, 567.1068067793242, 12908.0, 12974.286414247212, 12983.09118361715, 13025.283609401478, 13049.217046977212, 11810.645680629596, 12446.875531244663, 12549.560765373259, 12561.681023492492, 12720.936395317964, 11524.711882202928, 11593.072554195644, 11759.0, 11900.166988310822, 11952.0, 4059.6549293310104, 4075.347944328893, 4139.172165566899, 4269.444972153631, 4271.829126834954, 64693.67653161751, 67022.9946550807, 67209.32790672079, 67901.66049169723, 68214.65892670554, 10046.196304295785, 10155.12130255905, 10184.115938551391, 10197.082262596401, 10320.43237621938, 19083.427497175107, 19097.140628671743, 19106.0, 19109.522261943286, 19118.2352705893, 6511.544191906616, 6578.375054369827, 6626.105475760807, 6886.449084073262, 6899.17209934801, 3691.446283057509, 3699.3341198583976, 3790.1851102013197, 3790.8294126764363, 3860.478835357247, 2702.297402675279, 2805.088346287465, 2807.859607019641, 2813.4795062913427, 2818.3517790908204, 545.7080461952836, 559.6250512156864, 571.5856004396862, 578.3897987623014, 580.1645630292365, 505.5450094914533, 532.8756324156028, 582.0, 587.5446528940106, 600.4685853020109, 8217.342612591097, 8224.259816616533, 8387.370947178864, 8447.239748422671, 8812.07473215316, 510.4410670315998, 559.9216109744558, 572.9942700573024, 586.9031609784423, 620.4478014567039, 3931.233409485123, 3981.3828856527284, 4159.334506478949, 4244.617984381359, 4277.379779931893, 95408.0, 103935.0, 104838.0, 105576.47211763891, 105928.94071059345, 90434.0, 91354.0, 93524.0, 93995.0, 95428.0, 54003.72998134984, 71393.28606713866, 77113.22886771061, 77241.0, 78669.60665196752, 8448.873266900879, 8735.606897689491, 8784.78038049054, 8806.867896981423, 8869.512176830336, 31901.0, 38827.6117238824, 42757.57242427536, 43229.13541729085, 45735.771321143184, 55142.44857551373, 59795.0, 62379.6881015592, 62669.37330626635, 62893.68553157388, 10793.838092428463, 11139.777204456028, 11210.607628732956, 11298.60454884075, 11824.586139485076, 12371.381430928237, 12777.808332874829, 12809.674884882117, 13683.452661893412, 13688.589342319747, 9619.663311784054, 11769.0, 11957.760844782882, 12214.450349734105, 12358.011359091432, 11956.402179891145, 12183.878161218274, 12275.0, 12535.788134245471, 13100.082994190316, 11175.161862860155, 11712.531498739954, 11909.52361905514, 12416.441260143496, 12433.564825231073, 9676.806463870824, 10286.485675716334, 10405.0, 10413.375197487872, 10485.16118710486, 9753.9024609753, 10488.580456781643, 10551.736206594896, 10644.787104257717, 10922.12622990143], "value": 6627.0653398264185, "unit": "score"}], "name": "dromaeo_css", "value": 6328.423227820463, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 135.0, 117.0, 115.0, 113.0, 113.0, 113.0, 112.0, 115.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 134.0, 151.0, 178.0, 123.0, 149.0, 152.0, 127.0, 182.0, 124.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 159.0, 161.0, 164.0, 163.0, 163.0, 164.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 170.0, 78.0, 78.0, 76.0, 75.0, 165.0, 75.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 160.0, 84.0, 84.0, 82.0, 143.0, 83.0, 84.0, 144.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 67.0, 66.0, 66.0, 65.0, 68.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 83.0, 81.0, 90.0, 86.0, 82.0, 81.0, 82.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 131.0, 130.0, 131.0, 133.0, 134.0, 135.0, 145.0, 171.0, 131.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 177.0, 173.0, 170.0, 175.0, 179.0, 173.0, 175.0, 173.0, 172.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 71.0, 70.0, 70.0, 71.0, 68.0, 69.0, 67.0, 68.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1583.2, "alertThreshold": 2.0}]} 14:34:55 INFO - Return code: 0 14:34:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:34:55 INFO - # TBPL SUCCESS # 14:34:55 INFO - Running post-action listener: _resource_record_post_action 14:34:55 INFO - [mozharness: 2016-08-31 21:34:55.590881Z] Finished run-tests step (success) 14:34:55 INFO - Running post-run listener: _resource_record_post_run 14:34:55 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 417394688; Read time: 12; Write time: 401612 14:34:55 INFO - TinderboxPrint: CPU usage
13.1% 14:34:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:34:55 INFO - TinderboxPrint: I/O write bytes / time
417,394,688 / 401,612 14:34:55 INFO - TinderboxPrint: CPU idle
8,336.3 (86.9%) 14:34:55 INFO - TinderboxPrint: CPU user
1,203.6 (12.5%) 14:34:55 INFO - TinderboxPrint: Swap in / out
0 / 0 14:34:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 125001728; Read time: 0; Write time: 113228 14:34:55 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292392960; Read time: 0; Write time: 288384 14:34:56 INFO - Running post-run listener: _upload_blobber_files 14:34:56 INFO - Blob upload gear active. 14:34:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:34:56 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 14:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:34:56 INFO - (blobuploader) - INFO - Open directory for files ... 14:34:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:34:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:34:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:34:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:34:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:34:57 INFO - (blobuploader) - INFO - Done attempting. 14:34:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:34:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:34:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:34:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:34:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:34:58 INFO - (blobuploader) - INFO - Done attempting. 14:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:35:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:01 INFO - (blobuploader) - INFO - Done attempting. 14:35:01 INFO - (blobuploader) - INFO - Iteration through files over. 14:35:01 INFO - Return code: 0 14:35:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:35:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:35:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f6948f1896efc0819b8aad984337849430eac0b0c225bfc20cc5f1ee54c34d58d5e559e6de5d21533a096d4eb425b3be6b7b3b21b73f0dcd6d5654263aae3e46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/85c079946d600e41aa1c6ee8c9040aec8d9f771bc12f31139d314dedba433bec0a62f803d84d64c9f83869e746b5ce6ef4687c544c2aaae615066563644d9314", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1807c497ab7ae57b1429ebc7dbda19a67c7529eed991c6279398285e6349bb39aa6e068dd4204dfb03c514b8e295327f3457d3637030fa314da276651fe702f5"} 14:35:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:35:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:35:01 INFO - Contents: 14:35:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f6948f1896efc0819b8aad984337849430eac0b0c225bfc20cc5f1ee54c34d58d5e559e6de5d21533a096d4eb425b3be6b7b3b21b73f0dcd6d5654263aae3e46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/85c079946d600e41aa1c6ee8c9040aec8d9f771bc12f31139d314dedba433bec0a62f803d84d64c9f83869e746b5ce6ef4687c544c2aaae615066563644d9314", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1807c497ab7ae57b1429ebc7dbda19a67c7529eed991c6279398285e6349bb39aa6e068dd4204dfb03c514b8e295327f3457d3637030fa314da276651fe702f5"} 14:35:01 INFO - Running post-run listener: copy_logs_to_upload_dir 14:35:01 INFO - Copying logs to upload dir... 14:35:01 INFO - mkdir: /builds/slave/test/build/upload/logs 14:35:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.098027 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-31 14:35:01.755392) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 14:35:01.758524) ========= 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=0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f6948f1896efc0819b8aad984337849430eac0b0c225bfc20cc5f1ee54c34d58d5e559e6de5d21533a096d4eb425b3be6b7b3b21b73f0dcd6d5654263aae3e46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/85c079946d600e41aa1c6ee8c9040aec8d9f771bc12f31139d314dedba433bec0a62f803d84d64c9f83869e746b5ce6ef4687c544c2aaae615066563644d9314", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1807c497ab7ae57b1429ebc7dbda19a67c7529eed991c6279398285e6349bb39aa6e068dd4204dfb03c514b8e295327f3457d3637030fa314da276651fe702f5"} build_url:https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/HYCqxNhZTcOPr18G755SyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f6948f1896efc0819b8aad984337849430eac0b0c225bfc20cc5f1ee54c34d58d5e559e6de5d21533a096d4eb425b3be6b7b3b21b73f0dcd6d5654263aae3e46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/85c079946d600e41aa1c6ee8c9040aec8d9f771bc12f31139d314dedba433bec0a62f803d84d64c9f83869e746b5ce6ef4687c544c2aaae615066563644d9314", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1807c497ab7ae57b1429ebc7dbda19a67c7529eed991c6279398285e6349bb39aa6e068dd4204dfb03c514b8e295327f3457d3637030fa314da276651fe702f5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 14:35:01.784003) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 14:35:01.784338) ========= 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=0e2a256762fed810e2f0f810000001b3-1472677848.446921-37650106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 14:35:01.869626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 14:35:01.870086) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 14:35:01.870456) ========= ========= Total master_lag: 0.23 =========