builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1471467925.51 results: success (0) buildid: 20160817125015 builduid: 3fc1c3fbc4134d86aeedd25d747da207 revision: 6d6f82046da48820aca4a866fa0184234783ed7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:25.506792) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:25.507259) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:25.507572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:25.612303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:25.612597) ========= 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-1471463919.307257-108200794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-17 14:05:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-08-17 14:05:26 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105674 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:25.745344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:25.745755) ========= 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-1471463919.307257-108200794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023116 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:25.796817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:25.797434) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6d6f82046da48820aca4a866fa0184234783ed7d --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 6d6f82046da48820aca4a866fa0184234783ed7d --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-1471463919.307257-108200794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-17 14:05:26,706 truncating revision to first 12 chars 2016-08-17 14:05:26,707 Setting DEBUG logging. 2016-08-17 14:05:26,707 attempt 1/10 2016-08-17 14:05:26,707 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6d6f82046da4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 14:05:27,043 unpacking tar archive at: autoland-6d6f82046da4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681675 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:26.495209) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:26.495578) ========= script_repo_revision: 6d6f82046da48820aca4a866fa0184234783ed7d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:26.496142) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:26.496477) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 14:05:26.507783) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-17 14:05:26.508099) ========= /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-1471463919.307257-108200794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:05:27 INFO - MultiFileLogger online at 20160817 14:05:27 in /builds/slave/test 14:05:27 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:05:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:05:27 INFO - {'append_to_log': False, 14:05:27 INFO - 'base_work_dir': '/builds/slave/test', 14:05:27 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 14:05:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:05:27 INFO - 'branch': 'Autoland-Non-PGO', 14:05:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:05:27 INFO - 'config_files': ('talos/linux_config.py',), 14:05:27 INFO - 'default_actions': ('clobber', 14:05:27 INFO - 'read-buildbot-config', 14:05:27 INFO - 'download-and-extract', 14:05:27 INFO - 'populate-webroot', 14:05:27 INFO - 'create-virtualenv', 14:05:27 INFO - 'install', 14:05:27 INFO - 'run-tests'), 14:05:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:05:27 INFO - 'download_minidump_stackwalk': True, 14:05:27 INFO - 'download_symbols': 'ondemand', 14:05:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:05:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:05:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:05:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:05:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:05:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:05:27 INFO - 'installer_path': 'installer.exe', 14:05:27 INFO - 'log_level': 'info', 14:05:27 INFO - 'log_name': 'talos', 14:05:27 INFO - 'log_to_console': True, 14:05:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:05:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:05:27 INFO - 'opt_config_files': (), 14:05:27 INFO - 'pip_index': False, 14:05:27 INFO - 'sps_profile': False, 14:05:27 INFO - 'sps_profile_interval': 0, 14:05:27 INFO - 'suite': 'dromaeojs', 14:05:27 INFO - 'system_bits': '32', 14:05:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:05:27 INFO - 'title': 'talos-linux64-ix-058', 14:05:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:05:27 INFO - 'use_talos_json': True, 14:05:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:05:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:05:27 INFO - 'work_dir': 'build'} 14:05:27 INFO - [mozharness: 2016-08-17 21:05:27.514152Z] Running clobber step. 14:05:27 INFO - Running pre-action listener: _resource_record_pre_action 14:05:27 INFO - Running main action method: clobber 14:05:27 INFO - rmtree: /builds/slave/test/build 14:05:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:05:27 INFO - Running post-action listener: _resource_record_post_action 14:05:27 INFO - [mozharness: 2016-08-17 21:05:27.975277Z] Finished clobber step (success) 14:05:27 INFO - [mozharness: 2016-08-17 21:05:27.975378Z] Running read-buildbot-config step. 14:05:27 INFO - Running pre-action listener: _resource_record_pre_action 14:05:27 INFO - Running main action method: read_buildbot_config 14:05:27 INFO - Using buildbot properties: 14:05:27 INFO - { 14:05:27 INFO - "project": "", 14:05:27 INFO - "product": "firefox", 14:05:27 INFO - "script_repo_revision": "production", 14:05:27 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 14:05:27 INFO - "repository": "", 14:05:27 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 14:05:27 INFO - "buildid": "20160817125015", 14:05:27 INFO - "pgo_build": "False", 14:05:27 INFO - "basedir": "/builds/slave/test", 14:05:27 INFO - "buildnumber": 266, 14:05:27 INFO - "slavename": "talos-linux64-ix-058", 14:05:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:05:27 INFO - "platform": "ubuntu64_hw", 14:05:27 INFO - "scheduler": "tests-autoland-linux64-talos-7-3600", 14:05:27 INFO - "branch": "autoland", 14:05:27 INFO - "repo_path": "integration/autoland", 14:05:27 INFO - "revision": "6d6f82046da48820aca4a866fa0184234783ed7d", 14:05:27 INFO - "stage_platform": "linux64", 14:05:27 INFO - "builduid": "3fc1c3fbc4134d86aeedd25d747da207", 14:05:27 INFO - "slavebuilddir": "test" 14:05:27 INFO - } 14:05:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:05:27 INFO - Running post-action listener: _resource_record_post_action 14:05:27 INFO - [mozharness: 2016-08-17 21:05:27.977838Z] Finished read-buildbot-config step (success) 14:05:27 INFO - [mozharness: 2016-08-17 21:05:27.977926Z] Running download-and-extract step. 14:05:27 INFO - Running pre-action listener: _resource_record_pre_action 14:05:27 INFO - Running main action method: download_and_extract 14:05:27 INFO - mkdir: /builds/slave/test/build/tests 14:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:27 INFO - trying https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:05:27 INFO - Downloading https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/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:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/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:05:28 INFO - Downloaded 1361 bytes. 14:05:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:05:28 INFO - Using the following test package requirements: 14:05:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:05:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:05:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:05:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:28 INFO - u'jsshell-linux-x86_64.zip'], 14:05:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:05:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:05:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:05:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:05:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:05:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:05:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:05: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:05:28 INFO - trying https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:05:28 INFO - Downloading https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/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:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/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:05:29 INFO - Downloaded 20316794 bytes. 14:05:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 14:05:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:05: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:05:33 INFO - trying https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:05:33 INFO - Downloading https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/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:05:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/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:05:34 INFO - Downloaded 20316794 bytes. 14:05:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 14:05: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:05:39 INFO - trying https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:05:39 INFO - Downloading https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/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:05:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/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:05:41 INFO - Downloaded 14413719 bytes. 14:05:41 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:05: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:05:41 INFO - trying https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:05:41 INFO - Downloading https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/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:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/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:05:42 INFO - Downloaded 55759672 bytes. 14:05:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:05:42 INFO - mkdir: /builds/slave/test/properties 14:05:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:05:42 INFO - Writing to file /builds/slave/test/properties/build_url 14:05:42 INFO - Contents: 14:05:42 INFO - build_url:https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:05:43 INFO - Running post-action listener: _resource_record_post_action 14:05:43 INFO - Running post-action listener: set_extra_try_arguments 14:05:43 INFO - [mozharness: 2016-08-17 21:05:43.300496Z] Finished download-and-extract step (success) 14:05:43 INFO - [mozharness: 2016-08-17 21:05:43.300720Z] Running populate-webroot step. 14:05:43 INFO - Running pre-action listener: _resource_record_pre_action 14:05:43 INFO - Running main action method: populate_webroot 14:05:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:05:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:05:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:05:43 INFO - '--tppagecycles', 14:05:43 INFO - '7'], 14:05:43 INFO - 'tests': ['tsvgm']}}, 14:05:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:05:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:05:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:05:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:05:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:05:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:05:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:43 INFO - 'talos_options': ['--disable-e10s'], 14:05:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:43 INFO - 'talos_options': ['--disable-e10s'], 14:05:43 INFO - 'tests': ['damp', 'tps']}, 14:05:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:43 INFO - 'tests': ['damp', 'tps']}, 14:05:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:05:43 INFO - 'tests': ['dromaeo_dom']}, 14:05:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:05:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:05:43 INFO - 'tests': ['basic_compositor_video']}, 14:05:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:05:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:05:43 INFO - 'tests': ['a11yr', 14:05:43 INFO - 'ts_paint', 14:05:43 INFO - 'tpaint', 14:05:43 INFO - 'sessionrestore', 14:05:43 INFO - 'sessionrestore_no_auto_restore', 14:05:43 INFO - 'tabpaint']}, 14:05:43 INFO - 'other-e10s': {'tests': ['a11yr', 14:05:43 INFO - 'ts_paint', 14:05:43 INFO - 'tpaint', 14:05:43 INFO - 'sessionrestore', 14:05:43 INFO - 'sessionrestore_no_auto_restore', 14:05:43 INFO - 'tabpaint']}, 14:05:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:05:43 INFO - 'ts_paint', 14:05:43 INFO - 'tpaint', 14:05:43 INFO - 'sessionrestore', 14:05:43 INFO - 'sessionrestore_no_auto_restore', 14:05:43 INFO - 'tabpaint']}, 14:05:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:05:43 INFO - 'ts_paint', 14:05:43 INFO - 'tpaint', 14:05:43 INFO - 'sessionrestore', 14:05:43 INFO - 'sessionrestore_no_auto_restore', 14:05:43 INFO - 'tabpaint']}, 14:05:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:05:43 INFO - 'tests': ['a11yr', 14:05:43 INFO - 'ts_paint', 14:05:43 INFO - 'tpaint', 14:05:43 INFO - 'sessionrestore', 14:05:43 INFO - 'sessionrestore_no_auto_restore', 14:05:43 INFO - 'tabpaint']}, 14:05:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:05:43 INFO - 'tests': ['a11yr', 14:05:43 INFO - 'ts_paint', 14:05:43 INFO - 'tpaint', 14:05:43 INFO - 'sessionrestore', 14:05:43 INFO - 'sessionrestore_no_auto_restore', 14:05:43 INFO - 'tabpaint']}, 14:05:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:05:43 INFO - 'tests': ['tsvgx', 14:05:43 INFO - 'tsvgr_opacity', 14:05:43 INFO - 'tart', 14:05:43 INFO - 'tscrollx', 14:05:43 INFO - 'cart']}, 14:05:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:05:43 INFO - 'tsvgr_opacity', 14:05:43 INFO - 'tart', 14:05:43 INFO - 'tscrollx', 14:05:43 INFO - 'cart']}, 14:05:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:43 INFO - 'talos_options': ['--disable-e10s'], 14:05:43 INFO - 'tests': ['tp5o']}, 14:05:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:43 INFO - 'tests': ['tp5o']}, 14:05:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:43 INFO - 'talos_options': ['--disable-e10s', 14:05:43 INFO - '--xperf_path', 14:05:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:43 INFO - 'tests': ['tp5n']}, 14:05:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:43 INFO - 'talos_options': ['--xperf_path', 14:05:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:43 INFO - 'tests': ['tp5n']}}, 14:05:43 INFO - 'talos.zip': {'path': '', 14:05:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:05:43 INFO - Running post-action listener: _resource_record_post_action 14:05:43 INFO - [mozharness: 2016-08-17 21:05:43.316810Z] Finished populate-webroot step (success) 14:05:43 INFO - [mozharness: 2016-08-17 21:05:43.316898Z] Running create-virtualenv step. 14:05:43 INFO - Running pre-action listener: _resource_record_pre_action 14:05:43 INFO - Running main action method: create_virtualenv 14:05:43 INFO - Creating virtualenv /builds/slave/test/build/venv 14:05:43 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:05:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:05:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:05:43 INFO - Using real prefix '/usr' 14:05:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:05:43 INFO - Installing distribute.............................................................................................................................................................................................done. 14:05:45 INFO - Installing pip.................done. 14:05:45 INFO - Return code: 0 14:05:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:05: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:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:45 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 0x7fa028534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebc090>, '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 0xebf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebfe40>, '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-1471463919.307257-108200794', '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:05:45 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:05:45 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:05:45 INFO - Using env: {'DISPLAY': ':0', 14:05:45 INFO - 'HOME': '/home/cltbld', 14:05:45 INFO - 'LANG': 'en_US.UTF-8', 14:05:45 INFO - 'LANGUAGE': 'en_US:en', 14:05:45 INFO - 'LOGNAME': 'cltbld', 14:05:45 INFO - 'MAIL': '/var/mail/cltbld', 14:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:45 INFO - 'MOZ_NO_REMOTE': '1', 14:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:45 INFO - 'NO_EM_RESTART': '1', 14:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:45 INFO - 'PWD': '/builds/slave/test', 14:05:45 INFO - 'SHELL': '/bin/bash', 14:05:45 INFO - 'SHLVL': '1', 14:05:45 INFO - 'TERM': 'linux', 14:05:45 INFO - 'TMOUT': '86400', 14:05:45 INFO - 'USER': 'cltbld', 14:05:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471463919.307257-108200794', 14:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:45 INFO - '_': '/tools/buildbot/bin/python'} 14:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:46 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:05:46 INFO - Cleaning up... 14:05:46 INFO - Return code: 0 14:05:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa028534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebc090>, '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 0xebf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebfe40>, '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-1471463919.307257-108200794', '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:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:05:46 INFO - Using env: {'DISPLAY': ':0', 14:05:46 INFO - 'HOME': '/home/cltbld', 14:05:46 INFO - 'LANG': 'en_US.UTF-8', 14:05:46 INFO - 'LANGUAGE': 'en_US:en', 14:05:46 INFO - 'LOGNAME': 'cltbld', 14:05:46 INFO - 'MAIL': '/var/mail/cltbld', 14:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:46 INFO - 'MOZ_NO_REMOTE': '1', 14:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:46 INFO - 'NO_EM_RESTART': '1', 14:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:46 INFO - 'PWD': '/builds/slave/test', 14:05:46 INFO - 'SHELL': '/bin/bash', 14:05:46 INFO - 'SHLVL': '1', 14:05:46 INFO - 'TERM': 'linux', 14:05:46 INFO - 'TMOUT': '86400', 14:05:46 INFO - 'USER': 'cltbld', 14:05:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471463919.307257-108200794', 14:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:46 INFO - '_': '/tools/buildbot/bin/python'} 14:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:46 INFO - Downloading/unpacking psutil>=3.1.1 14:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:05:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:48 INFO - Installing collected packages: psutil 14:05:48 INFO - Running setup.py install for psutil 14:05:48 INFO - building 'psutil._psutil_linux' extension 14:05:48 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:05:48 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:05:48 INFO - building 'psutil._psutil_posix' extension 14:05:48 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:05:48 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:05:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:48 INFO - Successfully installed psutil 14:05:48 INFO - Cleaning up... 14:05:48 INFO - Return code: 0 14:05:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:05: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:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:48 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 0x7fa028534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebc090>, '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 0xebf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebfe40>, '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-1471463919.307257-108200794', '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:05:48 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:05:48 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:05:48 INFO - Using env: {'DISPLAY': ':0', 14:05:48 INFO - 'HOME': '/home/cltbld', 14:05:48 INFO - 'LANG': 'en_US.UTF-8', 14:05:48 INFO - 'LANGUAGE': 'en_US:en', 14:05:48 INFO - 'LOGNAME': 'cltbld', 14:05:48 INFO - 'MAIL': '/var/mail/cltbld', 14:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:48 INFO - 'MOZ_NO_REMOTE': '1', 14:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:48 INFO - 'NO_EM_RESTART': '1', 14:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:48 INFO - 'PWD': '/builds/slave/test', 14:05:48 INFO - 'SHELL': '/bin/bash', 14:05:48 INFO - 'SHLVL': '1', 14:05:48 INFO - 'TERM': 'linux', 14:05:48 INFO - 'TMOUT': '86400', 14:05:48 INFO - 'USER': 'cltbld', 14:05:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471463919.307257-108200794', 14:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:48 INFO - '_': '/tools/buildbot/bin/python'} 14:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:05:51 INFO - Installing collected packages: mozsystemmonitor 14:05:51 INFO - Running setup.py install for mozsystemmonitor 14:05:51 INFO - Successfully installed mozsystemmonitor 14:05:51 INFO - Cleaning up... 14:05:51 INFO - Return code: 0 14:05:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa028534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebc090>, '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 0xebf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebfe40>, '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-1471463919.307257-108200794', '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:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:05:51 INFO - Using env: {'DISPLAY': ':0', 14:05:51 INFO - 'HOME': '/home/cltbld', 14:05:51 INFO - 'LANG': 'en_US.UTF-8', 14:05:51 INFO - 'LANGUAGE': 'en_US:en', 14:05:51 INFO - 'LOGNAME': 'cltbld', 14:05:51 INFO - 'MAIL': '/var/mail/cltbld', 14:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:51 INFO - 'MOZ_NO_REMOTE': '1', 14:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:51 INFO - 'NO_EM_RESTART': '1', 14:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:51 INFO - 'PWD': '/builds/slave/test', 14:05:51 INFO - 'SHELL': '/bin/bash', 14:05:51 INFO - 'SHLVL': '1', 14:05:51 INFO - 'TERM': 'linux', 14:05:51 INFO - 'TMOUT': '86400', 14:05:51 INFO - 'USER': 'cltbld', 14:05:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471463919.307257-108200794', 14:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:51 INFO - '_': '/tools/buildbot/bin/python'} 14:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:51 INFO - Downloading/unpacking jsonschema==2.5.1 14:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:05:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:53 INFO - Downloading functools32-3.2.3-2.tar.gz 14:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:05:53 INFO - warning: no files found matching '*.txt' 14:05:53 INFO - no previously-included directories found matching 'build' 14:05:53 INFO - no previously-included directories found matching 'dist' 14:05:53 INFO - no previously-included directories found matching '.git*' 14:05:53 INFO - Installing collected packages: jsonschema, functools32 14:05:53 INFO - Running setup.py install for functools32 14:05:53 INFO - warning: no files found matching '*.txt' 14:05:53 INFO - no previously-included directories found matching 'build' 14:05:53 INFO - no previously-included directories found matching 'dist' 14:05:53 INFO - no previously-included directories found matching '.git*' 14:05:53 INFO - Successfully installed jsonschema functools32 14:05:53 INFO - Cleaning up... 14:05:53 INFO - Return code: 0 14:05:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa028534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebc090>, '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 0xebf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebfe40>, '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-1471463919.307257-108200794', '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:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:05:53 INFO - Using env: {'DISPLAY': ':0', 14:05:53 INFO - 'HOME': '/home/cltbld', 14:05:53 INFO - 'LANG': 'en_US.UTF-8', 14:05:53 INFO - 'LANGUAGE': 'en_US:en', 14:05:53 INFO - 'LOGNAME': 'cltbld', 14:05:53 INFO - 'MAIL': '/var/mail/cltbld', 14:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:53 INFO - 'MOZ_NO_REMOTE': '1', 14:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:53 INFO - 'NO_EM_RESTART': '1', 14:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:53 INFO - 'PWD': '/builds/slave/test', 14:05:53 INFO - 'SHELL': '/bin/bash', 14:05:53 INFO - 'SHLVL': '1', 14:05:53 INFO - 'TERM': 'linux', 14:05:53 INFO - 'TMOUT': '86400', 14:05:53 INFO - 'USER': 'cltbld', 14:05:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471463919.307257-108200794', 14:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:53 INFO - '_': '/tools/buildbot/bin/python'} 14:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:05:53 INFO - Cleaning up... 14:05:53 INFO - Return code: 0 14:05:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa028534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebc090>, '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 0xebf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebfe40>, '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-1471463919.307257-108200794', '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:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:05:53 INFO - Using env: {'DISPLAY': ':0', 14:05:53 INFO - 'HOME': '/home/cltbld', 14:05:53 INFO - 'LANG': 'en_US.UTF-8', 14:05:53 INFO - 'LANGUAGE': 'en_US:en', 14:05:53 INFO - 'LOGNAME': 'cltbld', 14:05:53 INFO - 'MAIL': '/var/mail/cltbld', 14:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:53 INFO - 'MOZ_NO_REMOTE': '1', 14:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:53 INFO - 'NO_EM_RESTART': '1', 14:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:53 INFO - 'PWD': '/builds/slave/test', 14:05:53 INFO - 'SHELL': '/bin/bash', 14:05:53 INFO - 'SHLVL': '1', 14:05:53 INFO - 'TERM': 'linux', 14:05:53 INFO - 'TMOUT': '86400', 14:05:53 INFO - 'USER': 'cltbld', 14:05:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471463919.307257-108200794', 14:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:53 INFO - '_': '/tools/buildbot/bin/python'} 14:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:54 INFO - Downloading/unpacking blobuploader==1.2.4 14:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:56 INFO - Downloading blobuploader-1.2.4.tar.gz 14:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:05:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:05:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:56 INFO - Downloading docopt-0.6.1.tar.gz 14:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:05:56 INFO - Installing collected packages: blobuploader, requests, docopt 14:05:56 INFO - Running setup.py install for blobuploader 14:05:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:05:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:05:56 INFO - Running setup.py install for requests 14:05:57 INFO - Running setup.py install for docopt 14:05:57 INFO - Successfully installed blobuploader requests docopt 14:05:57 INFO - Cleaning up... 14:05:57 INFO - Return code: 0 14:05:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05:57 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:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:57 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:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:57 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 0x7fa028534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebc090>, '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 0xebf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebfe40>, '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-1471463919.307257-108200794', '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:05:57 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:05:57 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:05:57 INFO - Using env: {'DISPLAY': ':0', 14:05:57 INFO - 'HOME': '/home/cltbld', 14:05:57 INFO - 'LANG': 'en_US.UTF-8', 14:05:57 INFO - 'LANGUAGE': 'en_US:en', 14:05:57 INFO - 'LOGNAME': 'cltbld', 14:05:57 INFO - 'MAIL': '/var/mail/cltbld', 14:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:57 INFO - 'MOZ_NO_REMOTE': '1', 14:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:57 INFO - 'NO_EM_RESTART': '1', 14:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:57 INFO - 'PWD': '/builds/slave/test', 14:05:57 INFO - 'SHELL': '/bin/bash', 14:05:57 INFO - 'SHLVL': '1', 14:05:57 INFO - 'TERM': 'linux', 14:05:57 INFO - 'TMOUT': '86400', 14:05:57 INFO - 'USER': 'cltbld', 14:05:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471463919.307257-108200794', 14:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:57 INFO - '_': '/tools/buildbot/bin/python'} 14:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:05:57 INFO - Running setup.py (path:/tmp/pip-DzCbGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:05:57 INFO - Running setup.py (path:/tmp/pip-7T9ML9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:05:57 INFO - Running setup.py (path:/tmp/pip-27k5sM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:05:57 INFO - Running setup.py (path:/tmp/pip-w3HDaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:05:57 INFO - Running setup.py (path:/tmp/pip-xYr6tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:05:58 INFO - Running setup.py (path:/tmp/pip-EwKlx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:05:58 INFO - Running setup.py (path:/tmp/pip-griLiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:05:58 INFO - Running setup.py (path:/tmp/pip-D4E2QR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:05:58 INFO - Running setup.py (path:/tmp/pip-AyEyd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:05:58 INFO - Running setup.py (path:/tmp/pip-FhLB_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:05:58 INFO - Running setup.py (path:/tmp/pip-CrivAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:05:58 INFO - Running setup.py (path:/tmp/pip-y9PxHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:05:58 INFO - Running setup.py (path:/tmp/pip-CZKZd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:05:58 INFO - Running setup.py (path:/tmp/pip-gvhu2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:58 INFO - Running setup.py (path:/tmp/pip-ExPCCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:05:58 INFO - Running setup.py (path:/tmp/pip-acBtHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:05:58 INFO - Running setup.py (path:/tmp/pip-Uc6vCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:05:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:05:58 INFO - Running setup.py install for manifestparser 14:05:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Running setup.py install for mozcrash 14:05:59 INFO - Running setup.py install for mozdebug 14:05:59 INFO - Running setup.py install for mozdevice 14:05:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Running setup.py install for mozfile 14:05:59 INFO - Running setup.py install for mozhttpd 14:05:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Running setup.py install for mozinfo 14:05:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Running setup.py install for mozInstall 14:05:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Running setup.py install for mozleak 14:05:59 INFO - Running setup.py install for mozlog 14:05:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Running setup.py install for moznetwork 14:06:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:06:00 INFO - Running setup.py install for mozprocess 14:06:00 INFO - Running setup.py install for mozprofile 14:06:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:06:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:06:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:06:00 INFO - Running setup.py install for mozrunner 14:06:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:06:00 INFO - Running setup.py install for mozscreenshot 14:06:00 INFO - Running setup.py install for moztest 14:06:00 INFO - Running setup.py install for mozversion 14:06:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:06:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:06:00 INFO - Cleaning up... 14:06:00 INFO - Return code: 0 14:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:00 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 0x7fa028534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebc090>, '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 0xebf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebfe40>, '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-1471463919.307257-108200794', '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:06:00 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:06:00 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:06:00 INFO - Using env: {'DISPLAY': ':0', 14:06:00 INFO - 'HOME': '/home/cltbld', 14:06:00 INFO - 'LANG': 'en_US.UTF-8', 14:06:00 INFO - 'LANGUAGE': 'en_US:en', 14:06:00 INFO - 'LOGNAME': 'cltbld', 14:06:00 INFO - 'MAIL': '/var/mail/cltbld', 14:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:00 INFO - 'MOZ_NO_REMOTE': '1', 14:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:00 INFO - 'NO_EM_RESTART': '1', 14:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:00 INFO - 'PWD': '/builds/slave/test', 14:06:00 INFO - 'SHELL': '/bin/bash', 14:06:00 INFO - 'SHLVL': '1', 14:06:00 INFO - 'TERM': 'linux', 14:06:00 INFO - 'TMOUT': '86400', 14:06:00 INFO - 'USER': 'cltbld', 14:06:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471463919.307257-108200794', 14:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:00 INFO - '_': '/tools/buildbot/bin/python'} 14:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:00 INFO - Running setup.py (path:/tmp/pip-8z9Ybb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:00 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:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:00 INFO - Running setup.py (path:/tmp/pip-yaYitE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:01 INFO - Running setup.py (path:/tmp/pip-j2Q2Qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:01 INFO - Running setup.py (path:/tmp/pip-XTum6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:01 INFO - Running setup.py (path:/tmp/pip-HIRFon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:01 INFO - Running setup.py (path:/tmp/pip-473XNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:01 INFO - Running setup.py (path:/tmp/pip-7ynFab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:01 INFO - Running setup.py (path:/tmp/pip-jyzQx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:01 INFO - Running setup.py (path:/tmp/pip-FqPYqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:01 INFO - Running setup.py (path:/tmp/pip-OjpWsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:01 INFO - Running setup.py (path:/tmp/pip-i3iT2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:01 INFO - Running setup.py (path:/tmp/pip-KsU_jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:01 INFO - Running setup.py (path:/tmp/pip-m15xJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:01 INFO - Running setup.py (path:/tmp/pip-GPrB7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:01 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:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:01 INFO - Running setup.py (path:/tmp/pip-0s5ECF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:02 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:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:02 INFO - Running setup.py (path:/tmp/pip-TT1JKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:02 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:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:02 INFO - Running setup.py (path:/tmp/pip-qfVihM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:02 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:06:02 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:06:02 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:06:02 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:06:02 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:06:02 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:06:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:06:02 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:06:02 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:06:02 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:06:02 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:06:02 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:06:02 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:06:04 INFO - Downloading blessings-1.6.tar.gz 14:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:06:04 INFO - Installing collected packages: blessings 14:06:04 INFO - Running setup.py install for blessings 14:06:04 INFO - Successfully installed blessings 14:06:04 INFO - Cleaning up... 14:06:04 INFO - Return code: 0 14:06:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:04 INFO - Reading from file tmpfile_stdout 14:06:04 INFO - Current package versions: 14:06:04 INFO - argparse == 1.2.1 14:06:04 INFO - blessings == 1.6 14:06:04 INFO - blobuploader == 1.2.4 14:06:04 INFO - docopt == 0.6.1 14:06:04 INFO - functools32 == 3.2.3-2 14:06:04 INFO - jsonschema == 2.5.1 14:06:04 INFO - manifestparser == 1.1 14:06:04 INFO - mozInstall == 1.12 14:06:04 INFO - mozcrash == 0.17 14:06:04 INFO - mozdebug == 0.1 14:06:04 INFO - mozdevice == 0.48 14:06:04 INFO - mozfile == 1.2 14:06:04 INFO - mozhttpd == 0.7 14:06:04 INFO - mozinfo == 0.9 14:06:04 INFO - mozleak == 0.1 14:06:04 INFO - mozlog == 3.3 14:06:04 INFO - moznetwork == 0.27 14:06:04 INFO - mozprocess == 0.23 14:06:04 INFO - mozprofile == 0.28 14:06:04 INFO - mozrunner == 6.12 14:06:04 INFO - mozscreenshot == 0.1 14:06:04 INFO - mozsystemmonitor == 0.3 14:06:04 INFO - moztest == 0.7 14:06:04 INFO - mozversion == 1.4 14:06:04 INFO - psutil == 3.1.1 14:06:04 INFO - requests == 1.2.3 14:06:04 INFO - wsgiref == 0.1.2 14:06:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:04 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 0x7fa028534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebc090>, '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 0xebf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebfe40>, '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-1471463919.307257-108200794', '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:06:04 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:06:04 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:06:04 INFO - Using env: {'DISPLAY': ':0', 14:06:04 INFO - 'HOME': '/home/cltbld', 14:06:04 INFO - 'LANG': 'en_US.UTF-8', 14:06:04 INFO - 'LANGUAGE': 'en_US:en', 14:06:04 INFO - 'LOGNAME': 'cltbld', 14:06:04 INFO - 'MAIL': '/var/mail/cltbld', 14:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:04 INFO - 'MOZ_NO_REMOTE': '1', 14:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:04 INFO - 'NO_EM_RESTART': '1', 14:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:04 INFO - 'PWD': '/builds/slave/test', 14:06:04 INFO - 'SHELL': '/bin/bash', 14:06:04 INFO - 'SHLVL': '1', 14:06:04 INFO - 'TERM': 'linux', 14:06:04 INFO - 'TMOUT': '86400', 14:06:04 INFO - 'USER': 'cltbld', 14:06:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471463919.307257-108200794', 14:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:04 INFO - '_': '/tools/buildbot/bin/python'} 14:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:04 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:06:04 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:06:04 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:06:04 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:06:04 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:06:04 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:06:04 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:06:04 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:06:04 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:06:04 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:06:04 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:06:04 INFO - Cleaning up... 14:06:04 INFO - Return code: 0 14:06:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:04 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 0x7fa028534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebc090>, '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 0xebf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebfe40>, '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-1471463919.307257-108200794', '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:06:04 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:06:04 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:06:04 INFO - Using env: {'DISPLAY': ':0', 14:06:04 INFO - 'HOME': '/home/cltbld', 14:06:04 INFO - 'LANG': 'en_US.UTF-8', 14:06:04 INFO - 'LANGUAGE': 'en_US:en', 14:06:04 INFO - 'LOGNAME': 'cltbld', 14:06:04 INFO - 'MAIL': '/var/mail/cltbld', 14:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:04 INFO - 'MOZ_NO_REMOTE': '1', 14:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:04 INFO - 'NO_EM_RESTART': '1', 14:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:04 INFO - 'PWD': '/builds/slave/test', 14:06:04 INFO - 'SHELL': '/bin/bash', 14:06:04 INFO - 'SHLVL': '1', 14:06:04 INFO - 'TERM': 'linux', 14:06:04 INFO - 'TMOUT': '86400', 14:06:04 INFO - 'USER': 'cltbld', 14:06:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471463919.307257-108200794', 14:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:04 INFO - '_': '/tools/buildbot/bin/python'} 14:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:06:04 INFO - Cleaning up... 14:06:04 INFO - Return code: 0 14:06:04 INFO - Running post-action listener: _resource_record_post_action 14:06:04 INFO - Running post-action listener: _start_resource_monitoring 14:06:05 INFO - Starting resource monitoring. 14:06:05 INFO - [mozharness: 2016-08-17 21:06:05.003015Z] Finished create-virtualenv step (success) 14:06:05 INFO - [mozharness: 2016-08-17 21:06:05.003472Z] Running install step. 14:06:05 INFO - Running pre-action listener: _resource_record_pre_action 14:06:05 INFO - Running main action method: install 14:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:05 INFO - Reading from file tmpfile_stdout 14:06:05 INFO - Detecting whether we're running mozinstall >=1.0... 14:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:06:05 INFO - Reading from file tmpfile_stdout 14:06:05 INFO - Output received: 14:06:05 INFO - Usage: mozinstall [options] installer 14:06:05 INFO - Options: 14:06:05 INFO - -h, --help show this help message and exit 14:06:05 INFO - -d DEST, --destination=DEST 14:06:05 INFO - Directory to install application into. [default: 14:06:05 INFO - "/builds/slave/test"] 14:06:05 INFO - --app=APP Application being installed. [default: firefox] 14:06:05 INFO - mkdir: /builds/slave/test/build/application 14:06:05 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:06:05 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:06:21 INFO - Reading from file tmpfile_stdout 14:06:21 INFO - Output received: 14:06:21 INFO - /builds/slave/test/build/application/firefox/firefox 14:06:21 INFO - Running post-action listener: _resource_record_post_action 14:06:21 INFO - [mozharness: 2016-08-17 21:06:21.388502Z] Finished install step (success) 14:06:21 INFO - [mozharness: 2016-08-17 21:06:21.388751Z] Running run-tests step. 14:06:21 INFO - Running pre-action listener: _resource_record_pre_action 14:06:21 INFO - Running main action method: run_tests 14:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:06:21 INFO - Python 2.7.3 14:06:21 INFO - Return code: 0 14:06:21 INFO - grabbing minidump binary from tooltool 14:06:21 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:06:21 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 0xebc090>, '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 0xebf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebfe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:06:21 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:06:21 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:06:21 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:06:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:06:21 INFO - Return code: 0 14:06:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:06:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:06:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:06:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:06:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:06:21 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/BNaKhHT4QrKaPPYbfqtw9Q/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:06:21 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/BNaKhHT4QrKaPPYbfqtw9Q/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:06:21 INFO - Using env: {'DISPLAY': ':0', 14:06:21 INFO - 'HOME': '/home/cltbld', 14:06:21 INFO - 'LANG': 'en_US.UTF-8', 14:06:21 INFO - 'LANGUAGE': 'en_US:en', 14:06:21 INFO - 'LOGNAME': 'cltbld', 14:06:21 INFO - 'MAIL': '/var/mail/cltbld', 14:06:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:06:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:21 INFO - 'MOZ_NO_REMOTE': '1', 14:06:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:21 INFO - 'NO_EM_RESTART': '1', 14:06:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:21 INFO - 'PWD': '/builds/slave/test', 14:06:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:06:21 INFO - 'SHELL': '/bin/bash', 14:06:21 INFO - 'SHLVL': '1', 14:06:21 INFO - 'TERM': 'linux', 14:06:21 INFO - 'TMOUT': '86400', 14:06:21 INFO - 'USER': 'cltbld', 14:06:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471463919.307257-108200794', 14:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:21 INFO - '_': '/tools/buildbot/bin/python'} 14:06:21 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/BNaKhHT4QrKaPPYbfqtw9Q/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:06:21 INFO - mozversion application_buildid: 20160817125015 14:06:21 INFO - mozversion application_changeset: 6d6f82046da48820aca4a866fa0184234783ed7d 14:06:21 INFO - mozversion application_display_name: Nightly 14:06:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:06:21 INFO - mozversion application_name: Firefox 14:06:21 INFO - mozversion application_remotingname: firefox 14:06:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:06:21 INFO - mozversion application_vendor: Mozilla 14:06:21 INFO - mozversion application_version: 51.0a1 14:06:21 INFO - mozversion platform_buildid: 20160817125015 14:06:21 INFO - mozversion platform_changeset: 6d6f82046da48820aca4a866fa0184234783ed7d 14:06:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:06:21 INFO - mozversion platform_version: 51.0a1 14:06:21 INFO - using testdate: 1471467981 14:06:21 INFO - actual date: 1471467981 14:06:21 INFO - starting webserver on 'localhost:34544' 14:06:21 INFO - SUITE-START | Running 2 tests 14:06:21 INFO - TEST-START | dromaeo_css 14:06:21 INFO - operating with platform_type : linux_ 14:06:21 INFO - Initialising browser for dromaeo_css test... 14:06:21 INFO - TEST-INFO | started process 13033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTxaRpe/profile http://localhost:34544/getInfo.html) 14:06:26 INFO - PROCESS | 13033 | __metrics Screen width/height:1600/1200 14:06:26 INFO - PROCESS | 13033 | colorDepth:24 14:06:26 INFO - PROCESS | 13033 | Browser inner width/height: 1024/697 14:06:26 INFO - PROCESS | 13033 | __metrics 14:06:26 INFO - PROCESS | 13033 | 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:06:26 INFO - PROCESS | 13033 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:06:27 INFO - PROCESS | 13033 | console.error: PushService: 14:06:27 INFO - PROCESS | 13033 | stateChangeProcessEnqueue: Error transitioning state 14:06:27 INFO - PROCESS | 13033 | UnknownError 14:06:27 INFO - TEST-INFO | 13033: exit 0 14:06:27 INFO - Browser initialized. 14:06:27 INFO - Running cycle 1/1 for dromaeo_css test... 14:06:27 INFO - TEST-INFO | started process 13114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTxaRpe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:39 INFO - PROCESS | 13114 | RSS: Main: 157380608 14:06:39 INFO - PROCESS | 13114 | 14:07:30 INFO - PROCESS | 13114 | 1471468050621 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:09:43 INFO - PROCESS | 13114 | Cycle 1(1): loaded http://localhost:34544/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34544/tests/dromaeo/cssquery-ext.html) 14:09:45 INFO - PROCESS | 13114 | RSS: Main: 243392512 14:09:45 INFO - PROCESS | 13114 | 14:12:47 INFO - PROCESS | 13114 | Cycle 1(1): loaded http://localhost:34544/tests/dromaeo/cssquery-ext.html (next: http://localhost:34544/tests/dromaeo/cssquery-jquery.html) 14:12:48 INFO - PROCESS | 13114 | RSS: Main: 243417088 14:12:48 INFO - PROCESS | 13114 | 14:15:50 INFO - PROCESS | 13114 | Cycle 1(1): loaded http://localhost:34544/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34544/tests/dromaeo/cssquery-mootools.html) 14:15:51 INFO - PROCESS | 13114 | RSS: Main: 231632896 14:15:51 INFO - PROCESS | 13114 | 14:18:53 INFO - PROCESS | 13114 | Cycle 1(1): loaded http://localhost:34544/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34544/tests/dromaeo/cssquery-prototype.html) 14:18:53 INFO - PROCESS | 13114 | RSS: Main: 191905792 14:18:53 INFO - PROCESS | 13114 | 14:21:56 INFO - PROCESS | 13114 | Cycle 1(1): loaded http://localhost:34544/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34544/tests/dromaeo/cssquery-yui.html) 14:21:57 INFO - PROCESS | 13114 | RSS: Main: 192716800 14:21:57 INFO - PROCESS | 13114 | 14:25:00 INFO - PROCESS | 13114 | Cycle 1(1): loaded http://localhost:34544/tests/dromaeo/cssquery-yui.html (next: http://localhost:34544/tests/dromaeo/cssquery-dojo.html) 14:25:00 INFO - PROCESS | 13114 | RSS: Main: 278974464 14:25:00 INFO - PROCESS | 13114 | 14:25:00 INFO - PROCESS | 13114 | __start_tp_report 14:25:00 INFO - PROCESS | 13114 | _x_x_mozilla_page_load 14:25:00 INFO - PROCESS | 13114 | _x_x_mozilla_page_load_details 14:25:00 INFO - PROCESS | 13114 | |i|pagename|runs| 14:25:00 INFO - PROCESS | 13114 | |0;dojo.html;2570.588705807071;2587.301428614274;2613.1899111275516;2639.458910923261;2657.760801527862;4596.586307232348;4628.8148474061;4744.881377965548;4776.785044672989;4800.039992001601;4619.099275641252;4695.131400690874;4721.457032441271;4721.881952951169;4756.405449318835;4223.556526564713;4241.215375155591;4288.849890253841;4339.826406943718;4411.470623525165;4376.452943382077;4396.274614688588;4424.380586717846;4430.623397011258;4444.066745983348;4241.512226094008;4291.506476755182;4375.978120109411;4381.233284175257;4464.419625448687;4282.357646353041;4299.935500967456;4309.5690430956965;4352.129574085164;4367.279398899178;4284.036091879333;4332.155229730204;4346.587074227975;4355.651547876162;4388.1223755249075;4627.190241707688;4768.856934291976;4774.880627984294;4819.614430845524;4831.685940413862;4914.606831453475;5051.318072060261;5099.413567439755;5169.922451163236;5182;5158.458361871987;5158.664686795384;5180.481951804827;5188.610854185913;5197.922031169535;4683.2038553446;4708.670393072452;4814.975925120352;4851.393575802989;4856.368672072608;5213.374395072616;5259;5282.260483532308;5298.655587386807;5299.655522391032;5036.32009678696;5072.340595722606;5083.923741143886;5090.032893750175;5091.1854103343285;4898.2652602109965;5051.166557517969;5121.129408000575;5175.378954525481;5180.844574662766;5045.344105266292;5087.64386492942;5090.898182036339;5118.846434606968;5124.564412024945;5059.316992206005;5065.088284108822;5069.239614057921;5069.822556210515;5120.974395128001;4109.671226301948;4162.4796900387455;4282.678799090081;4298.548652391516;4336.674749393808;3700.833462494194;3714.5542534895985;3717.5910649828497;3752.718546108998;3825.9043523912123;4357.9782101089295;4361;4364.585364390377;4396.49440314368;4398.868033958986;4936.8765780855765;5047.747612619354;5049.520295571988;5124.256982737482;5162.819301324511;4260.382244574581;4306.935395969063;4358.084802191512;4376.606105450461;4417.867463976086;4553.4763502197675;4610.861674149781;4612.377329060601;4616.16908956391;4661.160991021581;4596.747178905192;4821.2045012573235;4821.276808478756;4827.25177597473;4851.708897466164;5097.566706829961;5162.328897243335;5163.173892177234;5218.9739051304505;5220.190870415092;4824.614030877451;4830.492798256132;4831.396075490564;4843.491433399442;4849.442314133919;5098.1588037973315;5100.387953445462;5108.438071812172;5113.565346945403;5157.922631160461;4952.678075925053;5069.670471419346;5098.107831129611;5120.692758434506;5158.148905430562;4944.826931057396;4952.628552858478;4954.256861470808;4957.801687932587;4994.975025124996;4932.482089380564;4944.505549445027;4945.4312754033745;4947.1342515059005;4992.600591952708;4732.503087175797;4764.237721964469;4841.757912104451;4847.321375007572;4884.1941079722865;4993.076280888047;5012.097822391858;5014.623903207347;5015.874603134951;5059.06407314648;4745.881352966204;4829.95170048295;4850.223964165858;4851.611871050237;4852.56326930578 14:25:00 INFO - PROCESS | 13114 | |1;ext.html;574.4542684449773;588.041492367441;589.5136512377289;590.3034419385124;590.7607418995308;28343.149705508815;38342.8082859586;39596;39867.60132398675;43338.566614333846;40429.393559096636;40830.18339633213;40880.59119408805;40882.79558602203;40884.182316353654;7501.512401693873;7614.885776713354;7628.580428076453;7633.160352361236;7643.23567643234;7651.426143039266;7730.613469326539;7736.9613151934445;7743.612819359009;7746.690132394698;7699.8075048123965;7755.844883102334;7759.5344279343135;7759.6120193990355;7759.689612415525;7688.500247483896;7733.497322674037;7749.496282741604;7770.844583108363;7773.7279195228175;7546.622668866535;7597.468177227596;7602.809929751746;7603.695852165907;7605.049368828896;37265.25469490595;37375.4393684095;37572.62427375719;37636.43545346822;37655.81172094149;2950.7639388848843;3013.7287644112134;3048.9847550762324;3183.761217908643;3404.7616666833333;28896.133116006342;29030.27424314388;29044.854775725988;29480.410391792044;29932.850335748182;3084.7532197424152;3106.223444138965;3108.129723677374;3123.1723593247807;3149.0238026211946;242224;242324;243220;245193;245352;33154.17114572155;49375;49808;49828.25257621139;49873.25190122151;33080.172995675304;33179.83410082982;33226.169345766066;33257.83371083129;33285;13416.597502074954;13515;13556.322183890963;13557.118787278796;13559.389827457788;11272.154588405903;11320.150988675883;11320.207585468937;11345.829812552818;11348.319100853974;7695.923040769632;7741;7791.922080779233;7802.102758182768;7812.726554570677;3034.757219422441;3096.5664806927048;3134.357456721367;3162.794418362799;3180.6024246969127;885.7741275974586;926.1849572376266;942.948137852411;954.5704433005176;1026.1021606094666;26621.740521516465;27833.304167395978;27894.721052789213;27980;28144.29639259035;937.9343445958854;973.9853902191472;977.3891317926297;982.4007355513131;1025.8563801067855;13997.720045599031;14503.637409064646;14543.563693089225;14806.555803325917;14814;388168;390372;392284;392975;397322;46894.53105468902;47305.81735456641;47407.76296118497;47478.287825682644;47489.5251047492;1102.7463683352873;1145.1068166829887;1181.6159748081907;1184.3426898071652;1235.7775600391835;25906.740932591187;27878.721212787612;27898.581521277603;27956.97849924552;28390;40211.597884021954;41045.716342691914;41164.382534261415;41244.79377603093;41314.1737165249;299276;299609;300539;300867;300967;18659;18840.3405880799;21818.563628727654;23935.640965385883;24770.133045344046;38819.2236155281;39117;39249.607503925734;39336.803315983234;39741.205175896896;34260.48609270813;34309.48535772015;34692.30615387729;34849;35052;34245;34259.657403426645;34801.82599086988;34852.477212842336;35239;29114.909156215694;29901.700982990762;34130.31739365248;34340.48489272613;34447.31105377928;22422.663660044786;31699.683003169674;31967.36065278728;32022.839885800422;32054.358912821146;24519.877400613597;24670.506589867742;24776.380590485383;24946;25161.87419062893 14:25:00 INFO - PROCESS | 13114 | |2;jquery.html;357.2533405183168;357.97136229101676;359.31909032383635;374.1357464257565;375.0417682820393;15515.767263491043;16586.917065414673;17355.30992696134;17422.738658920127;17425.825741742578;16471.588210294718;16733.91633041836;17162.22769975351;17278.395256166037;17284.395046173388;4965.801367945278;5193.039287731782;5202.687838729688;5203.245529398235;5208.166693329068;3664.780113193217;3834.9424758628643;5087.10975579274;5720.456556627114;5946.97026514869;6019.638821670692;6027.09593560965;6029.788957386492;6031.4270144336215;6031.457168854802;5789.160571717099;5923.940760592403;5932.555058370639;5944.10838374243;5945.791897283618;5054.974725126388;5177.974110129463;5181.119209734355;5186.481351864821;5199.792008319662;20969.475763105893;21053.578928421346;21202.151913923426;21322.253721119843;21325.466863328387;1850.2414010255866;1888.6411581799414;2047.078814533466;2065.824404925583;2085.645440275157;13326.533571324957;13445;13556.389962451614;13825.101368411122;13895.652608684864;1607.726686463304;1677.6896274189314;1716.8454839064418;1732.9653406931916;1740.2777847193527;67022.99465508021;67787;68388.6580567099;68838.65580672065;70305.64847175783;8948.418352807046;8953.865692014626;9151.771205719777;9545;9566.186874115778;12964.675883102998;13002.349882505838;13024.739505209844;13034.152780069266;13052.673683157807;7285.648601643304;7375.18872923978;7626.38603644798;7720.42096842739;7796.532208067534;7444.8883266751045;7452.85094298111;7710.074791025113;7741.032370953631;7750.534967901944;5891.617044892068;5937.910931335947;5950.107483877453;6000.699965001732;6057.545684073712;1528.7553991361328;1635.4848222809776;1663.160104147422;1675.9329626815036;1710.1107424139627;874.2306770042322;887.0464250930276;915.6200176926501;954.5609019850807;964.8842138943372;16893.831061689227;16986;17867.285308587772;17929.193186306387;18202.45392638223;890.8708237305555;893.8346405914926;907.6913849291273;933.2767105493161;963.8987906269881;9764.365316254421;10182.796344073076;10183.949080254699;10244.795104097877;10446.164306855433;367983;368074;368622;371510;382054;42894.785526072796;44675;49342.75328623334;57816.24194427433;63537.36462635315;902.5036230073565;911.0889110889111;935.2564711054728;936.2790651198675;938.0103990290173;15162.24188790534;15183.178018637835;15630.45293414725;15719.449819256271;16035.198240088183;34073;34140.14649633779;34533;35182.120446988;35632.28735425329;45514.31728524008;45872.31191532063;45907.08185836198;46040;46273;6867.965660171667;6876.656167191521;6948.33990770876;7225.421966242583;7732.226777322223;11163.665090047312;11196.720081998015;11267.718307042061;11452.14108941816;11822.231554948901;9621.230301575997;9779.902200978184;9908;10061.798764024825;10266.794664106825;9315.906840931504;9749.853752193865;9808.950955245178;9810.65662701802;10055.245856560641;9411.764705882408;9667.758306042406;9878;10011;10024.498775061364;6938.340857618518;7070.787876363717;7173.5337203081635;7266.854662906607;7369.8157546061775;9661.855072174063;9806.166475849634;9859.408435493893;10042.899571004196;10465 14:25:00 INFO - PROCESS | 13114 | |3;mootools.html;1336.2450215628173;1381.8687224713651;1426.9001169918104;1583.8020247469067;1661.825508321627;7373;7974.362051035918;7976.960115199416;7977.202279772027;7982.840343193147;6708.463322934166;6952.2352541220425;6955.269696681851;7124.679389427475;7803.3367163791145;2130.3289463818887;2206.062423470019;2211.8009379155874;2224.477247846755;2230.955380892381;2199.8790066546335;2216.501287210373;2228.2089858100385;2254.323702889135;2262.9660555091687;2207.5033117548505;2208.503086805472;2214.3799736073925;2216.3683350245183;2218.2901471529117;2186.693862859201;2202.394341556077;2209.5359974405396;2227.40973641985;2229.598672238996;2140.743110826695;2146.0771868096713;2157.2988778647004;2185.7814218578173;2189.879556624385;7839.333656639193;7879.212078792132;7880.645370958263;7974.601269936538;7984.880226796603;4585.266357382803;4716.882077948045;4723.551262630044;4724.976375118137;4732.266498692708;2858.330835355894;2939.338648804002;2961.348503329264;2974.4348573770912;2998.805077669966;962.2686758063852;1005.3666190300137;1005.9144972677332;1020.4081632653117;1031.0411317474745;10614.363138211655;10631.574737010511;10661.040506354466;10665.733356666067;10691.198160138021;4068.7762173080173;4178.206140833232;4311.137772445523;4326.459192600925;4328.458942632171;9104.13510716481;9130.589123489326;9136.223421009288;9140.223081038053;9145.77135571616;4640.187967105743;4647.907041859144;4649.116667833101;4652.371929789503;4660.254359302563;4126.773027483518;4222.113356195234;4225.598568136023;4226.36604509326;4233.068724880522;3639.2357604902736;3698.7965661888315;3763.322601931624;3778.6977041836585;3805.6384643458828;1196.9281843089268;1198.8920997110301;1211.0856303490984;1215.4166000319897;1215.9878401216051;661.2494818381172;671.53328436736;795.892554505146;821.5112008355019;844.9691376520635;5017.724025178651;5153.3558305211845;5186.63693541456;5256.553192978563;5487.6158668892795;402.7100487648888;416.7478675401338;427.85239092513035;431.18075656252745;437.2784904906865;3431.227973705946;3449.3618680544178;3524.54180956474;3527.9823600882346;3574.8927532174075;9387.859182112274;9874.950625246827;9877.901220987698;9878.604855805832;9886.406815591088;9782.951085244527;9789.559469823875;9791.608335666637;9799.363041402286;9806.362586431858;7069.575825450489;7073.681684324218;7096.325849044436;7098.68055937484;7212.74755383559;5063.594912407072;5101.285819985279;5105.591552675852;5166.638335316492;5168.0697474454955;8660.523671198145;8789.428687135316;8835.911640883509;8847.646094156162;8928.196462318163;8998.325125615474;9060.682876099305;9165.587548560465;9227.907720922705;9254.028327025566;5887.587868849139;6363.331850155852;6654.700538475877;6670.599764014175;6678.532502724763;7546.056742907137;7603.88594171099;7613.162552119373;7617.847643046997;7619.314261716472;6802.591844489347;6894.896576551456;6897.41371983387;6904.240533541407;7074;6428;6439.742410303723;6458.61248325102;6499.28507864144;6499.935000649933;5825.650460972186;6151.784687535915;6156;6159.29168145669;6193.535484838565;4457.108578284291;4503.144402563503;4509.2559727645885;4552.066826300535;4580.106879158665;4478.283474644041;4538.2511885538515;4574.473935497327;4641.744704041175;4769.809207631656 14:25:00 INFO - PROCESS | 13114 | |4;prototype.html;291.73160692163196;299.63444597590944;307.08488703663085;309.7011384014427;312.9906102816913;4672.500212386374;4797.856064318076;4865.5864251538615;4875.951240487594;4952.579030782379;4688.249880019198;4765.213739732949;4801.447833499149;4802.111609352263;4814.54261845125;3765.6067255115645;3786.432035194722;3791;3806.5432148142263;3819.178876541543;3576.92846143077;3619.69232615228;3799.9810000949956;3803.5245594300713;3826.4642949987024;3761.2477504499075;3772.6038765929593;3780.81095945203;3780.8827056848118;3799.9620003800023;3767.5290588676417;3789.8863034108745;3795.671514969766;3796.8291426885858;3802.7641016669695;3336.833158342073;3342.96657033429;3345.2138747394342;3352.715019223369;3354.580677415323;4544.182047231497;4650.976745116287;4676.485586585472;4685.320628508847;4717.198076327033;4304.698671093025;4328.523862375137;4336.609705126553;4344.02259491615;4346.826126954918;5043.899122017539;5056.696598204119;5085.593152547787;5096.847094587131;5097.413797413308;3586.659267369622;3649.2665983657816;3654.214343916071;3676.3823917476225;3692.1692619160744;5211.400688920785;5236.700878446554;5247.895042099137;5259.526642602184;5262.289590905217;3734.9439758403646;3743.401055831054;3764.887053388403;3765.792881391495;3772.3398405278967;3790.8673196437994;3792.2984247914223;3811.0662887592716;3861.2470568238923;3863.130795570974;4057.5333836609166;4229.619334259932;4250.256205164084;4270.530241673413;4274.78168721919;5037.899242015213;5038.219076043146;5038.74031492127;5039.77321020555;5133.6919784813035;1202.7233736240714;1258.157034786695;1267.993660031694;1277.610328849691;1278.6675464379143;861.371199024703;881.5195718333396;898.9056149104381;899.5097671768901;904.4392476664378;4430.892276930767;4433.623142032963;4440.644748420119;4463.237021376538;4477.6417886569;5175.430702622709;5177.7670004849115;5218.504242096995;5222.268882356473;5233.371995360581;4333.155034768253;4392.637425589653;4409.382686423904;4412.24991751403;4458.888527786767;2412.5295567364196;2428.9232706036437;2443.841150325223;2452.5830608796546;2453.5215632951404;4372.076286433959;4401.977990110029;4416.227160246944;4417.7791110445;4439.200943830142;4519.525449827721;4542.727436353829;4628.699134556243;4635.218868678766;4727.787249573777;4290.6187066177945;4296.699231053796;4311.245532031882;4319.546447623017;4331.80506877185;4529.2300308948215;4533.546645335572;4614.838480653161;4621.353010578455;4634.3352572270405;4395.1868904252815;4432.800523976364;4449.243628583214;4708.482066972699;5094.465081166424;4880.365077698869;4881.145799485005;4884.658073934933;4904.411470623405;4908.312836202863;3695.3902606069696;3709.6104908984166;3712.6844218241754;3718.865745947512;3722.646348596879;5179.91221843402;5248.475152484721;5303.761330740203;5317.787288508416;5323.893522129613;5020.523050310215;5024.924626130538;5025.924611130763;5038.244263360525;5039.521245481674;5022.422421421437;5033.92449113271;5037.672551284155;5098.592112630907;5138.845834624967;4903.362562866804;4955.976854118912;4962.429320628174;5032.396112466381;5050.49495050492;5086.821961231339;5103.77033033507;5103.77033033507;5106.872328191825;5116.360454943132;4906.288588154626;4919.1883339248625;4932.482089380707;4955.925661115159;4968.366765614231 14:25:00 INFO - PROCESS | 13114 | |5;yui.html;569.9373068962414;605.8212827215971;609.7439075588253;653.3760258952701;675.6655455549504;12165.14843960922;13080.476780928764;13095.297611310516;13108.934455327722;13113.213207207575;12902.806457903116;13398.799018014714;13432.798508022388;13928.094673846193;13994.720105597882;756.2399788212838;777.2771322669914;780.0600276666631;780.1652232111643;780.9297163255305;634.5272771785003;757.1406453675063;774.4191856107919;775.8215610409609;777.587878424436;810.9310708589777;812.1107387410776;812.5937031484258;813.4265342933247;813.4631143445328;807.2734538914995;807.3783186946018;807.5356669914764;808.0545761459107;808.1231863428158;485.24059846340367;577.5264283287705;589.4606435111867;591.5977135547826;592.6148003797566;12347.506099756;12357.814632780515;12387.93806030973;12398.31809250491;12414.81377779334;11383.94308028463;11707.7073073173;11802.173847830656;12467.501299947991;12740.235585864877;10062.396256224576;10084.69745907624;10359.637412690596;11382.886171138265;11385.430728463627;3130.7964982276308;3174.412733644283;3182;3291.6214635317006;3296.175956010997;61785.6910715448;63438.682806586134;63522.999999999534;63789.36210637881;63887.36112638907;8817.29461643067;8817.867731984026;9092.318076144316;9128.087191280818;9534.523273836281;16212.189390530426;16270.918645406697;16398.6720265594;16414.26135823891;16537.586560336087;6698.162729658793;6777.085093512313;6854.862902742017;6923.238443771181;7027.613481258478;3762.9059273518383;3781.1303400218103;3793.886183414447;3814.5231846019246;3847.7306588539095;2989.536621823621;3060.158456424501;3083.814971101741;3087.1356020313897;3087.1818967973504;512.4491171990126;520.8749900024043;523.9685618862881;524.5541289903551;533.4558750074901;429.75074456814974;440.52643408336166;444.58431366672266;448.17983090943494;461.457787100156;6869.519133660696;7068.526015894396;7075.327843854826;7194.748183813542;7287.708491660274;469.9741514216751;471.4484053657229;484.65589431504026;502.89187824617153;517.9507946745053;3260.0871755908383;3318.435865902802;3341.465365541502;3399.932001359959;3450.5859296884532;79696;82394.58802705948;83223.83880805936;93218.53390733003;101461;79141.60429197818;81546;82085;82412;83950;67010;68986.31013689899;69198.3080169202;70562.64718676374;71458.64270678614;8060.516369017878;8575.485470871768;8783.560821958748;8839.690610828848;8950.776230594287;43428.78285608552;43507.999999998734;43857.34213986729;43909.341359880265;44830.55169448264;59890.40109598848;60837.695811522426;64253;64683.35316646961;66875.66562167158;10500.317479363817;10684.89315106839;10691.198160137865;10881;11233.66299011031;11838.171328006956;12334.568290109803;12362.814557781461;12390.876091238972;13073.215607063607;10096.646617368357;10565.313254638424;10995;11544.19190656646;11605.825912611148;10718.464076795974;10952.78094438091;10976.286541374786;11087.889121109009;11191.832122518332;11191.944040279746;11212.551497940318;11675.76648467009;11717.06263498901;11777.470013849226;8776.648934042567;9116.863247051167;9507.477088760184;9553.61785528599;9991.200703943812;9475.905240947503;9964;10022.198224142197;10093.949530252301;10151.187904967732 14:25:00 INFO - PROCESS | 13114 | __end_tp_report 14:25:00 INFO - PROCESS | 13114 | __start_cc_report 14:25:00 INFO - PROCESS | 13114 | _x_x_mozilla_cycle_collect,962 14:25:00 INFO - PROCESS | 13114 | __end_cc_report 14:25:00 INFO - PROCESS | 13114 | __startTimestamp1471469100845__endTimestamp 14:25:00 INFO - PROCESS | 13114 | 14:25:00 INFO - PROCESS | 13114 | ------- Summary: start ------- 14:25:00 INFO - PROCESS | 13114 | Number of tests: 6 14:25:00 INFO - PROCESS | 13114 | 14:25:00 INFO - PROCESS | 13114 | [#0] dojo.html Cycles:165 Average:4699.98 Median:4831.40 stddev:515.45 (10.7%) stddev-sans-first:489.22 14:25:00 INFO - PROCESS | 13114 | Values: 2570.6 2587.3 2613.2 2639.5 2657.8 4596.6 4628.8 4744.9 4776.8 4800.0 4619.1 4695.1 4721.5 4721.9 4756.4 4223.6 4241.2 4288.8 4339.8 4411.5 4376.5 4396.3 4424.4 4430.6 4444.1 4241.5 4291.5 4376.0 4381.2 4464.4 4282.4 4299.9 4309.6 4352.1 4367.3 4284.0 4332.2 4346.6 4355.7 4388.1 4627.2 4768.9 4774.9 4819.6 4831.7 4914.6 5051.3 5099.4 5169.9 5182.0 5158.5 5158.7 5180.5 5188.6 5197.9 4683.2 4708.7 4815.0 4851.4 4856.4 5213.4 5259.0 5282.3 5298.7 5299.7 5036.3 5072.3 5083.9 5090.0 5091.2 4898.3 5051.2 5121.1 5175.4 5180.8 5045.3 5087.6 5090.9 5118.8 5124.6 5059.3 5065.1 5069.2 5069.8 5121.0 4109.7 4162.5 4282.7 4298.5 4336.7 3700.8 3714.6 3717.6 3752.7 3825.9 4358.0 4361.0 4364.6 4396.5 4398.9 4936.9 5047.7 5049.5 5124.3 5162.8 4260.4 4306.9 4358.1 4376.6 4417.9 4553.5 4610.9 4612.4 4616.2 4661.2 4596.7 4821.2 4821.3 4827.3 4851.7 5097.6 5162.3 5163.2 5219.0 5220.2 4824.6 4830.5 4831.4 4843.5 4849.4 5098.2 5100.4 5108.4 5113.6 5157.9 4952.7 5069.7 5098.1 5120.7 5158.1 4944.8 4952.6 4954.3 4957.8 4995.0 4932.5 4944.5 4945.4 4947.1 4992.6 4732.5 4764.2 4841.8 4847.3 4884.2 4993.1 5012.1 5014.6 5015.9 5059.1 4745.9 4830.0 4850.2 4851.6 4852.6 14:25:00 INFO - PROCESS | 13114 | 14:25:00 INFO - PROCESS | 13114 | [#1] ext.html Cycles:180 Average:45022.71 Median:34324.99 stddev:83974.69 (244.6%) stddev-sans-first:84143.95 14:25:00 INFO - PROCESS | 13114 | Values: 574.5 588.0 589.5 590.3 590.8 28343.1 38342.8 39596.0 39867.6 43338.6 40429.4 40830.2 40880.6 40882.8 40884.2 7501.5 7614.9 7628.6 7633.2 7643.2 7651.4 7730.6 7737.0 7743.6 7746.7 7699.8 7755.8 7759.5 7759.6 7759.7 7688.5 7733.5 7749.5 7770.8 7773.7 7546.6 7597.5 7602.8 7603.7 7605.0 37265.3 37375.4 37572.6 37636.4 37655.8 2950.8 3013.7 3049.0 3183.8 3404.8 28896.1 29030.3 29044.9 29480.4 29932.9 3084.8 3106.2 3108.1 3123.2 3149.0 242224.0 242324.0 243220.0 245193.0 245352.0 33154.2 49375.0 49808.0 49828.3 49873.3 33080.2 33179.8 33226.2 33257.8 33285.0 13416.6 13515.0 13556.3 13557.1 13559.4 11272.2 11320.2 11320.2 11345.8 11348.3 7695.9 7741.0 7791.9 7802.1 7812.7 3034.8 3096.6 3134.4 3162.8 3180.6 885.8 926.2 942.9 954.6 1026.1 26621.7 27833.3 27894.7 27980.0 28144.3 937.9 974.0 977.4 982.4 1025.9 13997.7 14503.6 14543.6 14806.6 14814.0 388168.0 390372.0 392284.0 392975.0 397322.0 46894.5 47305.8 47407.8 47478.3 47489.5 1102.7 1145.1 1181.6 1184.3 1235.8 25906.7 27878.7 27898.6 27957.0 28390.0 40211.6 41045.7 41164.4 41244.8 41314.2 299276.0 299609.0 300539.0 300867.0 300967.0 18659.0 18840.3 21818.6 23935.6 24770.1 38819.2 39117.0 39249.6 39336.8 39741.2 34260.5 34309.5 34692.3 34849.0 35052.0 34245.0 34259.7 34801.8 34852.5 35239.0 29114.9 29901.7 34130.3 34340.5 34447.3 22422.7 31699.7 31967.4 32022.8 32054.4 24519.9 24670.5 24776.4 24946.0 25161.9 14:25:00 INFO - PROCESS | 13114 | 14:25:00 INFO - PROCESS | 13114 | [#2] jquery.html Cycles:180 Average:23010.75 Median:27154.28 stddev:60922.19 (224.4%) stddev-sans-first:61069.35 14:25:00 INFO - PROCESS | 13114 | Values: 357.3 358.0 359.3 374.1 375.0 15515.8 16586.9 17355.3 17422.7 17425.8 16471.6 16733.9 17162.2 17278.4 17284.4 4965.8 5193.0 5202.7 5203.2 5208.2 3664.8 3834.9 5087.1 5720.5 5947.0 6019.6 6027.1 6029.8 6031.4 6031.5 5789.2 5923.9 5932.6 5944.1 5945.8 5055.0 5178.0 5181.1 5186.5 5199.8 20969.5 21053.6 21202.2 21322.3 21325.5 1850.2 1888.6 2047.1 2065.8 2085.6 13326.5 13445.0 13556.4 13825.1 13895.7 1607.7 1677.7 1716.8 1733.0 1740.3 67023.0 67787.0 68388.7 68838.7 70305.6 8948.4 8953.9 9151.8 9545.0 9566.2 12964.7 13002.3 13024.7 13034.2 13052.7 7285.6 7375.2 7626.4 7720.4 7796.5 7444.9 7452.9 7710.1 7741.0 7750.5 5891.6 5937.9 5950.1 6000.7 6057.5 1528.8 1635.5 1663.2 1675.9 1710.1 874.2 887.0 915.6 954.6 964.9 16893.8 16986.0 17867.3 17929.2 18202.5 890.9 893.8 907.7 933.3 963.9 9764.4 10182.8 10183.9 10244.8 10446.2 367983.0 368074.0 368622.0 371510.0 382054.0 42894.8 44675.0 49342.8 57816.2 63537.4 902.5 911.1 935.3 936.3 938.0 15162.2 15183.2 15630.5 15719.4 16035.2 34073.0 34140.1 34533.0 35182.1 35632.3 45514.3 45872.3 45907.1 46040.0 46273.0 6868.0 6876.7 6948.3 7225.4 7732.2 11163.7 11196.7 11267.7 11452.1 11822.2 9621.2 9779.9 9908.0 10061.8 10266.8 9315.9 9749.9 9809.0 9810.7 10055.2 9411.8 9667.8 9878.0 10011.0 10024.5 6938.3 7070.8 7173.5 7266.9 7369.8 9661.9 9806.2 9859.4 10042.9 10465.0 14:25:00 INFO - PROCESS | 13114 | 14:25:00 INFO - PROCESS | 13114 | [#3] mootools.html Cycles:180 Average:5115.73 Median:4724.26 stddev:2888.26 (61.1%) stddev-sans-first:2882.40 14:25:00 INFO - PROCESS | 13114 | Values: 1336.2 1381.9 1426.9 1583.8 1661.8 7373.0 7974.4 7977.0 7977.2 7982.8 6708.5 6952.2 6955.3 7124.7 7803.3 2130.3 2206.1 2211.8 2224.5 2231.0 2199.9 2216.5 2228.2 2254.3 2263.0 2207.5 2208.5 2214.4 2216.4 2218.3 2186.7 2202.4 2209.5 2227.4 2229.6 2140.7 2146.1 2157.3 2185.8 2189.9 7839.3 7879.2 7880.6 7974.6 7984.9 4585.3 4716.9 4723.6 4725.0 4732.3 2858.3 2939.3 2961.3 2974.4 2998.8 962.3 1005.4 1005.9 1020.4 1031.0 10614.4 10631.6 10661.0 10665.7 10691.2 4068.8 4178.2 4311.1 4326.5 4328.5 9104.1 9130.6 9136.2 9140.2 9145.8 4640.2 4647.9 4649.1 4652.4 4660.3 4126.8 4222.1 4225.6 4226.4 4233.1 3639.2 3698.8 3763.3 3778.7 3805.6 1196.9 1198.9 1211.1 1215.4 1216.0 661.2 671.5 795.9 821.5 845.0 5017.7 5153.4 5186.6 5256.6 5487.6 402.7 416.7 427.9 431.2 437.3 3431.2 3449.4 3524.5 3528.0 3574.9 9387.9 9875.0 9877.9 9878.6 9886.4 9783.0 9789.6 9791.6 9799.4 9806.4 7069.6 7073.7 7096.3 7098.7 7212.7 5063.6 5101.3 5105.6 5166.6 5168.1 8660.5 8789.4 8835.9 8847.6 8928.2 8998.3 9060.7 9165.6 9227.9 9254.0 5887.6 6363.3 6654.7 6670.6 6678.5 7546.1 7603.9 7613.2 7617.8 7619.3 6802.6 6894.9 6897.4 6904.2 7074.0 6428.0 6439.7 6458.6 6499.3 6499.9 5825.7 6151.8 6156.0 6159.3 6193.5 4457.1 4503.1 4509.3 4552.1 4580.1 4478.3 4538.3 4574.5 4641.7 4769.8 14:25:00 INFO - PROCESS | 13114 | 14:25:00 INFO - PROCESS | 13114 | [#4] prototype.html Cycles:180 Average:4120.22 Median:4461.06 stddev:1186.43 (26.6%) stddev-sans-first:1154.44 14:25:00 INFO - PROCESS | 13114 | Values: 291.7 299.6 307.1 309.7 313.0 4672.5 4797.9 4865.6 4876.0 4952.6 4688.2 4765.2 4801.4 4802.1 4814.5 3765.6 3786.4 3791.0 3806.5 3819.2 3576.9 3619.7 3800.0 3803.5 3826.5 3761.2 3772.6 3780.8 3780.9 3800.0 3767.5 3789.9 3795.7 3796.8 3802.8 3336.8 3343.0 3345.2 3352.7 3354.6 4544.2 4651.0 4676.5 4685.3 4717.2 4304.7 4328.5 4336.6 4344.0 4346.8 5043.9 5056.7 5085.6 5096.8 5097.4 3586.7 3649.3 3654.2 3676.4 3692.2 5211.4 5236.7 5247.9 5259.5 5262.3 3734.9 3743.4 3764.9 3765.8 3772.3 3790.9 3792.3 3811.1 3861.2 3863.1 4057.5 4229.6 4250.3 4270.5 4274.8 5037.9 5038.2 5038.7 5039.8 5133.7 1202.7 1258.2 1268.0 1277.6 1278.7 861.4 881.5 898.9 899.5 904.4 4430.9 4433.6 4440.6 4463.2 4477.6 5175.4 5177.8 5218.5 5222.3 5233.4 4333.2 4392.6 4409.4 4412.2 4458.9 2412.5 2428.9 2443.8 2452.6 2453.5 4372.1 4402.0 4416.2 4417.8 4439.2 4519.5 4542.7 4628.7 4635.2 4727.8 4290.6 4296.7 4311.2 4319.5 4331.8 4529.2 4533.5 4614.8 4621.4 4634.3 4395.2 4432.8 4449.2 4708.5 5094.5 4880.4 4881.1 4884.7 4904.4 4908.3 3695.4 3709.6 3712.7 3718.9 3722.6 5179.9 5248.5 5303.8 5317.8 5323.9 5020.5 5024.9 5025.9 5038.2 5039.5 5022.4 5033.9 5037.7 5098.6 5138.8 4903.4 4956.0 4962.4 5032.4 5050.5 5086.8 5103.8 5103.8 5106.9 5116.4 4906.3 4919.2 4932.5 4955.9 4968.4 14:25:00 INFO - PROCESS | 13114 | 14:25:00 INFO - PROCESS | 13114 | [#5] yui.html Cycles:180 Average:17069.98 Median:478.05 stddev:24194.74 (5061.1%) stddev-sans-first:24230.90 14:25:00 INFO - PROCESS | 13114 | Values: 569.9 605.8 609.7 653.4 675.7 12165.1 13080.5 13095.3 13108.9 13113.2 12902.8 13398.8 13432.8 13928.1 13994.7 756.2 777.3 780.1 780.2 780.9 634.5 757.1 774.4 775.8 777.6 810.9 812.1 812.6 813.4 813.5 807.3 807.4 807.5 808.1 808.1 485.2 577.5 589.5 591.6 592.6 12347.5 12357.8 12387.9 12398.3 12414.8 11383.9 11707.7 11802.2 12467.5 12740.2 10062.4 10084.7 10359.6 11382.9 11385.4 3130.8 3174.4 3182.0 3291.6 3296.2 61785.7 63438.7 63523.0 63789.4 63887.4 8817.3 8817.9 9092.3 9128.1 9534.5 16212.2 16270.9 16398.7 16414.3 16537.6 6698.2 6777.1 6854.9 6923.2 7027.6 3762.9 3781.1 3793.9 3814.5 3847.7 2989.5 3060.2 3083.8 3087.1 3087.2 512.4 520.9 524.0 524.6 533.5 429.8 440.5 444.6 448.2 461.5 6869.5 7068.5 7075.3 7194.7 7287.7 470.0 471.4 484.7 502.9 518.0 3260.1 3318.4 3341.5 3399.9 3450.6 79696.0 82394.6 83223.8 93218.5 101461.0 79141.6 81546.0 82085.0 82412.0 83950.0 67010.0 68986.3 69198.3 70562.6 71458.6 8060.5 8575.5 8783.6 8839.7 8950.8 43428.8 43508.0 43857.3 43909.3 44830.6 59890.4 60837.7 64253.0 64683.4 66875.7 10500.3 10684.9 10691.2 10881.0 11233.7 11838.2 12334.6 12362.8 12390.9 13073.2 10096.6 10565.3 10995.0 11544.2 11605.8 10718.5 10952.8 10976.3 11087.9 11191.8 11191.9 11212.6 11675.8 11717.1 11777.5 8776.6 9116.9 9507.5 9553.6 9991.2 9475.9 9964.0 10022.2 10093.9 10151.2 14:25:00 INFO - PROCESS | 13114 | -------- Summary: end -------- 14:25:00 INFO - PROCESS | 13114 | 14:25:01 INFO - TEST-INFO | 13114: exit 0 14:25:01 INFO - TEST-OK | dromaeo_css | took 1120016ms 14:25:01 INFO - TEST-START | kraken 14:25:01 INFO - operating with platform_type : linux_ 14:25:01 INFO - Initialising browser for kraken test... 14:25:01 INFO - TEST-INFO | started process 13421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_NVQCr/profile http://localhost:34544/getInfo.html) 14:25:05 INFO - PROCESS | 13421 | __metrics Screen width/height:1600/1200 14:25:05 INFO - PROCESS | 13421 | colorDepth:24 14:25:05 INFO - PROCESS | 13421 | Browser inner width/height: 1024/697 14:25:05 INFO - PROCESS | 13421 | __metrics 14:25:06 INFO - PROCESS | 13421 | 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:25:06 INFO - PROCESS | 13421 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:25:07 INFO - PROCESS | 13421 | console.error: PushService: 14:25:07 INFO - PROCESS | 13421 | stateChangeProcessEnqueue: Error transitioning state 14:25:07 INFO - PROCESS | 13421 | UnknownError 14:25:07 INFO - TEST-INFO | 13421: exit 0 14:25:07 INFO - Browser initialized. 14:25:07 INFO - Running cycle 1/1 for kraken test... 14:25:07 INFO - TEST-INFO | started process 13502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_NVQCr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:19 INFO - PROCESS | 13502 | RSS: Main: 157929472 14:25:19 INFO - PROCESS | 13502 | 14:25:22 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34544/tests/kraken/driver.html?testName=audio-beat-detection) 14:25:23 INFO - PROCESS | 13502 | RSS: Main: 205287424 14:25:23 INFO - PROCESS | 13502 | 14:25:25 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34544/tests/kraken/driver.html?testName=audio-dft) 14:25:26 INFO - PROCESS | 13502 | RSS: Main: 197050368 14:25:26 INFO - PROCESS | 13502 | 14:25:29 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34544/tests/kraken/driver.html?testName=audio-fft) 14:25:30 INFO - PROCESS | 13502 | RSS: Main: 277856256 14:25:30 INFO - PROCESS | 13502 | 14:25:32 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34544/tests/kraken/driver.html?testName=audio-oscillator) 14:25:33 INFO - PROCESS | 13502 | RSS: Main: 188174336 14:25:33 INFO - PROCESS | 13502 | 14:25:35 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34544/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:25:36 INFO - PROCESS | 13502 | RSS: Main: 192516096 14:25:36 INFO - PROCESS | 13502 | 14:25:39 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34544/tests/kraken/driver.html?testName=imaging-darkroom) 14:25:40 INFO - PROCESS | 13502 | RSS: Main: 228892672 14:25:40 INFO - PROCESS | 13502 | 14:25:43 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34544/tests/kraken/driver.html?testName=imaging-desaturate) 14:25:44 INFO - PROCESS | 13502 | RSS: Main: 222298112 14:25:44 INFO - PROCESS | 13502 | 14:25:47 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34544/tests/kraken/driver.html?testName=json-parse-financial) 14:25:47 INFO - PROCESS | 13502 | RSS: Main: 225878016 14:25:47 INFO - PROCESS | 13502 | 14:25:49 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34544/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:25:50 INFO - PROCESS | 13502 | RSS: Main: 189005824 14:25:50 INFO - PROCESS | 13502 | 14:25:51 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34544/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:25:52 INFO - PROCESS | 13502 | RSS: Main: 196702208 14:25:52 INFO - PROCESS | 13502 | 14:25:54 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34544/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:25:55 INFO - PROCESS | 13502 | RSS: Main: 193613824 14:25:55 INFO - PROCESS | 13502 | 14:25:58 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:25:58 INFO - PROCESS | 13502 | RSS: Main: 189513728 14:25:58 INFO - PROCESS | 13502 | 14:26:01 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:26:02 INFO - PROCESS | 13502 | RSS: Main: 192069632 14:26:02 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | Cycle 1(1): loaded http://localhost:34544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34544/tests/kraken/driver.html?testName=ai-astar) 14:26:04 INFO - PROCESS | 13502 | RSS: Main: 242634752 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | __start_tp_report 14:26:04 INFO - PROCESS | 13502 | _x_x_mozilla_page_load 14:26:04 INFO - PROCESS | 13502 | _x_x_mozilla_page_load_details 14:26:04 INFO - PROCESS | 13502 | |i|pagename|runs| 14:26:04 INFO - PROCESS | 13502 | |0;ai-astar;105;115;114;116;110;114;113;114;114;114 14:26:04 INFO - PROCESS | 13502 | |1;audio-beat-detection;151;121;126;196;124;127;144;124;193;121 14:26:04 INFO - PROCESS | 13502 | |2;audio-dft;162;161;161;161;161;162;162;161;161;160 14:26:04 INFO - PROCESS | 13502 | |3;audio-fft;77;78;75;113;77;78;76;77;140;76 14:26:04 INFO - PROCESS | 13502 | |4;audio-oscillator;87;86;127;87;87;87;123;86;87;142 14:26:04 INFO - PROCESS | 13502 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 14:26:04 INFO - PROCESS | 13502 | |6;imaging-darkroom;146;146;146;147;147;148;146;147;147;148 14:26:04 INFO - PROCESS | 13502 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;94;94 14:26:04 INFO - PROCESS | 13502 | |8;json-parse-financial;64;65;68;66;66;67;65;64;66;66 14:26:04 INFO - PROCESS | 13502 | |9;json-stringify-tinderbox;65;65;65;65;66;66;67;66;66;66 14:26:04 INFO - PROCESS | 13502 | |10;stanford-crypto-aes;93;83;83;82;82;82;81;84;83;83 14:26:04 INFO - PROCESS | 13502 | |11;stanford-crypto-ccm;150;140;136;130;134;141;135;133;149;137 14:26:04 INFO - PROCESS | 13502 | |12;stanford-crypto-pbkdf2;175;171;174;175;176;173;171;173;178;169 14:26:04 INFO - PROCESS | 13502 | |13;stanford-crypto-sha256-iterative;68;68;71;72;66;68;66;68;67;67 14:26:04 INFO - PROCESS | 13502 | __end_tp_report 14:26:04 INFO - PROCESS | 13502 | __start_cc_report 14:26:04 INFO - PROCESS | 13502 | _x_x_mozilla_cycle_collect,1910 14:26:04 INFO - PROCESS | 13502 | __end_cc_report 14:26:04 INFO - PROCESS | 13502 | __startTimestamp1471469164369__endTimestamp 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | ------- Summary: start ------- 14:26:04 INFO - PROCESS | 13502 | Number of tests: 14 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.18 (2.8%) stddev-sans-first:1.64 14:26:04 INFO - PROCESS | 13502 | Values: 105.0 115.0 114.0 116.0 110.0 114.0 113.0 114.0 114.0 114.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:135.50 stddev:29.07 (21.5%) stddev-sans-first:30.68 14:26:04 INFO - PROCESS | 13502 | Values: 151.0 121.0 126.0 196.0 124.0 127.0 144.0 124.0 193.0 121.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 14:26:04 INFO - PROCESS | 13502 | Values: 162.0 161.0 161.0 161.0 161.0 162.0 162.0 161.0 161.0 160.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#3] audio-fft Cycles:10 Average:86.70 Median:77.00 stddev:21.94 (28.5%) stddev-sans-first:22.99 14:26:04 INFO - PROCESS | 13502 | Values: 77.0 78.0 75.0 113.0 77.0 78.0 76.0 77.0 140.0 76.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#4] audio-oscillator Cycles:10 Average:99.90 Median:87.00 stddev:21.75 (25.0%) stddev-sans-first:22.57 14:26:04 INFO - PROCESS | 13502 | Values: 87.0 86.0 127.0 87.0 87.0 87.0 123.0 86.0 87.0 142.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:26:04 INFO - PROCESS | 13502 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 14:26:04 INFO - PROCESS | 13502 | Values: 146.0 146.0 146.0 147.0 147.0 148.0 146.0 147.0 147.0 148.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 14:26:04 INFO - PROCESS | 13502 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.17 14:26:04 INFO - PROCESS | 13502 | Values: 64.0 65.0 68.0 66.0 66.0 67.0 65.0 64.0 66.0 66.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 14:26:04 INFO - PROCESS | 13502 | Values: 65.0 65.0 65.0 65.0 66.0 66.0 67.0 66.0 66.0 66.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:3.41 (4.1%) stddev-sans-first:0.88 14:26:04 INFO - PROCESS | 13502 | Values: 93.0 83.0 83.0 82.0 82.0 82.0 81.0 84.0 83.0 83.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:138.50 stddev:6.62 (4.8%) stddev-sans-first:5.56 14:26:04 INFO - PROCESS | 13502 | Values: 150.0 140.0 136.0 130.0 134.0 141.0 135.0 133.0 149.0 137.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.50 stddev:2.68 (1.5%) stddev-sans-first:2.78 14:26:04 INFO - PROCESS | 13502 | Values: 175.0 171.0 174.0 175.0 176.0 173.0 171.0 173.0 178.0 169.0 14:26:04 INFO - PROCESS | 13502 | 14:26:04 INFO - PROCESS | 13502 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.97 (2.9%) stddev-sans-first:2.09 14:26:04 INFO - PROCESS | 13502 | Values: 68.0 68.0 71.0 72.0 66.0 68.0 66.0 68.0 67.0 67.0 14:26:04 INFO - PROCESS | 13502 | -------- Summary: end -------- 14:26:04 INFO - PROCESS | 13502 | 14:26:05 INFO - TEST-INFO | 13502: exit 0 14:26:05 INFO - TEST-OK | kraken | took 63865ms 14:26:05 INFO - SUITE-END | took 1183s 14:26:06 INFO - Completed test suite (00:19:44) 14:26:06 INFO - javascript benchmark 14:26:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2570.588705807071, 2587.301428614274, 2613.1899111275516, 2639.458910923261, 2657.760801527862, 4596.586307232348, 4628.8148474061, 4744.881377965548, 4776.785044672989, 4800.039992001601, 4619.099275641252, 4695.131400690874, 4721.457032441271, 4721.881952951169, 4756.405449318835, 4223.556526564713, 4241.215375155591, 4288.849890253841, 4339.826406943718, 4411.470623525165, 4376.452943382077, 4396.274614688588, 4424.380586717846, 4430.623397011258, 4444.066745983348, 4241.512226094008, 4291.506476755182, 4375.978120109411, 4381.233284175257, 4464.419625448687, 4282.357646353041, 4299.935500967456, 4309.5690430956965, 4352.129574085164, 4367.279398899178, 4284.036091879333, 4332.155229730204, 4346.587074227975, 4355.651547876162, 4388.1223755249075, 4627.190241707688, 4768.856934291976, 4774.880627984294, 4819.614430845524, 4831.685940413862, 4914.606831453475, 5051.318072060261, 5099.413567439755, 5169.922451163236, 5182.0, 5158.458361871987, 5158.664686795384, 5180.481951804827, 5188.610854185913, 5197.922031169535, 4683.2038553446, 4708.670393072452, 4814.975925120352, 4851.393575802989, 4856.368672072608, 5213.374395072616, 5259.0, 5282.260483532308, 5298.655587386807, 5299.655522391032, 5036.32009678696, 5072.340595722606, 5083.923741143886, 5090.032893750175, 5091.1854103343285, 4898.2652602109965, 5051.166557517969, 5121.129408000575, 5175.378954525481, 5180.844574662766, 5045.344105266292, 5087.64386492942, 5090.898182036339, 5118.846434606968, 5124.564412024945, 5059.316992206005, 5065.088284108822, 5069.239614057921, 5069.822556210515, 5120.974395128001, 4109.671226301948, 4162.4796900387455, 4282.678799090081, 4298.548652391516, 4336.674749393808, 3700.833462494194, 3714.5542534895985, 3717.5910649828497, 3752.718546108998, 3825.9043523912123, 4357.9782101089295, 4361.0, 4364.585364390377, 4396.49440314368, 4398.868033958986, 4936.8765780855765, 5047.747612619354, 5049.520295571988, 5124.256982737482, 5162.819301324511, 4260.382244574581, 4306.935395969063, 4358.084802191512, 4376.606105450461, 4417.867463976086, 4553.4763502197675, 4610.861674149781, 4612.377329060601, 4616.16908956391, 4661.160991021581, 4596.747178905192, 4821.2045012573235, 4821.276808478756, 4827.25177597473, 4851.708897466164, 5097.566706829961, 5162.328897243335, 5163.173892177234, 5218.9739051304505, 5220.190870415092, 4824.614030877451, 4830.492798256132, 4831.396075490564, 4843.491433399442, 4849.442314133919, 5098.1588037973315, 5100.387953445462, 5108.438071812172, 5113.565346945403, 5157.922631160461, 4952.678075925053, 5069.670471419346, 5098.107831129611, 5120.692758434506, 5158.148905430562, 4944.826931057396, 4952.628552858478, 4954.256861470808, 4957.801687932587, 4994.975025124996, 4932.482089380564, 4944.505549445027, 4945.4312754033745, 4947.1342515059005, 4992.600591952708, 4732.503087175797, 4764.237721964469, 4841.757912104451, 4847.321375007572, 4884.1941079722865, 4993.076280888047, 5012.097822391858, 5014.623903207347, 5015.874603134951, 5059.06407314648, 4745.881352966204, 4829.95170048295, 4850.223964165858, 4851.611871050237, 4852.56326930578], "value": 4665.747008531234, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.4542684449773, 588.041492367441, 589.5136512377289, 590.3034419385124, 590.7607418995308, 28343.149705508815, 38342.8082859586, 39596.0, 39867.60132398675, 43338.566614333846, 40429.393559096636, 40830.18339633213, 40880.59119408805, 40882.79558602203, 40884.182316353654, 7501.512401693873, 7614.885776713354, 7628.580428076453, 7633.160352361236, 7643.23567643234, 7651.426143039266, 7730.613469326539, 7736.9613151934445, 7743.612819359009, 7746.690132394698, 7699.8075048123965, 7755.844883102334, 7759.5344279343135, 7759.6120193990355, 7759.689612415525, 7688.500247483896, 7733.497322674037, 7749.496282741604, 7770.844583108363, 7773.7279195228175, 7546.622668866535, 7597.468177227596, 7602.809929751746, 7603.695852165907, 7605.049368828896, 37265.25469490595, 37375.4393684095, 37572.62427375719, 37636.43545346822, 37655.81172094149, 2950.7639388848843, 3013.7287644112134, 3048.9847550762324, 3183.761217908643, 3404.7616666833333, 28896.133116006342, 29030.27424314388, 29044.854775725988, 29480.410391792044, 29932.850335748182, 3084.7532197424152, 3106.223444138965, 3108.129723677374, 3123.1723593247807, 3149.0238026211946, 242224.0, 242324.0, 243220.0, 245193.0, 245352.0, 33154.17114572155, 49375.0, 49808.0, 49828.25257621139, 49873.25190122151, 33080.172995675304, 33179.83410082982, 33226.169345766066, 33257.83371083129, 33285.0, 13416.597502074954, 13515.0, 13556.322183890963, 13557.118787278796, 13559.389827457788, 11272.154588405903, 11320.150988675883, 11320.207585468937, 11345.829812552818, 11348.319100853974, 7695.923040769632, 7741.0, 7791.922080779233, 7802.102758182768, 7812.726554570677, 3034.757219422441, 3096.5664806927048, 3134.357456721367, 3162.794418362799, 3180.6024246969127, 885.7741275974586, 926.1849572376266, 942.948137852411, 954.5704433005176, 1026.1021606094666, 26621.740521516465, 27833.304167395978, 27894.721052789213, 27980.0, 28144.29639259035, 937.9343445958854, 973.9853902191472, 977.3891317926297, 982.4007355513131, 1025.8563801067855, 13997.720045599031, 14503.637409064646, 14543.563693089225, 14806.555803325917, 14814.0, 388168.0, 390372.0, 392284.0, 392975.0, 397322.0, 46894.53105468902, 47305.81735456641, 47407.76296118497, 47478.287825682644, 47489.5251047492, 1102.7463683352873, 1145.1068166829887, 1181.6159748081907, 1184.3426898071652, 1235.7775600391835, 25906.740932591187, 27878.721212787612, 27898.581521277603, 27956.97849924552, 28390.0, 40211.597884021954, 41045.716342691914, 41164.382534261415, 41244.79377603093, 41314.1737165249, 299276.0, 299609.0, 300539.0, 300867.0, 300967.0, 18659.0, 18840.3405880799, 21818.563628727654, 23935.640965385883, 24770.133045344046, 38819.2236155281, 39117.0, 39249.607503925734, 39336.803315983234, 39741.205175896896, 34260.48609270813, 34309.48535772015, 34692.30615387729, 34849.0, 35052.0, 34245.0, 34259.657403426645, 34801.82599086988, 34852.477212842336, 35239.0, 29114.909156215694, 29901.700982990762, 34130.31739365248, 34340.48489272613, 34447.31105377928, 22422.663660044786, 31699.683003169674, 31967.36065278728, 32022.839885800422, 32054.358912821146, 24519.877400613597, 24670.506589867742, 24776.380590485383, 24946.0, 25161.87419062893], "value": 16042.541783874141, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.2533405183168, 357.97136229101676, 359.31909032383635, 374.1357464257565, 375.0417682820393, 15515.767263491043, 16586.917065414673, 17355.30992696134, 17422.738658920127, 17425.825741742578, 16471.588210294718, 16733.91633041836, 17162.22769975351, 17278.395256166037, 17284.395046173388, 4965.801367945278, 5193.039287731782, 5202.687838729688, 5203.245529398235, 5208.166693329068, 3664.780113193217, 3834.9424758628643, 5087.10975579274, 5720.456556627114, 5946.97026514869, 6019.638821670692, 6027.09593560965, 6029.788957386492, 6031.4270144336215, 6031.457168854802, 5789.160571717099, 5923.940760592403, 5932.555058370639, 5944.10838374243, 5945.791897283618, 5054.974725126388, 5177.974110129463, 5181.119209734355, 5186.481351864821, 5199.792008319662, 20969.475763105893, 21053.578928421346, 21202.151913923426, 21322.253721119843, 21325.466863328387, 1850.2414010255866, 1888.6411581799414, 2047.078814533466, 2065.824404925583, 2085.645440275157, 13326.533571324957, 13445.0, 13556.389962451614, 13825.101368411122, 13895.652608684864, 1607.726686463304, 1677.6896274189314, 1716.8454839064418, 1732.9653406931916, 1740.2777847193527, 67022.99465508021, 67787.0, 68388.6580567099, 68838.65580672065, 70305.64847175783, 8948.418352807046, 8953.865692014626, 9151.771205719777, 9545.0, 9566.186874115778, 12964.675883102998, 13002.349882505838, 13024.739505209844, 13034.152780069266, 13052.673683157807, 7285.648601643304, 7375.18872923978, 7626.38603644798, 7720.42096842739, 7796.532208067534, 7444.8883266751045, 7452.85094298111, 7710.074791025113, 7741.032370953631, 7750.534967901944, 5891.617044892068, 5937.910931335947, 5950.107483877453, 6000.699965001732, 6057.545684073712, 1528.7553991361328, 1635.4848222809776, 1663.160104147422, 1675.9329626815036, 1710.1107424139627, 874.2306770042322, 887.0464250930276, 915.6200176926501, 954.5609019850807, 964.8842138943372, 16893.831061689227, 16986.0, 17867.285308587772, 17929.193186306387, 18202.45392638223, 890.8708237305555, 893.8346405914926, 907.6913849291273, 933.2767105493161, 963.8987906269881, 9764.365316254421, 10182.796344073076, 10183.949080254699, 10244.795104097877, 10446.164306855433, 367983.0, 368074.0, 368622.0, 371510.0, 382054.0, 42894.785526072796, 44675.0, 49342.75328623334, 57816.24194427433, 63537.36462635315, 902.5036230073565, 911.0889110889111, 935.2564711054728, 936.2790651198675, 938.0103990290173, 15162.24188790534, 15183.178018637835, 15630.45293414725, 15719.449819256271, 16035.198240088183, 34073.0, 34140.14649633779, 34533.0, 35182.120446988, 35632.28735425329, 45514.31728524008, 45872.31191532063, 45907.08185836198, 46040.0, 46273.0, 6867.965660171667, 6876.656167191521, 6948.33990770876, 7225.421966242583, 7732.226777322223, 11163.665090047312, 11196.720081998015, 11267.718307042061, 11452.14108941816, 11822.231554948901, 9621.230301575997, 9779.902200978184, 9908.0, 10061.798764024825, 10266.794664106825, 9315.906840931504, 9749.853752193865, 9808.950955245178, 9810.65662701802, 10055.245856560641, 9411.764705882408, 9667.758306042406, 9878.0, 10011.0, 10024.498775061364, 6938.340857618518, 7070.787876363717, 7173.5337203081635, 7266.854662906607, 7369.8157546061775, 9661.855072174063, 9806.166475849634, 9859.408435493893, 10042.899571004196, 10465.0], "value": 8201.236397393925, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.2450215628173, 1381.8687224713651, 1426.9001169918104, 1583.8020247469067, 1661.825508321627, 7373.0, 7974.362051035918, 7976.960115199416, 7977.202279772027, 7982.840343193147, 6708.463322934166, 6952.2352541220425, 6955.269696681851, 7124.679389427475, 7803.3367163791145, 2130.3289463818887, 2206.062423470019, 2211.8009379155874, 2224.477247846755, 2230.955380892381, 2199.8790066546335, 2216.501287210373, 2228.2089858100385, 2254.323702889135, 2262.9660555091687, 2207.5033117548505, 2208.503086805472, 2214.3799736073925, 2216.3683350245183, 2218.2901471529117, 2186.693862859201, 2202.394341556077, 2209.5359974405396, 2227.40973641985, 2229.598672238996, 2140.743110826695, 2146.0771868096713, 2157.2988778647004, 2185.7814218578173, 2189.879556624385, 7839.333656639193, 7879.212078792132, 7880.645370958263, 7974.601269936538, 7984.880226796603, 4585.266357382803, 4716.882077948045, 4723.551262630044, 4724.976375118137, 4732.266498692708, 2858.330835355894, 2939.338648804002, 2961.348503329264, 2974.4348573770912, 2998.805077669966, 962.2686758063852, 1005.3666190300137, 1005.9144972677332, 1020.4081632653117, 1031.0411317474745, 10614.363138211655, 10631.574737010511, 10661.040506354466, 10665.733356666067, 10691.198160138021, 4068.7762173080173, 4178.206140833232, 4311.137772445523, 4326.459192600925, 4328.458942632171, 9104.13510716481, 9130.589123489326, 9136.223421009288, 9140.223081038053, 9145.77135571616, 4640.187967105743, 4647.907041859144, 4649.116667833101, 4652.371929789503, 4660.254359302563, 4126.773027483518, 4222.113356195234, 4225.598568136023, 4226.36604509326, 4233.068724880522, 3639.2357604902736, 3698.7965661888315, 3763.322601931624, 3778.6977041836585, 3805.6384643458828, 1196.9281843089268, 1198.8920997110301, 1211.0856303490984, 1215.4166000319897, 1215.9878401216051, 661.2494818381172, 671.53328436736, 795.892554505146, 821.5112008355019, 844.9691376520635, 5017.724025178651, 5153.3558305211845, 5186.63693541456, 5256.553192978563, 5487.6158668892795, 402.7100487648888, 416.7478675401338, 427.85239092513035, 431.18075656252745, 437.2784904906865, 3431.227973705946, 3449.3618680544178, 3524.54180956474, 3527.9823600882346, 3574.8927532174075, 9387.859182112274, 9874.950625246827, 9877.901220987698, 9878.604855805832, 9886.406815591088, 9782.951085244527, 9789.559469823875, 9791.608335666637, 9799.363041402286, 9806.362586431858, 7069.575825450489, 7073.681684324218, 7096.325849044436, 7098.68055937484, 7212.74755383559, 5063.594912407072, 5101.285819985279, 5105.591552675852, 5166.638335316492, 5168.0697474454955, 8660.523671198145, 8789.428687135316, 8835.911640883509, 8847.646094156162, 8928.196462318163, 8998.325125615474, 9060.682876099305, 9165.587548560465, 9227.907720922705, 9254.028327025566, 5887.587868849139, 6363.331850155852, 6654.700538475877, 6670.599764014175, 6678.532502724763, 7546.056742907137, 7603.88594171099, 7613.162552119373, 7617.847643046997, 7619.314261716472, 6802.591844489347, 6894.896576551456, 6897.41371983387, 6904.240533541407, 7074.0, 6428.0, 6439.742410303723, 6458.61248325102, 6499.28507864144, 6499.935000649933, 5825.650460972186, 6151.784687535915, 6156.0, 6159.29168145669, 6193.535484838565, 4457.108578284291, 4503.144402563503, 4509.2559727645885, 4552.066826300535, 4580.106879158665, 4478.283474644041, 4538.2511885538515, 4574.473935497327, 4641.744704041175, 4769.809207631656], "value": 4057.9570503560717, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.73160692163196, 299.63444597590944, 307.08488703663085, 309.7011384014427, 312.9906102816913, 4672.500212386374, 4797.856064318076, 4865.5864251538615, 4875.951240487594, 4952.579030782379, 4688.249880019198, 4765.213739732949, 4801.447833499149, 4802.111609352263, 4814.54261845125, 3765.6067255115645, 3786.432035194722, 3791.0, 3806.5432148142263, 3819.178876541543, 3576.92846143077, 3619.69232615228, 3799.9810000949956, 3803.5245594300713, 3826.4642949987024, 3761.2477504499075, 3772.6038765929593, 3780.81095945203, 3780.8827056848118, 3799.9620003800023, 3767.5290588676417, 3789.8863034108745, 3795.671514969766, 3796.8291426885858, 3802.7641016669695, 3336.833158342073, 3342.96657033429, 3345.2138747394342, 3352.715019223369, 3354.580677415323, 4544.182047231497, 4650.976745116287, 4676.485586585472, 4685.320628508847, 4717.198076327033, 4304.698671093025, 4328.523862375137, 4336.609705126553, 4344.02259491615, 4346.826126954918, 5043.899122017539, 5056.696598204119, 5085.593152547787, 5096.847094587131, 5097.413797413308, 3586.659267369622, 3649.2665983657816, 3654.214343916071, 3676.3823917476225, 3692.1692619160744, 5211.400688920785, 5236.700878446554, 5247.895042099137, 5259.526642602184, 5262.289590905217, 3734.9439758403646, 3743.401055831054, 3764.887053388403, 3765.792881391495, 3772.3398405278967, 3790.8673196437994, 3792.2984247914223, 3811.0662887592716, 3861.2470568238923, 3863.130795570974, 4057.5333836609166, 4229.619334259932, 4250.256205164084, 4270.530241673413, 4274.78168721919, 5037.899242015213, 5038.219076043146, 5038.74031492127, 5039.77321020555, 5133.6919784813035, 1202.7233736240714, 1258.157034786695, 1267.993660031694, 1277.610328849691, 1278.6675464379143, 861.371199024703, 881.5195718333396, 898.9056149104381, 899.5097671768901, 904.4392476664378, 4430.892276930767, 4433.623142032963, 4440.644748420119, 4463.237021376538, 4477.6417886569, 5175.430702622709, 5177.7670004849115, 5218.504242096995, 5222.268882356473, 5233.371995360581, 4333.155034768253, 4392.637425589653, 4409.382686423904, 4412.24991751403, 4458.888527786767, 2412.5295567364196, 2428.9232706036437, 2443.841150325223, 2452.5830608796546, 2453.5215632951404, 4372.076286433959, 4401.977990110029, 4416.227160246944, 4417.7791110445, 4439.200943830142, 4519.525449827721, 4542.727436353829, 4628.699134556243, 4635.218868678766, 4727.787249573777, 4290.6187066177945, 4296.699231053796, 4311.245532031882, 4319.546447623017, 4331.80506877185, 4529.2300308948215, 4533.546645335572, 4614.838480653161, 4621.353010578455, 4634.3352572270405, 4395.1868904252815, 4432.800523976364, 4449.243628583214, 4708.482066972699, 5094.465081166424, 4880.365077698869, 4881.145799485005, 4884.658073934933, 4904.411470623405, 4908.312836202863, 3695.3902606069696, 3709.6104908984166, 3712.6844218241754, 3718.865745947512, 3722.646348596879, 5179.91221843402, 5248.475152484721, 5303.761330740203, 5317.787288508416, 5323.893522129613, 5020.523050310215, 5024.924626130538, 5025.924611130763, 5038.244263360525, 5039.521245481674, 5022.422421421437, 5033.92449113271, 5037.672551284155, 5098.592112630907, 5138.845834624967, 4903.362562866804, 4955.976854118912, 4962.429320628174, 5032.396112466381, 5050.49495050492, 5086.821961231339, 5103.77033033507, 5103.77033033507, 5106.872328191825, 5116.360454943132, 4906.288588154626, 4919.1883339248625, 4932.482089380707, 4955.925661115159, 4968.366765614231], "value": 3747.6386653054715, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.9373068962414, 605.8212827215971, 609.7439075588253, 653.3760258952701, 675.6655455549504, 12165.14843960922, 13080.476780928764, 13095.297611310516, 13108.934455327722, 13113.213207207575, 12902.806457903116, 13398.799018014714, 13432.798508022388, 13928.094673846193, 13994.720105597882, 756.2399788212838, 777.2771322669914, 780.0600276666631, 780.1652232111643, 780.9297163255305, 634.5272771785003, 757.1406453675063, 774.4191856107919, 775.8215610409609, 777.587878424436, 810.9310708589777, 812.1107387410776, 812.5937031484258, 813.4265342933247, 813.4631143445328, 807.2734538914995, 807.3783186946018, 807.5356669914764, 808.0545761459107, 808.1231863428158, 485.24059846340367, 577.5264283287705, 589.4606435111867, 591.5977135547826, 592.6148003797566, 12347.506099756, 12357.814632780515, 12387.93806030973, 12398.31809250491, 12414.81377779334, 11383.94308028463, 11707.7073073173, 11802.173847830656, 12467.501299947991, 12740.235585864877, 10062.396256224576, 10084.69745907624, 10359.637412690596, 11382.886171138265, 11385.430728463627, 3130.7964982276308, 3174.412733644283, 3182.0, 3291.6214635317006, 3296.175956010997, 61785.6910715448, 63438.682806586134, 63522.999999999534, 63789.36210637881, 63887.36112638907, 8817.29461643067, 8817.867731984026, 9092.318076144316, 9128.087191280818, 9534.523273836281, 16212.189390530426, 16270.918645406697, 16398.6720265594, 16414.26135823891, 16537.586560336087, 6698.162729658793, 6777.085093512313, 6854.862902742017, 6923.238443771181, 7027.613481258478, 3762.9059273518383, 3781.1303400218103, 3793.886183414447, 3814.5231846019246, 3847.7306588539095, 2989.536621823621, 3060.158456424501, 3083.814971101741, 3087.1356020313897, 3087.1818967973504, 512.4491171990126, 520.8749900024043, 523.9685618862881, 524.5541289903551, 533.4558750074901, 429.75074456814974, 440.52643408336166, 444.58431366672266, 448.17983090943494, 461.457787100156, 6869.519133660696, 7068.526015894396, 7075.327843854826, 7194.748183813542, 7287.708491660274, 469.9741514216751, 471.4484053657229, 484.65589431504026, 502.89187824617153, 517.9507946745053, 3260.0871755908383, 3318.435865902802, 3341.465365541502, 3399.932001359959, 3450.5859296884532, 79696.0, 82394.58802705948, 83223.83880805936, 93218.53390733003, 101461.0, 79141.60429197818, 81546.0, 82085.0, 82412.0, 83950.0, 67010.0, 68986.31013689899, 69198.3080169202, 70562.64718676374, 71458.64270678614, 8060.516369017878, 8575.485470871768, 8783.560821958748, 8839.690610828848, 8950.776230594287, 43428.78285608552, 43507.999999998734, 43857.34213986729, 43909.341359880265, 44830.55169448264, 59890.40109598848, 60837.695811522426, 64253.0, 64683.35316646961, 66875.66562167158, 10500.317479363817, 10684.89315106839, 10691.198160137865, 10881.0, 11233.66299011031, 11838.171328006956, 12334.568290109803, 12362.814557781461, 12390.876091238972, 13073.215607063607, 10096.646617368357, 10565.313254638424, 10995.0, 11544.19190656646, 11605.825912611148, 10718.464076795974, 10952.78094438091, 10976.286541374786, 11087.889121109009, 11191.832122518332, 11191.944040279746, 11212.551497940318, 11675.76648467009, 11717.06263498901, 11777.470013849226, 8776.648934042567, 9116.863247051167, 9507.477088760184, 9553.61785528599, 9991.200703943812, 9475.905240947503, 9964.0, 10022.198224142197, 10093.949530252301, 10151.187904967732], "value": 6272.435720174463, "unit": "score"}], "name": "dromaeo_css", "value": 6231.659189118523, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 116.0, 110.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 126.0, 196.0, 124.0, 127.0, 144.0, 124.0, 193.0, 121.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 75.0, 113.0, 77.0, 78.0, 76.0, 77.0, 140.0, 76.0], "value": 86.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 127.0, 87.0, 87.0, 87.0, 123.0, 86.0, 87.0, 142.0], "value": 99.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 68.0, 66.0, 66.0, 67.0, 65.0, 64.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 83.0, 83.0, 82.0, 82.0, 82.0, 81.0, 84.0, 83.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 140.0, 136.0, 130.0, 134.0, 141.0, 135.0, 133.0, 149.0, 137.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 174.0, 175.0, 176.0, 173.0, 171.0, 173.0, 178.0, 169.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 71.0, 72.0, 66.0, 68.0, 66.0, 68.0, 67.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1557.1, "alertThreshold": 2.0}]} 14:26:06 INFO - Return code: 0 14:26:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:26:06 INFO - # TBPL SUCCESS # 14:26:06 INFO - Running post-action listener: _resource_record_post_action 14:26:06 INFO - [mozharness: 2016-08-17 21:26:06.189799Z] Finished run-tests step (success) 14:26:06 INFO - Running post-run listener: _resource_record_post_run 14:26:06 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407658496; Read time: 12; Write time: 389304 14:26:06 INFO - TinderboxPrint: CPU usage
13.0% 14:26:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:26:06 INFO - TinderboxPrint: I/O write bytes / time
407,658,496 / 389,304 14:26:06 INFO - TinderboxPrint: CPU idle
8,337.3 (87.0%) 14:26:06 INFO - TinderboxPrint: CPU user
1,204.6 (12.6%) 14:26:06 INFO - TinderboxPrint: Swap in / out
0 / 0 14:26:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124796928; Read time: 0; Write time: 145468 14:26:06 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 281915392; Read time: 0; Write time: 243804 14:26:06 INFO - Running post-run listener: _upload_blobber_files 14:26:06 INFO - Blob upload gear active. 14:26:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:26:06 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:26:06 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:26:06 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:26:07 INFO - (blobuploader) - INFO - Open directory for files ... 14:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:07 INFO - (blobuploader) - INFO - Done attempting. 14:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:26:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:26:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:08 INFO - (blobuploader) - INFO - Done attempting. 14:26:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:26:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:13 INFO - (blobuploader) - INFO - Done attempting. 14:26:13 INFO - (blobuploader) - INFO - Iteration through files over. 14:26:13 INFO - Return code: 0 14:26:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:26:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:26:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/048a33738999619bdd0d1b6a3a431aa5ecff72a2a60402ba07feefc5d9ef4de09597dd4631d420931fe0a8eec7633dcb91646ca8e571da05ec3c7acb30c49695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0b2ac9522b862da3f27de6aa3ca34f867581b1eef25d601c10938b795239010ff3ba55ffe095a9e1118eff8c10e8626eeadc0eab52fa0f59c92c6446cb269915", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/873c49fd9ca48e84cdf23bddd083c649e8168038f9aa25f6ade8baa226297144a0d8637fa56816722ee83727011b9fd827ac742370fa0ce3ba7e3ebe4cbfe61a"} 14:26:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:26:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:26:13 INFO - Contents: 14:26:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/048a33738999619bdd0d1b6a3a431aa5ecff72a2a60402ba07feefc5d9ef4de09597dd4631d420931fe0a8eec7633dcb91646ca8e571da05ec3c7acb30c49695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0b2ac9522b862da3f27de6aa3ca34f867581b1eef25d601c10938b795239010ff3ba55ffe095a9e1118eff8c10e8626eeadc0eab52fa0f59c92c6446cb269915", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/873c49fd9ca48e84cdf23bddd083c649e8168038f9aa25f6ade8baa226297144a0d8637fa56816722ee83727011b9fd827ac742370fa0ce3ba7e3ebe4cbfe61a"} 14:26:13 INFO - Running post-run listener: copy_logs_to_upload_dir 14:26:13 INFO - Copying logs to upload dir... 14:26:13 INFO - mkdir: /builds/slave/test/build/upload/logs 14:26:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.270229 ========= master_lag: 0.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-17 14:26:13.223283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2016-08-17 14:26:13.226547) ========= 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-1471463919.307257-108200794 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/048a33738999619bdd0d1b6a3a431aa5ecff72a2a60402ba07feefc5d9ef4de09597dd4631d420931fe0a8eec7633dcb91646ca8e571da05ec3c7acb30c49695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0b2ac9522b862da3f27de6aa3ca34f867581b1eef25d601c10938b795239010ff3ba55ffe095a9e1118eff8c10e8626eeadc0eab52fa0f59c92c6446cb269915", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/873c49fd9ca48e84cdf23bddd083c649e8168038f9aa25f6ade8baa226297144a0d8637fa56816722ee83727011b9fd827ac742370fa0ce3ba7e3ebe4cbfe61a"} build_url:https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/BNaKhHT4QrKaPPYbfqtw9Q/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/048a33738999619bdd0d1b6a3a431aa5ecff72a2a60402ba07feefc5d9ef4de09597dd4631d420931fe0a8eec7633dcb91646ca8e571da05ec3c7acb30c49695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0b2ac9522b862da3f27de6aa3ca34f867581b1eef25d601c10938b795239010ff3ba55ffe095a9e1118eff8c10e8626eeadc0eab52fa0f59c92c6446cb269915", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/873c49fd9ca48e84cdf23bddd083c649e8168038f9aa25f6ade8baa226297144a0d8637fa56816722ee83727011b9fd827ac742370fa0ce3ba7e3ebe4cbfe61a"}' ========= master_lag: 7.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2016-08-17 14:26:20.352471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-08-17 14:26:20.352884) ========= 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-1471463919.307257-108200794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 3.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-08-17 14:26:23.366125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 14:26:23.366452) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 14:26:23.367500) ========= ========= Total master_lag: 10.64 =========