builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1471079391.06 results: success (0) buildid: 20160812233009 builduid: 29f275f2cf534ec2aaca7367444ac8c4 revision: 4cf5aa807f27376197743b62eff2b2c3c2891b44 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:51.060317) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:51.060798) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:51.061089) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:51.225166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:51.225469) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-13 02:09:51-- 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% 224M=0s 2016-08-13 02:09:51 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096381 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:51.336859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:51.337151) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023365 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:51.392980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:51.393350) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4cf5aa807f27376197743b62eff2b2c3c2891b44 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4cf5aa807f27376197743b62eff2b2c3c2891b44 --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=5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-13 02:09:51,977 truncating revision to first 12 chars 2016-08-13 02:09:51,977 Setting DEBUG logging. 2016-08-13 02:09:51,977 attempt 1/10 2016-08-13 02:09:51,977 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4cf5aa807f27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-13 02:09:52,304 unpacking tar archive at: fx-team-4cf5aa807f27/testing/mozharness/ program finished with exit code 0 elapsedTime=0.742890 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:52.149746) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:52.150072) ========= script_repo_revision: 4cf5aa807f27376197743b62eff2b2c3c2891b44 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:52.150509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:52.150772) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 02:09:52.160943) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-13 02:09:52.161350) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:09:52 INFO - MultiFileLogger online at 20160813 02:09:52 in /builds/slave/test 02:09:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:09:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:09:52 INFO - {'append_to_log': False, 02:09:52 INFO - 'base_work_dir': '/builds/slave/test', 02:09:52 INFO - 'blob_upload_branch': 'Fx-Team', 02:09:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:09:52 INFO - 'branch': 'Fx-Team', 02:09:52 INFO - 'buildbot_json_path': 'buildprops.json', 02:09:52 INFO - 'config_files': ('talos/linux_config.py',), 02:09:52 INFO - 'default_actions': ('clobber', 02:09:52 INFO - 'read-buildbot-config', 02:09:52 INFO - 'download-and-extract', 02:09:52 INFO - 'populate-webroot', 02:09:52 INFO - 'create-virtualenv', 02:09:52 INFO - 'install', 02:09:52 INFO - 'run-tests'), 02:09:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:09:52 INFO - 'download_minidump_stackwalk': True, 02:09:52 INFO - 'download_symbols': 'ondemand', 02:09:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:09:52 INFO - 'tooltool.py': '/tools/tooltool.py', 02:09:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:09:52 INFO - '/tools/misc-python/virtualenv.py')}, 02:09:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:09:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:09:52 INFO - 'installer_path': 'installer.exe', 02:09:52 INFO - 'log_level': 'info', 02:09:52 INFO - 'log_name': 'talos', 02:09:52 INFO - 'log_to_console': True, 02:09:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:09:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:09:52 INFO - 'opt_config_files': (), 02:09:52 INFO - 'pip_index': False, 02:09:52 INFO - 'sps_profile': False, 02:09:52 INFO - 'sps_profile_interval': 0, 02:09:52 INFO - 'suite': 'dromaeojs-e10s', 02:09:52 INFO - 'system_bits': '32', 02:09:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:09:52 INFO - 'title': 'talos-linux64-ix-051', 02:09:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:09:52 INFO - 'use_talos_json': True, 02:09:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:09:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:09:52 INFO - 'work_dir': 'build'} 02:09:52 INFO - [mozharness: 2016-08-13 09:09:52.839241Z] Running clobber step. 02:09:52 INFO - Running pre-action listener: _resource_record_pre_action 02:09:52 INFO - Running main action method: clobber 02:09:52 INFO - rmtree: /builds/slave/test/build 02:09:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:09:53 INFO - Running post-action listener: _resource_record_post_action 02:09:53 INFO - [mozharness: 2016-08-13 09:09:53.811155Z] Finished clobber step (success) 02:09:53 INFO - [mozharness: 2016-08-13 09:09:53.811254Z] Running read-buildbot-config step. 02:09:53 INFO - Running pre-action listener: _resource_record_pre_action 02:09:53 INFO - Running main action method: read_buildbot_config 02:09:53 INFO - Using buildbot properties: 02:09:53 INFO - { 02:09:53 INFO - "project": "", 02:09:53 INFO - "product": "firefox", 02:09:53 INFO - "script_repo_revision": "production", 02:09:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:09:53 INFO - "repository": "", 02:09:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:09:53 INFO - "buildid": "20160812233009", 02:09:53 INFO - "pgo_build": "True", 02:09:53 INFO - "basedir": "/builds/slave/test", 02:09:53 INFO - "buildnumber": 697, 02:09:53 INFO - "slavename": "talos-linux64-ix-051", 02:09:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:09:53 INFO - "platform": "ubuntu64_hw", 02:09:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:09:53 INFO - "branch": "fx-team", 02:09:53 INFO - "repo_path": "integration/fx-team", 02:09:53 INFO - "revision": "4cf5aa807f27376197743b62eff2b2c3c2891b44", 02:09:53 INFO - "stage_platform": "linux64-pgo", 02:09:53 INFO - "builduid": "29f275f2cf534ec2aaca7367444ac8c4", 02:09:53 INFO - "slavebuilddir": "test" 02:09:53 INFO - } 02:09:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:09:53 INFO - Running post-action listener: _resource_record_post_action 02:09:53 INFO - [mozharness: 2016-08-13 09:09:53.813679Z] Finished read-buildbot-config step (success) 02:09:53 INFO - [mozharness: 2016-08-13 09:09:53.813767Z] Running download-and-extract step. 02:09:53 INFO - Running pre-action listener: _resource_record_pre_action 02:09:53 INFO - Running main action method: download_and_extract 02:09:53 INFO - mkdir: /builds/slave/test/build/tests 02:09: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')]} 02:09:53 INFO - trying https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:09:53 INFO - Downloading https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/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 02:09:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/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 02:09:54 INFO - Downloaded 1361 bytes. 02:09:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:09:54 INFO - Using the following test package requirements: 02:09:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:09:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:09:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:09:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:54 INFO - u'jsshell-linux-x86_64.zip'], 02:09:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:09:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:09:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:09:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:09:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:09:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:09:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:09:54 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')]} 02:09:54 INFO - trying https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:09:54 INFO - Downloading https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/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 02:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/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 02:09:55 INFO - Downloaded 21835886 bytes. 02:09:55 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 02:10:00 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 02:10: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')]} 02:10:00 INFO - trying https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:10:00 INFO - Downloading https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/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 02:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/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 02:10:01 INFO - Downloaded 21835886 bytes. 02:10:01 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 02:10:05 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')]} 02:10:05 INFO - trying https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:10:05 INFO - Downloading https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/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 02:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/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 02:10:07 INFO - Downloaded 14413719 bytes. 02:10:07 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 02:10:07 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')]} 02:10:07 INFO - trying https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:10:07 INFO - Downloading https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/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 02:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/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 02:10:11 INFO - Downloaded 59406926 bytes. 02:10:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:10:11 INFO - mkdir: /builds/slave/test/properties 02:10:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:10:11 INFO - Writing to file /builds/slave/test/properties/build_url 02:10:11 INFO - Contents: 02:10:11 INFO - build_url:https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:10:12 INFO - Running post-action listener: _resource_record_post_action 02:10:12 INFO - Running post-action listener: set_extra_try_arguments 02:10:12 INFO - [mozharness: 2016-08-13 09:10:12.660956Z] Finished download-and-extract step (success) 02:10:12 INFO - [mozharness: 2016-08-13 09:10:12.661179Z] Running populate-webroot step. 02:10:12 INFO - Running pre-action listener: _resource_record_pre_action 02:10:12 INFO - Running main action method: populate_webroot 02:10:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:10:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:10:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:10:12 INFO - '--tppagecycles', 02:10:12 INFO - '7'], 02:10:12 INFO - 'tests': ['tsvgm']}}, 02:10:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:10:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:10:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:10:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:10:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:10:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:10:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:12 INFO - 'talos_options': ['--disable-e10s'], 02:10:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:12 INFO - 'talos_options': ['--disable-e10s'], 02:10:12 INFO - 'tests': ['damp', 'tps']}, 02:10:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:12 INFO - 'tests': ['damp', 'tps']}, 02:10:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:10:12 INFO - 'tests': ['dromaeo_dom']}, 02:10:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:10:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:10:12 INFO - 'tests': ['basic_compositor_video']}, 02:10:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:10:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:10:12 INFO - 'tests': ['a11yr', 02:10:12 INFO - 'ts_paint', 02:10:12 INFO - 'tpaint', 02:10:12 INFO - 'sessionrestore', 02:10:12 INFO - 'sessionrestore_no_auto_restore', 02:10:12 INFO - 'tabpaint']}, 02:10:12 INFO - 'other-e10s': {'tests': ['a11yr', 02:10:12 INFO - 'ts_paint', 02:10:12 INFO - 'tpaint', 02:10:12 INFO - 'sessionrestore', 02:10:12 INFO - 'sessionrestore_no_auto_restore', 02:10:12 INFO - 'tabpaint']}, 02:10:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:10:12 INFO - 'ts_paint', 02:10:12 INFO - 'tpaint', 02:10:12 INFO - 'sessionrestore', 02:10:12 INFO - 'sessionrestore_no_auto_restore', 02:10:12 INFO - 'tabpaint']}, 02:10:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:10:12 INFO - 'ts_paint', 02:10:12 INFO - 'tpaint', 02:10:12 INFO - 'sessionrestore', 02:10:12 INFO - 'sessionrestore_no_auto_restore', 02:10:12 INFO - 'tabpaint']}, 02:10:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:10:12 INFO - 'tests': ['a11yr', 02:10:12 INFO - 'ts_paint', 02:10:12 INFO - 'tpaint', 02:10:12 INFO - 'sessionrestore', 02:10:12 INFO - 'sessionrestore_no_auto_restore', 02:10:12 INFO - 'tabpaint']}, 02:10:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:10:12 INFO - 'tests': ['a11yr', 02:10:12 INFO - 'ts_paint', 02:10:12 INFO - 'tpaint', 02:10:12 INFO - 'sessionrestore', 02:10:12 INFO - 'sessionrestore_no_auto_restore', 02:10:12 INFO - 'tabpaint']}, 02:10:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:10:12 INFO - 'tests': ['tsvgx', 02:10:12 INFO - 'tsvgr_opacity', 02:10:12 INFO - 'tart', 02:10:12 INFO - 'tscrollx', 02:10:12 INFO - 'cart']}, 02:10:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:10:12 INFO - 'tsvgr_opacity', 02:10:12 INFO - 'tart', 02:10:12 INFO - 'tscrollx', 02:10:12 INFO - 'cart']}, 02:10:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:12 INFO - 'talos_options': ['--disable-e10s'], 02:10:12 INFO - 'tests': ['tp5o']}, 02:10:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:12 INFO - 'tests': ['tp5o']}, 02:10:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:12 INFO - 'talos_options': ['--disable-e10s', 02:10:12 INFO - '--xperf_path', 02:10:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:12 INFO - 'tests': ['tp5n']}, 02:10:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:12 INFO - 'talos_options': ['--xperf_path', 02:10:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:12 INFO - 'tests': ['tp5n']}}, 02:10:12 INFO - 'talos.zip': {'path': '', 02:10:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:10:12 INFO - Running post-action listener: _resource_record_post_action 02:10:12 INFO - [mozharness: 2016-08-13 09:10:12.682161Z] Finished populate-webroot step (success) 02:10:12 INFO - [mozharness: 2016-08-13 09:10:12.682248Z] Running create-virtualenv step. 02:10:12 INFO - Running pre-action listener: _resource_record_pre_action 02:10:12 INFO - Running main action method: create_virtualenv 02:10:12 INFO - Creating virtualenv /builds/slave/test/build/venv 02:10:12 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 02:10:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:10:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:10:12 INFO - Using real prefix '/usr' 02:10:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:10:13 INFO - Installing distribute.............................................................................................................................................................................................done. 02:10:15 INFO - Installing pip.................done. 02:10:15 INFO - Return code: 0 02:10:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:10:15 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')]} 02:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:15 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')]} 02:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:15 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 0x7f6b17ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2730850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272b370>, '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 0x272e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272ed80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', '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 02:10:15 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 02:10:15 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 02:10:15 INFO - Using env: {'DISPLAY': ':0', 02:10:15 INFO - 'HOME': '/home/cltbld', 02:10:15 INFO - 'LANG': 'en_US.UTF-8', 02:10:15 INFO - 'LANGUAGE': 'en_US:en', 02:10:15 INFO - 'LOGNAME': 'cltbld', 02:10:15 INFO - 'MAIL': '/var/mail/cltbld', 02:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:15 INFO - 'MOZ_NO_REMOTE': '1', 02:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:15 INFO - 'NO_EM_RESTART': '1', 02:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:15 INFO - 'PWD': '/builds/slave/test', 02:10:15 INFO - 'SHELL': '/bin/bash', 02:10:15 INFO - 'SHLVL': '1', 02:10:15 INFO - 'TERM': 'linux', 02:10:15 INFO - 'TMOUT': '86400', 02:10:15 INFO - 'USER': 'cltbld', 02:10:15 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', 02:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:15 INFO - '_': '/tools/buildbot/bin/python'} 02:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:15 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 02:10:15 INFO - Cleaning up... 02:10:15 INFO - Return code: 0 02:10:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:10:15 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')]} 02:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:15 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')]} 02:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:15 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 0x7f6b17ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2730850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272b370>, '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 0x272e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272ed80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', '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 02:10:15 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 02:10:15 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 02:10:15 INFO - Using env: {'DISPLAY': ':0', 02:10:15 INFO - 'HOME': '/home/cltbld', 02:10:15 INFO - 'LANG': 'en_US.UTF-8', 02:10:15 INFO - 'LANGUAGE': 'en_US:en', 02:10:15 INFO - 'LOGNAME': 'cltbld', 02:10:15 INFO - 'MAIL': '/var/mail/cltbld', 02:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:15 INFO - 'MOZ_NO_REMOTE': '1', 02:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:15 INFO - 'NO_EM_RESTART': '1', 02:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:15 INFO - 'PWD': '/builds/slave/test', 02:10:15 INFO - 'SHELL': '/bin/bash', 02:10:15 INFO - 'SHLVL': '1', 02:10:15 INFO - 'TERM': 'linux', 02:10:15 INFO - 'TMOUT': '86400', 02:10:15 INFO - 'USER': 'cltbld', 02:10:15 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', 02:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:15 INFO - '_': '/tools/buildbot/bin/python'} 02:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:15 INFO - Downloading/unpacking psutil>=3.1.1 02:10:15 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 02:10:15 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 02:10:15 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 02:10:15 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 02:10:15 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 02:10:15 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 02:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:10:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:17 INFO - Installing collected packages: psutil 02:10:17 INFO - Running setup.py install for psutil 02:10:17 INFO - building 'psutil._psutil_linux' extension 02:10:17 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 02:10:17 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 02:10:17 INFO - building 'psutil._psutil_posix' extension 02:10:17 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 02:10:18 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 02:10:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:18 INFO - Successfully installed psutil 02:10:18 INFO - Cleaning up... 02:10:18 INFO - Return code: 0 02:10:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:10:18 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')]} 02:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:18 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')]} 02:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:18 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 0x7f6b17ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2730850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272b370>, '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 0x272e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272ed80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', '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 02:10:18 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 02:10:18 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 02:10:18 INFO - Using env: {'DISPLAY': ':0', 02:10:18 INFO - 'HOME': '/home/cltbld', 02:10:18 INFO - 'LANG': 'en_US.UTF-8', 02:10:18 INFO - 'LANGUAGE': 'en_US:en', 02:10:18 INFO - 'LOGNAME': 'cltbld', 02:10:18 INFO - 'MAIL': '/var/mail/cltbld', 02:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:18 INFO - 'MOZ_NO_REMOTE': '1', 02:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:18 INFO - 'NO_EM_RESTART': '1', 02:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:18 INFO - 'PWD': '/builds/slave/test', 02:10:18 INFO - 'SHELL': '/bin/bash', 02:10:18 INFO - 'SHLVL': '1', 02:10:18 INFO - 'TERM': 'linux', 02:10:18 INFO - 'TMOUT': '86400', 02:10:18 INFO - 'USER': 'cltbld', 02:10:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', 02:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:18 INFO - '_': '/tools/buildbot/bin/python'} 02:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:10:18 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 02:10:18 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 02:10:18 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 02:10:18 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 02:10:18 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 02:10:18 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 02:10:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:10:20 INFO - Installing collected packages: mozsystemmonitor 02:10:20 INFO - Running setup.py install for mozsystemmonitor 02:10:20 INFO - Successfully installed mozsystemmonitor 02:10:20 INFO - Cleaning up... 02:10:20 INFO - Return code: 0 02:10:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:20 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 0x7f6b17ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2730850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272b370>, '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 0x272e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272ed80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', '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 02:10:20 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 02:10:20 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 02:10:20 INFO - Using env: {'DISPLAY': ':0', 02:10:20 INFO - 'HOME': '/home/cltbld', 02:10:20 INFO - 'LANG': 'en_US.UTF-8', 02:10:20 INFO - 'LANGUAGE': 'en_US:en', 02:10:20 INFO - 'LOGNAME': 'cltbld', 02:10:20 INFO - 'MAIL': '/var/mail/cltbld', 02:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:20 INFO - 'MOZ_NO_REMOTE': '1', 02:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:20 INFO - 'NO_EM_RESTART': '1', 02:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:20 INFO - 'PWD': '/builds/slave/test', 02:10:20 INFO - 'SHELL': '/bin/bash', 02:10:20 INFO - 'SHLVL': '1', 02:10:20 INFO - 'TERM': 'linux', 02:10:20 INFO - 'TMOUT': '86400', 02:10:20 INFO - 'USER': 'cltbld', 02:10:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', 02:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:20 INFO - '_': '/tools/buildbot/bin/python'} 02:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:20 INFO - Downloading/unpacking jsonschema==2.5.1 02:10:20 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 02:10:20 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 02:10:20 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 02:10:20 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 02:10:20 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 02:10:20 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 02:10:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:10:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:10:22 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 02:10:22 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 02:10:22 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 02:10:22 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 02:10:22 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 02:10:22 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 02:10:22 INFO - Downloading functools32-3.2.3-2.tar.gz 02:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:10:22 INFO - warning: no files found matching '*.txt' 02:10:22 INFO - no previously-included directories found matching 'build' 02:10:22 INFO - no previously-included directories found matching 'dist' 02:10:22 INFO - no previously-included directories found matching '.git*' 02:10:22 INFO - Installing collected packages: jsonschema, functools32 02:10:22 INFO - Running setup.py install for functools32 02:10:22 INFO - warning: no files found matching '*.txt' 02:10:22 INFO - no previously-included directories found matching 'build' 02:10:22 INFO - no previously-included directories found matching 'dist' 02:10:22 INFO - no previously-included directories found matching '.git*' 02:10:23 INFO - Successfully installed jsonschema functools32 02:10:23 INFO - Cleaning up... 02:10:23 INFO - Return code: 0 02:10:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:10:23 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')]} 02:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:23 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')]} 02:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:23 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 0x7f6b17ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2730850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272b370>, '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 0x272e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272ed80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', '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 02:10:23 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 02:10:23 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 02:10:23 INFO - Using env: {'DISPLAY': ':0', 02:10:23 INFO - 'HOME': '/home/cltbld', 02:10:23 INFO - 'LANG': 'en_US.UTF-8', 02:10:23 INFO - 'LANGUAGE': 'en_US:en', 02:10:23 INFO - 'LOGNAME': 'cltbld', 02:10:23 INFO - 'MAIL': '/var/mail/cltbld', 02:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:23 INFO - 'MOZ_NO_REMOTE': '1', 02:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:23 INFO - 'NO_EM_RESTART': '1', 02:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:23 INFO - 'PWD': '/builds/slave/test', 02:10:23 INFO - 'SHELL': '/bin/bash', 02:10:23 INFO - 'SHLVL': '1', 02:10:23 INFO - 'TERM': 'linux', 02:10:23 INFO - 'TMOUT': '86400', 02:10:23 INFO - 'USER': 'cltbld', 02:10:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', 02:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:23 INFO - '_': '/tools/buildbot/bin/python'} 02:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:10:23 INFO - Cleaning up... 02:10:23 INFO - Return code: 0 02:10:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:10:23 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')]} 02:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:23 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')]} 02:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:23 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 0x7f6b17ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2730850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272b370>, '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 0x272e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272ed80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', '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 02:10:23 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 02:10:23 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 02:10:23 INFO - Using env: {'DISPLAY': ':0', 02:10:23 INFO - 'HOME': '/home/cltbld', 02:10:23 INFO - 'LANG': 'en_US.UTF-8', 02:10:23 INFO - 'LANGUAGE': 'en_US:en', 02:10:23 INFO - 'LOGNAME': 'cltbld', 02:10:23 INFO - 'MAIL': '/var/mail/cltbld', 02:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:23 INFO - 'MOZ_NO_REMOTE': '1', 02:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:23 INFO - 'NO_EM_RESTART': '1', 02:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:23 INFO - 'PWD': '/builds/slave/test', 02:10:23 INFO - 'SHELL': '/bin/bash', 02:10:23 INFO - 'SHLVL': '1', 02:10:23 INFO - 'TERM': 'linux', 02:10:23 INFO - 'TMOUT': '86400', 02:10:23 INFO - 'USER': 'cltbld', 02:10:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', 02:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:23 INFO - '_': '/tools/buildbot/bin/python'} 02:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:23 INFO - Downloading/unpacking blobuploader==1.2.4 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 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 02:10:25 INFO - Downloading blobuploader-1.2.4.tar.gz 02:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:10:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:10:25 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 02:10:25 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 02:10:25 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 02:10:25 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 02:10:25 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 02:10:25 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 02:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:10:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:10:25 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 02:10:25 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 02:10:25 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 02:10:25 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 02:10:25 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 02:10:25 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 02:10:26 INFO - Downloading docopt-0.6.1.tar.gz 02:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:10:26 INFO - Installing collected packages: blobuploader, requests, docopt 02:10:26 INFO - Running setup.py install for blobuploader 02:10:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:10:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:10:26 INFO - Running setup.py install for requests 02:10:26 INFO - Running setup.py install for docopt 02:10:26 INFO - Successfully installed blobuploader requests docopt 02:10:26 INFO - Cleaning up... 02:10:26 INFO - Return code: 0 02:10:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:26 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')]} 02:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:26 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')]} 02:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:26 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 0x7f6b17ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2730850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272b370>, '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 0x272e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272ed80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', '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 02:10:26 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 02:10:26 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 02:10:26 INFO - Using env: {'DISPLAY': ':0', 02:10:26 INFO - 'HOME': '/home/cltbld', 02:10:26 INFO - 'LANG': 'en_US.UTF-8', 02:10:26 INFO - 'LANGUAGE': 'en_US:en', 02:10:26 INFO - 'LOGNAME': 'cltbld', 02:10:26 INFO - 'MAIL': '/var/mail/cltbld', 02:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:26 INFO - 'MOZ_NO_REMOTE': '1', 02:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:26 INFO - 'NO_EM_RESTART': '1', 02:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:26 INFO - 'PWD': '/builds/slave/test', 02:10:26 INFO - 'SHELL': '/bin/bash', 02:10:26 INFO - 'SHLVL': '1', 02:10:26 INFO - 'TERM': 'linux', 02:10:26 INFO - 'TMOUT': '86400', 02:10:26 INFO - 'USER': 'cltbld', 02:10:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', 02:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:26 INFO - '_': '/tools/buildbot/bin/python'} 02:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:27 INFO - Running setup.py (path:/tmp/pip-GIY5YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:27 INFO - Running setup.py (path:/tmp/pip-XoiF92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:27 INFO - Running setup.py (path:/tmp/pip-uIeQuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:27 INFO - Running setup.py (path:/tmp/pip-_hpzVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:27 INFO - Running setup.py (path:/tmp/pip-LHXhl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:27 INFO - Running setup.py (path:/tmp/pip-Enrksz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:27 INFO - Running setup.py (path:/tmp/pip-emGgDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:27 INFO - Running setup.py (path:/tmp/pip-lIu4Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:27 INFO - Running setup.py (path:/tmp/pip-hDYgdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:27 INFO - Running setup.py (path:/tmp/pip-RGQLVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:27 INFO - Running setup.py (path:/tmp/pip-ovRJlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:27 INFO - Running setup.py (path:/tmp/pip-b40z9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:27 INFO - Running setup.py (path:/tmp/pip-ohHiy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:27 INFO - Running setup.py (path:/tmp/pip-rQHt5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:28 INFO - Running setup.py (path:/tmp/pip-cshbWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:28 INFO - Running setup.py (path:/tmp/pip-sbhiIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:28 INFO - Running setup.py (path:/tmp/pip-2alsOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:10:28 INFO - Running setup.py install for manifestparser 02:10:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:10:28 INFO - Running setup.py install for mozcrash 02:10:28 INFO - Running setup.py install for mozdebug 02:10:28 INFO - Running setup.py install for mozdevice 02:10:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:10:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:10:28 INFO - Running setup.py install for mozfile 02:10:28 INFO - Running setup.py install for mozhttpd 02:10:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:10:28 INFO - Running setup.py install for mozinfo 02:10:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:10:28 INFO - Running setup.py install for mozInstall 02:10:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:10:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:10:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:10:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:10:29 INFO - Running setup.py install for mozleak 02:10:29 INFO - Running setup.py install for mozlog 02:10:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:10:29 INFO - Running setup.py install for moznetwork 02:10:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:10:29 INFO - Running setup.py install for mozprocess 02:10:29 INFO - Running setup.py install for mozprofile 02:10:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:10:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:10:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:10:29 INFO - Running setup.py install for mozrunner 02:10:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:10:29 INFO - Running setup.py install for mozscreenshot 02:10:29 INFO - Running setup.py install for moztest 02:10:29 INFO - Running setup.py install for mozversion 02:10:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:10:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:10:30 INFO - Cleaning up... 02:10:30 INFO - Return code: 0 02:10:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:30 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 0x7f6b17ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2730850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272b370>, '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 0x272e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272ed80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', '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 02:10:30 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 02:10:30 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 02:10:30 INFO - Using env: {'DISPLAY': ':0', 02:10:30 INFO - 'HOME': '/home/cltbld', 02:10:30 INFO - 'LANG': 'en_US.UTF-8', 02:10:30 INFO - 'LANGUAGE': 'en_US:en', 02:10:30 INFO - 'LOGNAME': 'cltbld', 02:10:30 INFO - 'MAIL': '/var/mail/cltbld', 02:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:30 INFO - 'MOZ_NO_REMOTE': '1', 02:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:30 INFO - 'NO_EM_RESTART': '1', 02:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:30 INFO - 'PWD': '/builds/slave/test', 02:10:30 INFO - 'SHELL': '/bin/bash', 02:10:30 INFO - 'SHLVL': '1', 02:10:30 INFO - 'TERM': 'linux', 02:10:30 INFO - 'TMOUT': '86400', 02:10:30 INFO - 'USER': 'cltbld', 02:10:30 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', 02:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:30 INFO - '_': '/tools/buildbot/bin/python'} 02:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:30 INFO - Running setup.py (path:/tmp/pip-pO4PrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:30 INFO - Running setup.py (path:/tmp/pip-WCPakN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:30 INFO - Running setup.py (path:/tmp/pip-0Yct3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:30 INFO - Running setup.py (path:/tmp/pip-9oUY0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:30 INFO - Running setup.py (path:/tmp/pip-BIQFPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:30 INFO - Running setup.py (path:/tmp/pip-5Xz6In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:30 INFO - Running setup.py (path:/tmp/pip-7HXF0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:30 INFO - Running setup.py (path:/tmp/pip-abuz8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:30 INFO - Running setup.py (path:/tmp/pip-tlTFBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:30 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)) 02:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:30 INFO - Running setup.py (path:/tmp/pip-4glMqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:31 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)) 02:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:31 INFO - Running setup.py (path:/tmp/pip-KDdb8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:31 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)) 02:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:31 INFO - Running setup.py (path:/tmp/pip-GGKRuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:31 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)) 02:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:31 INFO - Running setup.py (path:/tmp/pip-g4CfHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:31 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)) 02:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:31 INFO - Running setup.py (path:/tmp/pip-ctwrDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:31 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)) 02:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:31 INFO - Running setup.py (path:/tmp/pip-0qvRlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:31 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)) 02:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:31 INFO - Running setup.py (path:/tmp/pip-DfCc7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:31 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)) 02:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:31 INFO - Running setup.py (path:/tmp/pip-brkDsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:31 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)) 02:10:31 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)) 02:10:31 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)) 02:10:31 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)) 02:10:31 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)) 02:10:31 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)) 02:10:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 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 02:10:33 INFO - Downloading blessings-1.6.tar.gz 02:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:10:33 INFO - Installing collected packages: blessings 02:10:33 INFO - Running setup.py install for blessings 02:10:33 INFO - Successfully installed blessings 02:10:33 INFO - Cleaning up... 02:10:33 INFO - Return code: 0 02:10:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:10:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:33 INFO - Reading from file tmpfile_stdout 02:10:33 INFO - Current package versions: 02:10:33 INFO - argparse == 1.2.1 02:10:33 INFO - blessings == 1.6 02:10:33 INFO - blobuploader == 1.2.4 02:10:33 INFO - docopt == 0.6.1 02:10:33 INFO - functools32 == 3.2.3-2 02:10:33 INFO - jsonschema == 2.5.1 02:10:33 INFO - manifestparser == 1.1 02:10:33 INFO - mozInstall == 1.12 02:10:33 INFO - mozcrash == 0.17 02:10:33 INFO - mozdebug == 0.1 02:10:33 INFO - mozdevice == 0.48 02:10:33 INFO - mozfile == 1.2 02:10:33 INFO - mozhttpd == 0.7 02:10:33 INFO - mozinfo == 0.9 02:10:33 INFO - mozleak == 0.1 02:10:33 INFO - mozlog == 3.3 02:10:33 INFO - moznetwork == 0.27 02:10:33 INFO - mozprocess == 0.23 02:10:33 INFO - mozprofile == 0.28 02:10:33 INFO - mozrunner == 6.12 02:10:33 INFO - mozscreenshot == 0.1 02:10:33 INFO - mozsystemmonitor == 0.3 02:10:33 INFO - moztest == 0.7 02:10:33 INFO - mozversion == 1.4 02:10:33 INFO - psutil == 3.1.1 02:10:33 INFO - requests == 1.2.3 02:10:33 INFO - wsgiref == 0.1.2 02:10:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:33 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 0x7f6b17ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2730850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272b370>, '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 0x272e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272ed80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', '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 02:10:33 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 02:10:33 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 02:10:33 INFO - Using env: {'DISPLAY': ':0', 02:10:33 INFO - 'HOME': '/home/cltbld', 02:10:33 INFO - 'LANG': 'en_US.UTF-8', 02:10:33 INFO - 'LANGUAGE': 'en_US:en', 02:10:33 INFO - 'LOGNAME': 'cltbld', 02:10:33 INFO - 'MAIL': '/var/mail/cltbld', 02:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:33 INFO - 'MOZ_NO_REMOTE': '1', 02:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:33 INFO - 'NO_EM_RESTART': '1', 02:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:33 INFO - 'PWD': '/builds/slave/test', 02:10:33 INFO - 'SHELL': '/bin/bash', 02:10:33 INFO - 'SHLVL': '1', 02:10:33 INFO - 'TERM': 'linux', 02:10:33 INFO - 'TMOUT': '86400', 02:10:33 INFO - 'USER': 'cltbld', 02:10:33 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', 02:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:33 INFO - '_': '/tools/buildbot/bin/python'} 02:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:34 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)) 02:10:34 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)) 02:10:34 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)) 02:10:34 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)) 02:10:34 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)) 02:10:34 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)) 02:10:34 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)) 02:10:34 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)) 02:10:34 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)) 02:10:34 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)) 02:10:34 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)) 02:10:34 INFO - Cleaning up... 02:10:34 INFO - Return code: 0 02:10:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6b17ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2730850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272b370>, '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 0x272e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272ed80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', '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 02:10:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:10:34 INFO - Using env: {'DISPLAY': ':0', 02:10:34 INFO - 'HOME': '/home/cltbld', 02:10:34 INFO - 'LANG': 'en_US.UTF-8', 02:10:34 INFO - 'LANGUAGE': 'en_US:en', 02:10:34 INFO - 'LOGNAME': 'cltbld', 02:10:34 INFO - 'MAIL': '/var/mail/cltbld', 02:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:34 INFO - 'MOZ_NO_REMOTE': '1', 02:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:34 INFO - 'NO_EM_RESTART': '1', 02:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:34 INFO - 'PWD': '/builds/slave/test', 02:10:34 INFO - 'SHELL': '/bin/bash', 02:10:34 INFO - 'SHLVL': '1', 02:10:34 INFO - 'TERM': 'linux', 02:10:34 INFO - 'TMOUT': '86400', 02:10:34 INFO - 'USER': 'cltbld', 02:10:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', 02:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:34 INFO - '_': '/tools/buildbot/bin/python'} 02:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:10:34 INFO - Cleaning up... 02:10:34 INFO - Return code: 0 02:10:34 INFO - Running post-action listener: _resource_record_post_action 02:10:34 INFO - Running post-action listener: _start_resource_monitoring 02:10:34 INFO - Starting resource monitoring. 02:10:34 INFO - [mozharness: 2016-08-13 09:10:34.327226Z] Finished create-virtualenv step (success) 02:10:34 INFO - [mozharness: 2016-08-13 09:10:34.327684Z] Running install step. 02:10:34 INFO - Running pre-action listener: _resource_record_pre_action 02:10:34 INFO - Running main action method: install 02:10:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:34 INFO - Reading from file tmpfile_stdout 02:10:34 INFO - Detecting whether we're running mozinstall >=1.0... 02:10:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:10:34 INFO - Reading from file tmpfile_stdout 02:10:34 INFO - Output received: 02:10:34 INFO - Usage: mozinstall [options] installer 02:10:34 INFO - Options: 02:10:34 INFO - -h, --help show this help message and exit 02:10:34 INFO - -d DEST, --destination=DEST 02:10:34 INFO - Directory to install application into. [default: 02:10:34 INFO - "/builds/slave/test"] 02:10:34 INFO - --app=APP Application being installed. [default: firefox] 02:10:34 INFO - mkdir: /builds/slave/test/build/application 02:10:34 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'] 02:10:34 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 02:10:51 INFO - Reading from file tmpfile_stdout 02:10:51 INFO - Output received: 02:10:51 INFO - /builds/slave/test/build/application/firefox/firefox 02:10:51 INFO - Running post-action listener: _resource_record_post_action 02:10:51 INFO - [mozharness: 2016-08-13 09:10:51.521678Z] Finished install step (success) 02:10:51 INFO - [mozharness: 2016-08-13 09:10:51.521925Z] Running run-tests step. 02:10:51 INFO - Running pre-action listener: _resource_record_pre_action 02:10:51 INFO - Running main action method: run_tests 02:10:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:10:51 INFO - Python 2.7.3 02:10:51 INFO - Return code: 0 02:10:51 INFO - grabbing minidump binary from tooltool 02:10: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')]} 02:10:51 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 0x272b370>, '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 0x272e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272ed80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:10:51 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 02:10:51 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 02:10:51 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 02:10:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:10:51 INFO - Return code: 0 02:10:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:10:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:10:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:10:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:10:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:10:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:10:51 INFO - Using env: {'DISPLAY': ':0', 02:10:51 INFO - 'HOME': '/home/cltbld', 02:10:51 INFO - 'LANG': 'en_US.UTF-8', 02:10:51 INFO - 'LANGUAGE': 'en_US:en', 02:10:51 INFO - 'LOGNAME': 'cltbld', 02:10:51 INFO - 'MAIL': '/var/mail/cltbld', 02:10:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:10:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:51 INFO - 'MOZ_NO_REMOTE': '1', 02:10:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:51 INFO - 'NO_EM_RESTART': '1', 02:10:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:51 INFO - 'PWD': '/builds/slave/test', 02:10:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:10:51 INFO - 'SHELL': '/bin/bash', 02:10:51 INFO - 'SHLVL': '1', 02:10:51 INFO - 'TERM': 'linux', 02:10:51 INFO - 'TMOUT': '86400', 02:10:51 INFO - 'USER': 'cltbld', 02:10:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324', 02:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:51 INFO - '_': '/tools/buildbot/bin/python'} 02:10:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:10:51 INFO - mozversion application_buildid: 20160812233009 02:10:51 INFO - mozversion application_changeset: 4cf5aa807f27376197743b62eff2b2c3c2891b44 02:10:51 INFO - mozversion application_display_name: Nightly 02:10:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:10:51 INFO - mozversion application_name: Firefox 02:10:51 INFO - mozversion application_remotingname: firefox 02:10:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:10:51 INFO - mozversion application_vendor: Mozilla 02:10:51 INFO - mozversion application_version: 51.0a1 02:10:51 INFO - mozversion platform_buildid: 20160812233009 02:10:51 INFO - mozversion platform_changeset: 4cf5aa807f27376197743b62eff2b2c3c2891b44 02:10:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:10:51 INFO - mozversion platform_version: 51.0a1 02:10:51 INFO - using testdate: 1471079451 02:10:51 INFO - actual date: 1471079451 02:10:51 INFO - starting webserver on 'localhost:50813' 02:10:51 INFO - SUITE-START | Running 2 tests 02:10:51 INFO - TEST-START | dromaeo_css 02:10:51 INFO - operating with platform_type : linux_ 02:10:51 INFO - Initialising browser for dromaeo_css test... 02:10:51 INFO - TEST-INFO | started process 9649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdKkBBI/profile http://localhost:50813/getInfo.html) 02:10:56 INFO - PROCESS | 9649 | __metrics Screen width/height:1600/1200 02:10:56 INFO - PROCESS | 9649 | colorDepth:24 02:10:56 INFO - PROCESS | 9649 | Browser inner width/height: 1024/697 02:10:56 INFO - PROCESS | 9649 | __metrics 02:10:56 ERROR - PROCESS | 9649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 02:10:57 INFO - TEST-INFO | 9649: exit 0 02:10:57 INFO - Browser initialized. 02:10:57 INFO - Running cycle 1/1 for dromaeo_css test... 02:10:57 INFO - TEST-INFO | started process 9769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdKkBBI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:09 INFO - PROCESS | 9769 | RSS: Main: 162889728 02:11:09 INFO - PROCESS | 9769 | 02:11:59 INFO - PROCESS | 9769 | 1471079519066 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] 02:14:08 INFO - PROCESS | 9769 | Cycle 1(1): loaded http://localhost:50813/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50813/tests/dromaeo/cssquery-ext.html) 02:14:10 INFO - PROCESS | 9769 | RSS: Main: 164417536 02:14:10 INFO - PROCESS | 9769 | 02:17:12 INFO - PROCESS | 9769 | Cycle 1(1): loaded http://localhost:50813/tests/dromaeo/cssquery-ext.html (next: http://localhost:50813/tests/dromaeo/cssquery-jquery.html) 02:17:12 INFO - PROCESS | 9769 | RSS: Main: 164597760 02:17:12 INFO - PROCESS | 9769 | 02:20:14 INFO - PROCESS | 9769 | Cycle 1(1): loaded http://localhost:50813/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50813/tests/dromaeo/cssquery-mootools.html) 02:20:15 INFO - PROCESS | 9769 | RSS: Main: 166838272 02:20:15 INFO - PROCESS | 9769 | 02:23:16 INFO - PROCESS | 9769 | Cycle 1(1): loaded http://localhost:50813/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50813/tests/dromaeo/cssquery-prototype.html) 02:23:17 INFO - PROCESS | 9769 | RSS: Main: 164253696 02:23:17 INFO - PROCESS | 9769 | 02:26:20 INFO - PROCESS | 9769 | Cycle 1(1): loaded http://localhost:50813/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50813/tests/dromaeo/cssquery-yui.html) 02:26:20 INFO - PROCESS | 9769 | RSS: Main: 166100992 02:26:20 INFO - PROCESS | 9769 | 02:29:23 INFO - PROCESS | 9769 | Cycle 1(1): loaded http://localhost:50813/tests/dromaeo/cssquery-yui.html (next: http://localhost:50813/tests/dromaeo/cssquery-dojo.html) 02:29:23 INFO - PROCESS | 9769 | RSS: Main: 166572032 02:29:23 INFO - PROCESS | 9769 | 02:29:23 INFO - PROCESS | 9769 | __start_tp_report 02:29:23 INFO - PROCESS | 9769 | _x_x_mozilla_page_load 02:29:23 INFO - PROCESS | 9769 | _x_x_mozilla_page_load_details 02:29:23 INFO - PROCESS | 9769 | |i|pagename|runs| 02:29:23 INFO - PROCESS | 9769 | |0;dojo.html;3117.1272043827726;3130.8121512709254;3135.6394014688317;3149.795263307885;3170.682931706828;5370.462953704628;5448.42791506892;5468.906218756245;5471.972640136799;5535.6955367454775;5392.083345831208;5448.101063324547;5471.206675032118;5472.151816468444;5473.753681084351;4984.426790919046;5004.599632029429;5044.646874718771;5060.54455099041;5061.316722242505;4951.77717002734;5076.263941728447;5095.847124586268;5104.821331253407;5132.435432102466;4993.328770967598;5105.591552675777;5203.1414816555225;5217.269582258468;5225.346831646044;4938.1111399947995;5026.773795179226;5031.22016087507;5067.619928505377;5081.415637201732;4866.343043689092;4912.066707325633;4946.480619534969;4976.104301225778;4990.076835785391;5400.540954018913;5422.647527910713;5431.022415965124;5434.510894019557;5511.669299842022;5706.3722990471015;5786.768529258825;5791.276090488689;5838.5329173666005;5839.357670656224;5855.4144585541535;5934.940650593525;5937.376575459601;5958.374370691102;5966.820995370146;5495.587830912697;5499.7250137492965;5512.972435137799;5519.668819870821;5523.917141242925;5887.735051922674;5918.260217472816;6047.909281360783;6048.848778780478;6068.059450785136;5716.456936591017;5770.047942089508;5782.045962416154;5808.012637851575;5822.388649191858;5843.707814609253;5850.970745146247;5852.882942341129;5862.648241105548;5866.325372582122;5566.832995010156;5795.652260864362;5800.1299805029585;5821.359650438449;5827.854303642443;5617.269754931833;5768.7692492300675;5815.302163740378;5919.319278283053;5950.583459157904;4496.887577810516;4511.932321015187;4523.32150177476;4546.909061818745;4560.042391097841;3994.201159768058;4009.699272554512;4016.0763024504527;4017.678585713136;4041.535223449282;5338.3593968724;5459.754311056012;5526;5543.916841247304;5550.72246387679;5919.6744179070565;5975.910361344583;5984.581079324405;5991.221141251609;6020.638761674313;5535.086710692771;5577.972110139423;5579.804706835242;5581.581381396411;5595.160725891067;4894.070126675992;5032.84901452957;5060.139776237975;5065.11360511909;5076.466970968069;6206.751729930752;6217.409346112112;6221.844453888689;6232.345603711636;6233.625982441068;5962.07587823888;5968.970155149196;5970;5998.730057147526;6048.0625503047095;6008.789692360747;6041.909371359346;6081.179040829608;6120.540959427972;6188.319284878749;5778.27771528559;5803.680797556175;5816.331121921034;5847.678377689268;5848.824535263949;5877.706114694162;5931.970340148272;5944.405559444021;5952.404759524013;5965.552583556164;5624.521915637053;5709.600327977168;5767.250257466502;5788.681622510802;5792.94207057924;5792;5805.245318108618;5808.332041815245;5811.76752929895;5838.795642152504;5714.485696287354;5727;5736.225609542826;5741.25363702716;5746.885062298647;5617.719114044363;5677.1768093627015;5722.198892155185;5733.71331433435;5824.592278540631;5592.69240191777;5633.8309850704545;5646.9152962704775;5659.349174844946;5663.7451314690115 02:29:23 INFO - PROCESS | 9769 | |1;ext.html;576.1559315602641;581.1631250998562;583.0991118721574;592.7747455966733;602.8966990407555;40725.59274407255;44517.332240016425;44520.777396113015;44683;44755.999999999956;44327.77836110823;44991.55008449915;45008.54991450084;45026;45033.774831125884;8847.601857916408;8889.244414224799;8926.419782714136;8940.06129356418;8966.551672416386;8736.912630873705;8870.645174193025;8873.29013678904;8898.59956301968;8909.1536304051;8894.688685895995;8896.243819275336;8907.198352148305;8921.10788921106;8965.372423930328;8837.558122093933;8852.734417967471;8897.911020889773;8903.955480222623;8906.554672266393;8701.869471957925;8773.736787896374;8806.86789698155;8839.69061082859;8844.690435834715;41951.790241048904;42443.36334954978;42445;42495.900491940854;42542.57457425417;3437.089171369564;3571.6606922342335;3591;3747.381682022463;3948.1314110895846;33014.6698533014;33332.3333533328;33394.1651458713;33398.666013339796;33563.328733425195;4313.870583882457;4393.121375724836;4467.687261891669;4477.462704475483;4547.909041819145;360973;362532;363380;364124;364982.1750891255;56885.715571421875;57291.71354143203;57434.7128264356;57450.712746436;57595.42404575984;36906;37749.81125094412;37888;39364.40953385702;39383.21233575312;15861.762073568905;15876.126813025394;15939.203039847962;15970.76043859343;15992.280347384396;12890;12933.741325173443;12935.417906194056;12973.221606703628;12988.675283117998;18996.14517346695;19214.231430742893;19232.23071077141;19271.807281927282;19337.709934350994;6621.271660117383;6899.413549848218;6946.7221311148;6963.651817409109;6999.650017499104;892.4689809563299;914.3005600715458;1042.7393151712072;1075.5321435175724;1076.7469644633504;31588.842055789573;31677.683223167933;31730.682693173236;31900.680993190235;31968.200794979846;1097.780443911221;1106.3583121789343;1153.3310679805693;1160.988390116105;1161.3902701081831;16574.337026518806;16685.24916378766;16797;16910.74633880493;17073.49685777518;548941;551826;554250;556110;559099;59063.704681476316;59499.40500594939;59793.40206597965;59879.700601497585;59914.40085599088;1246;1294.6698591859204;1314.8619394963391;1319.5843309357713;1363.6113707593486;30775.692243077283;31188.68811311858;32090.518642220854;32554;33341.83329083436;51567.226491601905;52154.21768673549;52371.47628523666;52434.21348679849;52439;513200;514395;516327;516882;517968;29138;29264.853675731487;29372.55941160927;29431.705682942895;29790.553141702458;49048.75475622599;49133.2630010543;50002.24996624981;50068.749656251486;50587;41173.588264118174;41231.1753764917;42779.786101069294;43455.46868381889;44039;42432.15135697331;42696.78651606722;42834.143317134105;43358;43579.56420435755;34538.48192277168;41572;41824.79087604542;41944.1611167781;42774.358384623636;36171.819140904125;37343.62656373402;38064.80967595255;38765.41851872168;38996.63511777074;29108;29729.027097290098;30031;30087.849560752056;30097 02:29:23 INFO - PROCESS | 9769 | |2;jquery.html;396.47071160001394;401.8955071681362;403.88893054410033;417.9059711564897;423.33113680385;14243.928780356084;18812.811871881277;19738.605227895434;20407.795922040776;20536.89731551342;19556.608867822633;19684.11421486033;19699.507512312164;19799;19897.50256243591;5648.795726096083;5831.504322132624;5930.525557955375;5967.910481342783;5968.79109231177;5688.175214593882;5850.561207909403;5893.941060589382;5922;5926.644401335933;5801.767929282823;5805.216295800076;5812.912806307909;5818.359980402152;5850.912236316459;5789.2763404574425;5798.942010579904;5833.416658334175;5844.123381492767;6005.1892994445625;5898.528117750569;5917.8816423671715;5923.141144534062;5933.851653708649;5964.343922168558;13941.469022567604;21452.678209826867;22343.55312893733;22887.54224915509;24553.263402097964;2141.2291575032978;2461.913833015854;2502.2368177705794;2570.2674737699667;3003.6996300369788;10246.795064098676;10267.7433064174;10457.111145552637;10603.310784798963;11254.549818007352;1971.5859669469428;1996.9715596467831;2007.1770574064562;2035.3385149826365;2052.3124753207694;84859.15140848575;85365.57317213436;85618.5719071407;85622.57188714079;86779.13220867774;11308.434578271053;11431.885681143249;11695.356755378536;11701.356425396514;11864.347460889561;15668.37326506927;15672.216389180496;15778.368865245491;15802.762958555631;15839.920800395925;8206;8362.749117526484;8370.246677799027;8532.829343413221;8616.138386161334;7939.880901786478;8126.715564955198;8289.58552072394;8484.36367272457;8525.31797456202;4629;4746.95253047472;4785.904281914342;4801.207800712843;5017.172166592544;1985.5253306713253;1988.1450976080425;1988.5540784834734;1992.85053620979;2066.73132492775;956.4978386347224;1076.8516808966006;1080.9244801422478;1098.368438148052;1128.503458478267;19498.61002779965;19618.411447656592;19732.50668733293;19843.107060182327;20030;981.4503877828439;1000.6847842929454;1009.4094954451728;1009.9293049486612;1038.901304376083;10308.278420510642;10967.561297548169;10986.945065274622;11054.944725276322;11202.551897924155;512384;515122;524523;527799;532193;74963.62518187483;91365;101539;105720.47139764253;108047;995.3576598612348;1004.4626125023224;1023.9897601023895;1035.6064695415694;1036.3522798251092;17806.46580602584;17846.19692113832;18220.81779182191;18521.9073904635;18850.434486965412;31126.688733113286;34969.82515087408;43094.13811723811;44382.3342649867;44458;60508;61765.691171543855;63218.683906580176;63748.36251637424;63880;8608.698695545876;8661.42910587355;8704.651813927625;8741.825163496822;8875.334349923653;12841.614751557468;13251.777781109125;13324.133931294435;13381.799273010718;13661.726765464437;10892.18308626872;11535.884641153481;11897.881021189678;12431.689207769878;12792.552260671204;11511;11511.136664750346;11788.23376480526;12049.457774399998;12476.5009399623;12242.87757122453;12252.571160009356;12476.937615311865;12673.429695663533;12901.935490322488;8686.131386861263;8704.477731336141;8709.303255739653;8738.825223495622;9103.817923641622;11092.445377731243;11845.52617895309;11892.821607676065;11905.761884762429;12360.876391235972 02:29:23 INFO - PROCESS | 9769 | |3;mootools.html;1450.282110355374;1464.560631810457;1582.7704982777498;1718.6734520441123;1733.4193045329814;7296.890546641805;8401.28589069929;8524;9110.271178305737;9131.36080474367;8603.311735061196;8963.686270980517;8967.058458861808;8992.730218093451;9004.324675649335;2418.2986933789225;2442.9144979925704;2444.7555244475498;2447.902083916641;2448.485817978227;2393.4375421775867;2417.359399759065;2448.6571879936823;2450.9264722058365;2460.9753902461016;2387.0451819272257;2392.461696118377;2428.732839387666;2439.3901524618846;2440.3655049687122;2361.397843549884;2379.9286021419384;2383.261189031397;2383.3088404362716;2385.7017872765905;2306.3657494189233;2321.7330007049068;2333.696619439462;2337.520808234308;2349.5888219561507;8949.731508054769;9025.05236950124;9041.141091596288;9045.140711632384;9056;5249;5336.839894803162;5375.086235340002;5454.727263636842;5455.18172274158;3504.106452854531;3580.230250496156;3587.4798154267746;3588.910277243064;3591.2458383739445;1142.5144313666658;1164.5341863254766;1166.854143232096;1200.963971080869;1213.7087099096154;12069.879301206964;12101.334426606532;12107.757844843141;12205.267683938991;12234.632961011184;4476.843310484118;4553.954460455419;4725.362076119749;4762.047590481918;4803.159447096744;10292.176625869912;10431.321964072462;10447.425391603534;10463.319884207502;10472.214583906238;5354;5380.3274590676165;5429.837104886859;5438.83683489496;5440.238366628675;4183.142455796555;4865.099956508057;4885.071836351082;4925.236588328815;4997.500249975046;4011.9598804011584;4064.4919385076864;4070.430139780433;4217.641500472433;4220.366944958281;1329.6011196640968;1336.211635135275;1352.4454973460834;1357.945682172702;1361.7957306404119;986.2504496582505;1013.9087482126644;1031.5718976624767;1032.829583118777;1034.6482196053228;5876;6043.214382130295;6139.079138129227;6190.473809726223;6207.689615519296;467.34104912073815;480.4066977283053;481.5232919409829;482.52230292010654;483.7774623673079;4201.432806571073;4262.104957958863;4267.97866010668;4278.657707383464;4332.415123958288;10608.840867386996;11075.224734268684;11083.168762342695;11099.44502774858;11131.888681113085;10944.56221751137;10980.341179529254;10980.835287470694;11016.944915275373;11025.558977640805;7814.4529882907655;8104.797380065427;8118.634661440249;8222.437736830103;8327.458715183615;6243.282022567281;6364.936350636434;6483.805485835433;6501.577397469149;6576.145101136822;10024.849627255451;10096.141827944706;10274.897251027394;10390.792184156124;10544.15646748243;10160.949195253976;10290.742731431475;10304.948475257575;10401.323913945569;10500.317479363817;7034.577925324497;7826.960865195865;7887.84224315499;7893.763187104396;8012.879806802786;8598.570071496526;8672.089430609947;8750.212480876497;8758.91241087581;8772.38593298463;7696.923030769844;7717.652705628372;7744.535327880345;7904.288614024766;8054.597270136353;7659.808504787202;7811.765647030598;7869.0950540688555;7911.802204944923;7947.284744372803;6951.409130223988;7045.577265364094;7092.893606596009;7094.64526773649;7107.609081500567;5517.393086760373;5572.526335261548;5572.665640061609;5619.157126431068;5699.8860022800145;5561.6663000220115;5569.470900264469;5637.46444087811;5642.830715078554;5693.174489699053 02:29:23 INFO - PROCESS | 9769 | |4;prototype.html;341.3769869987273;342.5649425229958;346.74860725973673;347.15987310708084;347.52042181789125;5500.624843789053;5588.413216612258;5589.7205139743055;5622.662640241589;5635.915461268084;5512.5589952803775;5519.724013799314;5552.805651802188;5554.166874968757;5575.609707320489;4116.34138537834;4222.9788851055855;4318.956810431902;4334.739915605058;4376.19040477511;4332.808477668635;4341.176705783562;4348.30427131659;4357.3899654048455;4359.891002724926;4322.330038843984;4336.718113322624;4338.262495375778;4342.3052311630145;4373;4242.753749694484;4250.193667691235;4275.230458517465;4314.848980285675;4319.244132276839;3818.8663396781258;3822.923541529182;3824.4836947012354;3828.3491806392703;3845.5000849889616;5336.199570064483;5372.650777699437;5388.030154572176;5389.766140315779;5409.702466364349;4838.685485443435;4847.224444088964;4908.141075311842;4929.433115191763;4949.232868905326;5681.375048744635;5683.261176047129;5687.516561092312;5734.655920644733;5771.249737534135;4169.312063509517;4189.560096189917;4198.769067701275;4199.853005144836;4200.789960501963;5769.769209231626;5917.863532327873;5924.377940316248;5968.97015514924;6030.66831324277;4256.4679415073115;4259.403683484315;4269.594388533084;4271.957280427218;4281.400603915455;4330.480342358937;4343.913121737548;4353.194658988097;4358.607725304674;4360.4331436913;4628.166929952641;4842.806287748451;4902.41171059468;4924.285978533093;4937.333459982857;5687.175359572839;5725.656460612377;5739.885202295931;5752;5807.88384232313;1451.354147404416;1473.3296350160651;1474.9410023598937;1475.1960181701;1478.209158100411;940.05994005994;947.4315410753493;949.1220620925616;951.8286708392556;966.1932286540817;4787.640926930494;4809.667311353991;4820.3492528508905;4831;4901.108346075833;5212.739363031833;5213.244079608436;5216.66091704038;5233.450487698813;5276.709780962007;4660.231061874752;4704.458987216445;4914.287428322873;4925.630577706686;4968.751562421864;2741.821781584191;2775.875085621152;2786.1193694256294;2792.7207279272316;2817.21118086936;5408.972955135199;5415.48552887475;5446.509814116748;5472.671639701631;5497.257870187554;5195.272661827347;5239.580833533309;5287.4976877196605;5307.858810355792;5474.945250547523;5321.3348331458565;5374.516293533601;5391.29913111293;5413.891722165614;5441;5128;5235.806158243392;5239.973800130975;5242.895142097213;5253.185756207794;4820.903581928412;5181.637285389987;5185.585153187812;5185.611079169153;5211.400688920671;5447.346318441812;5447.400785913625;5467.6719396836315;5484.546595152208;5491.341039075336;3866.9226615468096;3875.1668391296007;3880.8253628586217;3887.9028024298486;3897.3692757389217;4954.504549545017;5189.584833213409;5214.817481388133;5215.530602245816;5232.215167724872;5568.021108706823;5623.268975033219;5810.48927278919;5813.3605303417435;5816.731474724946;5751.194832723339;5786.884262314814;5788.421157884178;5837.1244313351635;5906.291245050621;5591.944080559142;5626.465485778845;5727.391743201756;5785.4214578541805;5799.8550036249435;5712.171735098304;5774.335951365647;5801.82594522165;5861.472467477947;5868.5645457134815;5706.28671416073;5710.143478478261;5735.885282294247;5748.166515855094;5760.251167348386 02:29:23 INFO - PROCESS | 9769 | |5;yui.html;743.1490942870414;749.2619769527018;780.1340512031647;799.4164260090135;814.3973459639865;16372.508824735261;17427.91286043571;17682.11589420527;17760;17803.554911127227;15691.60770980726;15883.285252163652;15928.442504512344;15938.20308984552;15992.200389980513;650.0898741761548;784.5763287824597;798.5727635714879;809.9109097999245;823.7487566292278;817.2930415190847;819.2053707903324;819.6516480495795;821.708293555788;822.042320696391;855.6833971430548;857.1642648417806;857.1856736100698;857.8627419612864;859.6131740716671;851.8764779107057;853.1298075962515;854.0477367734962;855.7389996051202;856.3662889461816;623.4139908486009;623.6227082614998;626.0421555020826;626.1421852062658;626.5676683088654;15348.07911525312;15474.22628868552;15481.380744770197;15521.534353969399;15562.299696513572;16078.356865725356;16191.676166476722;16487.093209873452;16764.66470670592;17144.914275428542;13198.802017969738;13242.602721918358;13299.867001330056;13498.122622029538;13633.454661813515;3984.1633257015774;4041.191761647653;4086.856960006415;4128.153728485683;4239.448871646666;72042.63978680073;75425.24574754237;75753;82768;82778;11520.884791152148;11530.481128349244;11564.363959982282;11805.881941180478;11870.703232419086;20266.392008239778;20268.594628107356;20280.290189843283;20285.89857050705;20354.79645203529;9099.771530843384;9205.539723013822;9210.22380823859;9244.3528952974;9628.90371096294;4715.104130215317;4768.499307572724;4806.639502037361;4877.244027175793;4908.092002979461;3561.71506279497;3655.7570426054735;3691.3540130477595;3691.6862066724093;3703.166787472797;644.6100109433819;650.3269116464531;654.8395643067479;663.8074958262147;665.870155319708;610.3377835048933;650.8828410885991;676.4520738202073;682.2836022176793;715.1704023332909;10064.345817521838;10082.949585252027;10159.4920253987;10283.303254962848;10556.577736890438;591.6716222496556;615.833724894285;620.7058283478997;640.5484133685741;642.5662677692538;4777.570018698334;5093.9745301274;5123.7438128093445;5185.274061631375;5192.61055420845;117076;130288;135643.2524861625;137730;141728.29135854254;113890;117131;117357.41321293339;117608;118442;93131;97929.5103524492;97943;100934;103471;9504.904950950402;9639.421634701941;9685.951570242103;9692.369995950241;10011.048950349705;57168;59054.11418828635;59924.40075599188;59967.60129594767;62035;75970;76985;84194;87231;89522;11497.562804649418;11796.52813887435;11904.642860714192;11909;12624.116311858083;13103.672408189872;13138.73722525525;13166.539171128965;13167.47330106785;13537.59387218385;12897.50022310595;13564.186148831102;13583.592492225249;14227;14343.211123388313;13390;13735.931320343334;14135.717285654435;14741.705165896836;14756.33596488182;12162.087843411957;12442.37788110609;12640.115191936477;12920.547780827626;13539.11995720275;10345.327553709287;10630.149588033093;10833.29583577065;11233.101351891992;11301.773964520828;11392.487338069972;11684.941575292409;11842.76314473723;11897.46461409256;12167.513299467922 02:29:23 INFO - PROCESS | 9769 | __end_tp_report 02:29:23 INFO - PROCESS | 9769 | __start_cc_report 02:29:23 INFO - PROCESS | 9769 | _x_x_mozilla_cycle_collect,322 02:29:23 INFO - PROCESS | 9769 | __end_cc_report 02:29:23 INFO - PROCESS | 9769 | __startTimestamp1471080563735__endTimestamp 02:29:23 INFO - PROCESS | 9769 | 02:29:23 INFO - PROCESS | 9769 | ------- Summary: start ------- 02:29:23 INFO - PROCESS | 9769 | Number of tests: 6 02:29:23 INFO - PROCESS | 9769 | 02:29:23 INFO - PROCESS | 9769 | [#0] dojo.html Cycles:165 Average:5468.02 Median:5659.35 stddev:626.06 (11.1%) stddev-sans-first:600.20 02:29:23 INFO - PROCESS | 9769 | Values: 3117.1 3130.8 3135.6 3149.8 3170.7 5370.5 5448.4 5468.9 5472.0 5535.7 5392.1 5448.1 5471.2 5472.2 5473.8 4984.4 5004.6 5044.6 5060.5 5061.3 4951.8 5076.3 5095.8 5104.8 5132.4 4993.3 5105.6 5203.1 5217.3 5225.3 4938.1 5026.8 5031.2 5067.6 5081.4 4866.3 4912.1 4946.5 4976.1 4990.1 5400.5 5422.6 5431.0 5434.5 5511.7 5706.4 5786.8 5791.3 5838.5 5839.4 5855.4 5934.9 5937.4 5958.4 5966.8 5495.6 5499.7 5513.0 5519.7 5523.9 5887.7 5918.3 6047.9 6048.8 6068.1 5716.5 5770.0 5782.0 5808.0 5822.4 5843.7 5851.0 5852.9 5862.6 5866.3 5566.8 5795.7 5800.1 5821.4 5827.9 5617.3 5768.8 5815.3 5919.3 5950.6 4496.9 4511.9 4523.3 4546.9 4560.0 3994.2 4009.7 4016.1 4017.7 4041.5 5338.4 5459.8 5526.0 5543.9 5550.7 5919.7 5975.9 5984.6 5991.2 6020.6 5535.1 5578.0 5579.8 5581.6 5595.2 4894.1 5032.8 5060.1 5065.1 5076.5 6206.8 6217.4 6221.8 6232.3 6233.6 5962.1 5969.0 5970.0 5998.7 6048.1 6008.8 6041.9 6081.2 6120.5 6188.3 5778.3 5803.7 5816.3 5847.7 5848.8 5877.7 5932.0 5944.4 5952.4 5965.6 5624.5 5709.6 5767.3 5788.7 5792.9 5792.0 5805.2 5808.3 5811.8 5838.8 5714.5 5727.0 5736.2 5741.3 5746.9 5617.7 5677.2 5722.2 5733.7 5824.6 5592.7 5633.8 5646.9 5659.3 5663.7 02:29:23 INFO - PROCESS | 9769 | 02:29:23 INFO - PROCESS | 9769 | [#1] ext.html Cycles:180 Average:63049.20 Median:42619.68 stddev:128835.53 (302.3%) stddev-sans-first:129111.56 02:29:23 INFO - PROCESS | 9769 | Values: 576.2 581.2 583.1 592.8 602.9 40725.6 44517.3 44520.8 44683.0 44756.0 44327.8 44991.6 45008.5 45026.0 45033.8 8847.6 8889.2 8926.4 8940.1 8966.6 8736.9 8870.6 8873.3 8898.6 8909.2 8894.7 8896.2 8907.2 8921.1 8965.4 8837.6 8852.7 8897.9 8904.0 8906.6 8701.9 8773.7 8806.9 8839.7 8844.7 41951.8 42443.4 42445.0 42495.9 42542.6 3437.1 3571.7 3591.0 3747.4 3948.1 33014.7 33332.3 33394.2 33398.7 33563.3 4313.9 4393.1 4467.7 4477.5 4547.9 360973.0 362532.0 363380.0 364124.0 364982.2 56885.7 57291.7 57434.7 57450.7 57595.4 36906.0 37749.8 37888.0 39364.4 39383.2 15861.8 15876.1 15939.2 15970.8 15992.3 12890.0 12933.7 12935.4 12973.2 12988.7 18996.1 19214.2 19232.2 19271.8 19337.7 6621.3 6899.4 6946.7 6963.7 6999.7 892.5 914.3 1042.7 1075.5 1076.7 31588.8 31677.7 31730.7 31900.7 31968.2 1097.8 1106.4 1153.3 1161.0 1161.4 16574.3 16685.2 16797.0 16910.7 17073.5 548941.0 551826.0 554250.0 556110.0 559099.0 59063.7 59499.4 59793.4 59879.7 59914.4 1246.0 1294.7 1314.9 1319.6 1363.6 30775.7 31188.7 32090.5 32554.0 33341.8 51567.2 52154.2 52371.5 52434.2 52439.0 513200.0 514395.0 516327.0 516882.0 517968.0 29138.0 29264.9 29372.6 29431.7 29790.6 49048.8 49133.3 50002.2 50068.7 50587.0 41173.6 41231.2 42779.8 43455.5 44039.0 42432.2 42696.8 42834.1 43358.0 43579.6 34538.5 41572.0 41824.8 41944.2 42774.4 36171.8 37343.6 38064.8 38765.4 38996.6 29108.0 29729.0 30031.0 30087.8 30097.0 02:29:23 INFO - PROCESS | 9769 | 02:29:23 INFO - PROCESS | 9769 | [#2] jquery.html Cycles:180 Average:30353.13 Median:2103.98 stddev:86179.08 (4096.0%) stddev-sans-first:86391.48 02:29:23 INFO - PROCESS | 9769 | Values: 396.5 401.9 403.9 417.9 423.3 14243.9 18812.8 19738.6 20407.8 20536.9 19556.6 19684.1 19699.5 19799.0 19897.5 5648.8 5831.5 5930.5 5967.9 5968.8 5688.2 5850.6 5893.9 5922.0 5926.6 5801.8 5805.2 5812.9 5818.4 5850.9 5789.3 5798.9 5833.4 5844.1 6005.2 5898.5 5917.9 5923.1 5933.9 5964.3 13941.5 21452.7 22343.6 22887.5 24553.3 2141.2 2461.9 2502.2 2570.3 3003.7 10246.8 10267.7 10457.1 10603.3 11254.5 1971.6 1997.0 2007.2 2035.3 2052.3 84859.2 85365.6 85618.6 85622.6 86779.1 11308.4 11431.9 11695.4 11701.4 11864.3 15668.4 15672.2 15778.4 15802.8 15839.9 8206.0 8362.7 8370.2 8532.8 8616.1 7939.9 8126.7 8289.6 8484.4 8525.3 4629.0 4747.0 4785.9 4801.2 5017.2 1985.5 1988.1 1988.6 1992.9 2066.7 956.5 1076.9 1080.9 1098.4 1128.5 19498.6 19618.4 19732.5 19843.1 20030.0 981.5 1000.7 1009.4 1009.9 1038.9 10308.3 10967.6 10986.9 11054.9 11202.6 512384.0 515122.0 524523.0 527799.0 532193.0 74963.6 91365.0 101539.0 105720.5 108047.0 995.4 1004.5 1024.0 1035.6 1036.4 17806.5 17846.2 18220.8 18521.9 18850.4 31126.7 34969.8 43094.1 44382.3 44458.0 60508.0 61765.7 63218.7 63748.4 63880.0 8608.7 8661.4 8704.7 8741.8 8875.3 12841.6 13251.8 13324.1 13381.8 13661.7 10892.2 11535.9 11897.9 12431.7 12792.6 11511.0 11511.1 11788.2 12049.5 12476.5 12242.9 12252.6 12476.9 12673.4 12901.9 8686.1 8704.5 8709.3 8738.8 9103.8 11092.4 11845.5 11892.8 11905.8 12360.9 02:29:23 INFO - PROCESS | 9769 | 02:29:23 INFO - PROCESS | 9769 | [#3] mootools.html Cycles:180 Average:5899.65 Median:4515.40 stddev:3311.56 (73.3%) stddev-sans-first:3303.97 02:29:23 INFO - PROCESS | 9769 | Values: 1450.3 1464.6 1582.8 1718.7 1733.4 7296.9 8401.3 8524.0 9110.3 9131.4 8603.3 8963.7 8967.1 8992.7 9004.3 2418.3 2442.9 2444.8 2447.9 2448.5 2393.4 2417.4 2448.7 2450.9 2461.0 2387.0 2392.5 2428.7 2439.4 2440.4 2361.4 2379.9 2383.3 2383.3 2385.7 2306.4 2321.7 2333.7 2337.5 2349.6 8949.7 9025.1 9041.1 9045.1 9056.0 5249.0 5336.8 5375.1 5454.7 5455.2 3504.1 3580.2 3587.5 3588.9 3591.2 1142.5 1164.5 1166.9 1201.0 1213.7 12069.9 12101.3 12107.8 12205.3 12234.6 4476.8 4554.0 4725.4 4762.0 4803.2 10292.2 10431.3 10447.4 10463.3 10472.2 5354.0 5380.3 5429.8 5438.8 5440.2 4183.1 4865.1 4885.1 4925.2 4997.5 4012.0 4064.5 4070.4 4217.6 4220.4 1329.6 1336.2 1352.4 1357.9 1361.8 986.3 1013.9 1031.6 1032.8 1034.6 5876.0 6043.2 6139.1 6190.5 6207.7 467.3 480.4 481.5 482.5 483.8 4201.4 4262.1 4268.0 4278.7 4332.4 10608.8 11075.2 11083.2 11099.4 11131.9 10944.6 10980.3 10980.8 11016.9 11025.6 7814.5 8104.8 8118.6 8222.4 8327.5 6243.3 6364.9 6483.8 6501.6 6576.1 10024.8 10096.1 10274.9 10390.8 10544.2 10160.9 10290.7 10304.9 10401.3 10500.3 7034.6 7827.0 7887.8 7893.8 8012.9 8598.6 8672.1 8750.2 8758.9 8772.4 7696.9 7717.7 7744.5 7904.3 8054.6 7659.8 7811.8 7869.1 7911.8 7947.3 6951.4 7045.6 7092.9 7094.6 7107.6 5517.4 5572.5 5572.7 5619.2 5699.9 5561.7 5569.5 5637.5 5642.8 5693.2 02:29:23 INFO - PROCESS | 9769 | 02:29:23 INFO - PROCESS | 9769 | [#4] prototype.html Cycles:180 Average:4658.93 Median:5214.03 stddev:1336.79 (25.6%) stddev-sans-first:1300.67 02:29:23 INFO - PROCESS | 9769 | Values: 341.4 342.6 346.7 347.2 347.5 5500.6 5588.4 5589.7 5622.7 5635.9 5512.6 5519.7 5552.8 5554.2 5575.6 4116.3 4223.0 4319.0 4334.7 4376.2 4332.8 4341.2 4348.3 4357.4 4359.9 4322.3 4336.7 4338.3 4342.3 4373.0 4242.8 4250.2 4275.2 4314.8 4319.2 3818.9 3822.9 3824.5 3828.3 3845.5 5336.2 5372.7 5388.0 5389.8 5409.7 4838.7 4847.2 4908.1 4929.4 4949.2 5681.4 5683.3 5687.5 5734.7 5771.2 4169.3 4189.6 4198.8 4199.9 4200.8 5769.8 5917.9 5924.4 5969.0 6030.7 4256.5 4259.4 4269.6 4272.0 4281.4 4330.5 4343.9 4353.2 4358.6 4360.4 4628.2 4842.8 4902.4 4924.3 4937.3 5687.2 5725.7 5739.9 5752.0 5807.9 1451.4 1473.3 1474.9 1475.2 1478.2 940.1 947.4 949.1 951.8 966.2 4787.6 4809.7 4820.3 4831.0 4901.1 5212.7 5213.2 5216.7 5233.5 5276.7 4660.2 4704.5 4914.3 4925.6 4968.8 2741.8 2775.9 2786.1 2792.7 2817.2 5409.0 5415.5 5446.5 5472.7 5497.3 5195.3 5239.6 5287.5 5307.9 5474.9 5321.3 5374.5 5391.3 5413.9 5441.0 5128.0 5235.8 5240.0 5242.9 5253.2 4820.9 5181.6 5185.6 5185.6 5211.4 5447.3 5447.4 5467.7 5484.5 5491.3 3866.9 3875.2 3880.8 3887.9 3897.4 4954.5 5189.6 5214.8 5215.5 5232.2 5568.0 5623.3 5810.5 5813.4 5816.7 5751.2 5786.9 5788.4 5837.1 5906.3 5591.9 5626.5 5727.4 5785.4 5799.9 5712.2 5774.3 5801.8 5861.5 5868.6 5706.3 5710.1 5735.9 5748.2 5760.3 02:29:23 INFO - PROCESS | 9769 | 02:29:23 INFO - PROCESS | 9769 | [#5] yui.html Cycles:180 Average:22800.53 Median:3691.52 stddev:34301.88 (929.2%) stddev-sans-first:34358.12 02:29:23 INFO - PROCESS | 9769 | Values: 743.1 749.3 780.1 799.4 814.4 16372.5 17427.9 17682.1 17760.0 17803.6 15691.6 15883.3 15928.4 15938.2 15992.2 650.1 784.6 798.6 809.9 823.7 817.3 819.2 819.7 821.7 822.0 855.7 857.2 857.2 857.9 859.6 851.9 853.1 854.0 855.7 856.4 623.4 623.6 626.0 626.1 626.6 15348.1 15474.2 15481.4 15521.5 15562.3 16078.4 16191.7 16487.1 16764.7 17144.9 13198.8 13242.6 13299.9 13498.1 13633.5 3984.2 4041.2 4086.9 4128.2 4239.4 72042.6 75425.2 75753.0 82768.0 82778.0 11520.9 11530.5 11564.4 11805.9 11870.7 20266.4 20268.6 20280.3 20285.9 20354.8 9099.8 9205.5 9210.2 9244.4 9628.9 4715.1 4768.5 4806.6 4877.2 4908.1 3561.7 3655.8 3691.4 3691.7 3703.2 644.6 650.3 654.8 663.8 665.9 610.3 650.9 676.5 682.3 715.2 10064.3 10082.9 10159.5 10283.3 10556.6 591.7 615.8 620.7 640.5 642.6 4777.6 5094.0 5123.7 5185.3 5192.6 117076.0 130288.0 135643.3 137730.0 141728.3 113890.0 117131.0 117357.4 117608.0 118442.0 93131.0 97929.5 97943.0 100934.0 103471.0 9504.9 9639.4 9686.0 9692.4 10011.0 57168.0 59054.1 59924.4 59967.6 62035.0 75970.0 76985.0 84194.0 87231.0 89522.0 11497.6 11796.5 11904.6 11909.0 12624.1 13103.7 13138.7 13166.5 13167.5 13537.6 12897.5 13564.2 13583.6 14227.0 14343.2 13390.0 13735.9 14135.7 14741.7 14756.3 12162.1 12442.4 12640.1 12920.5 13539.1 10345.3 10630.1 10833.3 11233.1 11301.8 11392.5 11684.9 11842.8 11897.5 12167.5 02:29:23 INFO - PROCESS | 9769 | -------- Summary: end -------- 02:29:23 INFO - PROCESS | 9769 | 02:29:24 INFO - TEST-INFO | 9769: exit 0 02:29:24 INFO - TEST-OK | dromaeo_css | took 1112687ms 02:29:24 INFO - TEST-START | kraken 02:29:24 INFO - operating with platform_type : linux_ 02:29:24 INFO - Initialising browser for kraken test... 02:29:24 INFO - TEST-INFO | started process 10137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp72sDYc/profile http://localhost:50813/getInfo.html) 02:29:28 INFO - PROCESS | 10137 | __metrics Screen width/height:1600/1200 02:29:28 INFO - PROCESS | 10137 | colorDepth:24 02:29:28 INFO - PROCESS | 10137 | Browser inner width/height: 1024/697 02:29:28 INFO - PROCESS | 10137 | __metrics 02:29:29 ERROR - PROCESS | 10137 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 02:29:30 INFO - TEST-INFO | 10137: exit 0 02:29:30 INFO - Browser initialized. 02:29:30 INFO - Running cycle 1/1 for kraken test... 02:29:30 INFO - TEST-INFO | started process 10256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp72sDYc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:42 INFO - PROCESS | 10256 | RSS: Main: 163389440 02:29:42 INFO - PROCESS | 10256 | 02:29:44 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50813/tests/kraken/driver.html?testName=audio-beat-detection) 02:29:45 INFO - PROCESS | 10256 | RSS: Main: 168693760 02:29:45 INFO - PROCESS | 10256 | 02:29:48 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50813/tests/kraken/driver.html?testName=audio-dft) 02:29:48 INFO - PROCESS | 10256 | RSS: Main: 168361984 02:29:48 INFO - PROCESS | 10256 | 02:29:51 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50813/tests/kraken/driver.html?testName=audio-fft) 02:29:52 INFO - PROCESS | 10256 | RSS: Main: 163827712 02:29:52 INFO - PROCESS | 10256 | 02:29:54 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50813/tests/kraken/driver.html?testName=audio-oscillator) 02:29:55 INFO - PROCESS | 10256 | RSS: Main: 164745216 02:29:55 INFO - PROCESS | 10256 | 02:29:57 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50813/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:29:57 INFO - PROCESS | 10256 | RSS: Main: 165175296 02:29:57 INFO - PROCESS | 10256 | 02:30:01 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50813/tests/kraken/driver.html?testName=imaging-darkroom) 02:30:01 INFO - PROCESS | 10256 | RSS: Main: 164937728 02:30:01 INFO - PROCESS | 10256 | 02:30:05 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50813/tests/kraken/driver.html?testName=imaging-desaturate) 02:30:05 INFO - PROCESS | 10256 | RSS: Main: 162430976 02:30:05 INFO - PROCESS | 10256 | 02:30:08 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50813/tests/kraken/driver.html?testName=json-parse-financial) 02:30:09 INFO - PROCESS | 10256 | RSS: Main: 164323328 02:30:09 INFO - PROCESS | 10256 | 02:30:10 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50813/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:11 INFO - PROCESS | 10256 | RSS: Main: 164401152 02:30:11 INFO - PROCESS | 10256 | 02:30:13 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50813/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:30:13 INFO - PROCESS | 10256 | RSS: Main: 164691968 02:30:13 INFO - PROCESS | 10256 | 02:30:16 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50813/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:30:16 INFO - PROCESS | 10256 | RSS: Main: 164765696 02:30:16 INFO - PROCESS | 10256 | 02:30:19 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:30:20 INFO - PROCESS | 10256 | RSS: Main: 164777984 02:30:20 INFO - PROCESS | 10256 | 02:30:22 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:30:23 INFO - PROCESS | 10256 | RSS: Main: 165179392 02:30:23 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | Cycle 1(1): loaded http://localhost:50813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50813/tests/kraken/driver.html?testName=ai-astar) 02:30:25 INFO - PROCESS | 10256 | RSS: Main: 165969920 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | __start_tp_report 02:30:25 INFO - PROCESS | 10256 | _x_x_mozilla_page_load 02:30:25 INFO - PROCESS | 10256 | _x_x_mozilla_page_load_details 02:30:25 INFO - PROCESS | 10256 | |i|pagename|runs| 02:30:25 INFO - PROCESS | 10256 | |0;ai-astar;104;116;109;112;115;114;118;112;112;112 02:30:25 INFO - PROCESS | 10256 | |1;audio-beat-detection;149;124;149;190;121;149;151;121;178;123 02:30:25 INFO - PROCESS | 10256 | |2;audio-dft;162;168;164;165;165;179;165;163;163;163 02:30:25 INFO - PROCESS | 10256 | |3;audio-fft;74;77;77;199;76;76;75;76;167;77 02:30:25 INFO - PROCESS | 10256 | |4;audio-oscillator;85;86;144;85;85;85;147;88;85;150 02:30:25 INFO - PROCESS | 10256 | |5;imaging-gaussian-blur;117;117;118;117;117;117;118;117;118;118 02:30:25 INFO - PROCESS | 10256 | |6;imaging-darkroom;150;146;148;147;146;152;148;147;147;147 02:30:25 INFO - PROCESS | 10256 | |7;imaging-desaturate;98;96;95;95;96;96;96;98;96;95 02:30:25 INFO - PROCESS | 10256 | |8;json-parse-financial;52;52;57;54;55;59;54;59;56;57 02:30:25 INFO - PROCESS | 10256 | |9;json-stringify-tinderbox;61;63;63;63;67;62;63;64;62;63 02:30:25 INFO - PROCESS | 10256 | |10;stanford-crypto-aes;92;85;87;79;89;79;83;79;79;77 02:30:25 INFO - PROCESS | 10256 | |11;stanford-crypto-ccm;132;135;128;125;129;126;124;131;141;125 02:30:25 INFO - PROCESS | 10256 | |12;stanford-crypto-pbkdf2;169;166;162;166;182;161;164;162;163;161 02:30:25 INFO - PROCESS | 10256 | |13;stanford-crypto-sha256-iterative;64;64;66;67;65;64;65;64;65;64 02:30:25 INFO - PROCESS | 10256 | __end_tp_report 02:30:25 INFO - PROCESS | 10256 | __start_cc_report 02:30:25 INFO - PROCESS | 10256 | _x_x_mozilla_cycle_collect,845 02:30:25 INFO - PROCESS | 10256 | __end_cc_report 02:30:25 INFO - PROCESS | 10256 | __startTimestamp1471080625398__endTimestamp 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | ------- Summary: start ------- 02:30:25 INFO - PROCESS | 10256 | Number of tests: 14 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:3.89 (3.4%) stddev-sans-first:2.69 02:30:25 INFO - PROCESS | 10256 | Values: 104.0 116.0 109.0 112.0 115.0 114.0 118.0 112.0 112.0 112.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:149.00 stddev:24.20 (16.2%) stddev-sans-first:25.64 02:30:25 INFO - PROCESS | 10256 | Values: 149.0 124.0 149.0 190.0 121.0 149.0 151.0 121.0 178.0 123.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.00 stddev:4.97 (3.0%) stddev-sans-first:5.09 02:30:25 INFO - PROCESS | 10256 | Values: 162.0 168.0 164.0 165.0 165.0 179.0 165.0 163.0 163.0 163.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#3] audio-fft Cycles:10 Average:97.40 Median:76.00 stddev:45.75 (60.2%) stddev-sans-first:47.74 02:30:25 INFO - PROCESS | 10256 | Values: 74.0 77.0 77.0 199.0 76.0 76.0 75.0 76.0 167.0 77.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:85.00 stddev:29.72 (35.0%) stddev-sans-first:30.72 02:30:25 INFO - PROCESS | 10256 | Values: 85.0 86.0 144.0 85.0 85.0 85.0 147.0 88.0 85.0 150.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:30:25 INFO - PROCESS | 10256 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:1.87 (1.3%) stddev-sans-first:1.81 02:30:25 INFO - PROCESS | 10256 | Values: 150.0 146.0 148.0 147.0 146.0 152.0 148.0 147.0 147.0 147.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.10 (1.1%) stddev-sans-first:0.93 02:30:25 INFO - PROCESS | 10256 | Values: 98.0 96.0 95.0 95.0 96.0 96.0 96.0 98.0 96.0 95.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.50 stddev:2.55 (4.5%) stddev-sans-first:2.37 02:30:25 INFO - PROCESS | 10256 | Values: 52.0 52.0 57.0 54.0 55.0 59.0 54.0 59.0 56.0 57.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:1.60 (2.5%) stddev-sans-first:1.50 02:30:25 INFO - PROCESS | 10256 | Values: 61.0 63.0 63.0 63.0 67.0 62.0 63.0 64.0 62.0 63.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:84.00 stddev:5.13 (6.1%) stddev-sans-first:4.26 02:30:25 INFO - PROCESS | 10256 | Values: 92.0 85.0 87.0 79.0 89.0 79.0 83.0 79.0 79.0 77.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:130.00 stddev:5.34 (4.1%) stddev-sans-first:5.59 02:30:25 INFO - PROCESS | 10256 | Values: 132.0 135.0 128.0 125.0 129.0 126.0 124.0 131.0 141.0 125.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:165.00 stddev:6.31 (3.8%) stddev-sans-first:6.57 02:30:25 INFO - PROCESS | 10256 | Values: 169.0 166.0 162.0 166.0 182.0 161.0 164.0 162.0 163.0 161.0 02:30:25 INFO - PROCESS | 10256 | 02:30:25 INFO - PROCESS | 10256 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 02:30:25 INFO - PROCESS | 10256 | Values: 64.0 64.0 66.0 67.0 65.0 64.0 65.0 64.0 65.0 64.0 02:30:25 INFO - PROCESS | 10256 | -------- Summary: end -------- 02:30:25 INFO - PROCESS | 10256 | 02:30:26 INFO - TEST-INFO | 10256: exit 0 02:30:26 INFO - TEST-OK | kraken | took 61856ms 02:30:26 INFO - SUITE-END | took 1174s 02:30:26 INFO - Completed test suite (00:19:34) 02:30:26 INFO - javascript benchmark 02:30:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7369.394549910391, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.1272043827726, 3130.8121512709254, 3135.6394014688317, 3149.795263307885, 3170.682931706828, 5370.462953704628, 5448.42791506892, 5468.906218756245, 5471.972640136799, 5535.6955367454775, 5392.083345831208, 5448.101063324547, 5471.206675032118, 5472.151816468444, 5473.753681084351, 4984.426790919046, 5004.599632029429, 5044.646874718771, 5060.54455099041, 5061.316722242505, 4951.77717002734, 5076.263941728447, 5095.847124586268, 5104.821331253407, 5132.435432102466, 4993.328770967598, 5105.591552675777, 5203.1414816555225, 5217.269582258468, 5225.346831646044, 4938.1111399947995, 5026.773795179226, 5031.22016087507, 5067.619928505377, 5081.415637201732, 4866.343043689092, 4912.066707325633, 4946.480619534969, 4976.104301225778, 4990.076835785391, 5400.540954018913, 5422.647527910713, 5431.022415965124, 5434.510894019557, 5511.669299842022, 5706.3722990471015, 5786.768529258825, 5791.276090488689, 5838.5329173666005, 5839.357670656224, 5855.4144585541535, 5934.940650593525, 5937.376575459601, 5958.374370691102, 5966.820995370146, 5495.587830912697, 5499.7250137492965, 5512.972435137799, 5519.668819870821, 5523.917141242925, 5887.735051922674, 5918.260217472816, 6047.909281360783, 6048.848778780478, 6068.059450785136, 5716.456936591017, 5770.047942089508, 5782.045962416154, 5808.012637851575, 5822.388649191858, 5843.707814609253, 5850.970745146247, 5852.882942341129, 5862.648241105548, 5866.325372582122, 5566.832995010156, 5795.652260864362, 5800.1299805029585, 5821.359650438449, 5827.854303642443, 5617.269754931833, 5768.7692492300675, 5815.302163740378, 5919.319278283053, 5950.583459157904, 4496.887577810516, 4511.932321015187, 4523.32150177476, 4546.909061818745, 4560.042391097841, 3994.201159768058, 4009.699272554512, 4016.0763024504527, 4017.678585713136, 4041.535223449282, 5338.3593968724, 5459.754311056012, 5526.0, 5543.916841247304, 5550.72246387679, 5919.6744179070565, 5975.910361344583, 5984.581079324405, 5991.221141251609, 6020.638761674313, 5535.086710692771, 5577.972110139423, 5579.804706835242, 5581.581381396411, 5595.160725891067, 4894.070126675992, 5032.84901452957, 5060.139776237975, 5065.11360511909, 5076.466970968069, 6206.751729930752, 6217.409346112112, 6221.844453888689, 6232.345603711636, 6233.625982441068, 5962.07587823888, 5968.970155149196, 5970.0, 5998.730057147526, 6048.0625503047095, 6008.789692360747, 6041.909371359346, 6081.179040829608, 6120.540959427972, 6188.319284878749, 5778.27771528559, 5803.680797556175, 5816.331121921034, 5847.678377689268, 5848.824535263949, 5877.706114694162, 5931.970340148272, 5944.405559444021, 5952.404759524013, 5965.552583556164, 5624.521915637053, 5709.600327977168, 5767.250257466502, 5788.681622510802, 5792.94207057924, 5792.0, 5805.245318108618, 5808.332041815245, 5811.76752929895, 5838.795642152504, 5714.485696287354, 5727.0, 5736.225609542826, 5741.25363702716, 5746.885062298647, 5617.719114044363, 5677.1768093627015, 5722.198892155185, 5733.71331433435, 5824.592278540631, 5592.69240191777, 5633.8309850704545, 5646.9152962704775, 5659.349174844946, 5663.7451314690115], "value": 5425.185234114467, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.1559315602641, 581.1631250998562, 583.0991118721574, 592.7747455966733, 602.8966990407555, 40725.59274407255, 44517.332240016425, 44520.777396113015, 44683.0, 44755.999999999956, 44327.77836110823, 44991.55008449915, 45008.54991450084, 45026.0, 45033.774831125884, 8847.601857916408, 8889.244414224799, 8926.419782714136, 8940.06129356418, 8966.551672416386, 8736.912630873705, 8870.645174193025, 8873.29013678904, 8898.59956301968, 8909.1536304051, 8894.688685895995, 8896.243819275336, 8907.198352148305, 8921.10788921106, 8965.372423930328, 8837.558122093933, 8852.734417967471, 8897.911020889773, 8903.955480222623, 8906.554672266393, 8701.869471957925, 8773.736787896374, 8806.86789698155, 8839.69061082859, 8844.690435834715, 41951.790241048904, 42443.36334954978, 42445.0, 42495.900491940854, 42542.57457425417, 3437.089171369564, 3571.6606922342335, 3591.0, 3747.381682022463, 3948.1314110895846, 33014.6698533014, 33332.3333533328, 33394.1651458713, 33398.666013339796, 33563.328733425195, 4313.870583882457, 4393.121375724836, 4467.687261891669, 4477.462704475483, 4547.909041819145, 360973.0, 362532.0, 363380.0, 364124.0, 364982.1750891255, 56885.715571421875, 57291.71354143203, 57434.7128264356, 57450.712746436, 57595.42404575984, 36906.0, 37749.81125094412, 37888.0, 39364.40953385702, 39383.21233575312, 15861.762073568905, 15876.126813025394, 15939.203039847962, 15970.76043859343, 15992.280347384396, 12890.0, 12933.741325173443, 12935.417906194056, 12973.221606703628, 12988.675283117998, 18996.14517346695, 19214.231430742893, 19232.23071077141, 19271.807281927282, 19337.709934350994, 6621.271660117383, 6899.413549848218, 6946.7221311148, 6963.651817409109, 6999.650017499104, 892.4689809563299, 914.3005600715458, 1042.7393151712072, 1075.5321435175724, 1076.7469644633504, 31588.842055789573, 31677.683223167933, 31730.682693173236, 31900.680993190235, 31968.200794979846, 1097.780443911221, 1106.3583121789343, 1153.3310679805693, 1160.988390116105, 1161.3902701081831, 16574.337026518806, 16685.24916378766, 16797.0, 16910.74633880493, 17073.49685777518, 548941.0, 551826.0, 554250.0, 556110.0, 559099.0, 59063.704681476316, 59499.40500594939, 59793.40206597965, 59879.700601497585, 59914.40085599088, 1246.0, 1294.6698591859204, 1314.8619394963391, 1319.5843309357713, 1363.6113707593486, 30775.692243077283, 31188.68811311858, 32090.518642220854, 32554.0, 33341.83329083436, 51567.226491601905, 52154.21768673549, 52371.47628523666, 52434.21348679849, 52439.0, 513200.0, 514395.0, 516327.0, 516882.0, 517968.0, 29138.0, 29264.853675731487, 29372.55941160927, 29431.705682942895, 29790.553141702458, 49048.75475622599, 49133.2630010543, 50002.24996624981, 50068.749656251486, 50587.0, 41173.588264118174, 41231.1753764917, 42779.786101069294, 43455.46868381889, 44039.0, 42432.15135697331, 42696.78651606722, 42834.143317134105, 43358.0, 43579.56420435755, 34538.48192277168, 41572.0, 41824.79087604542, 41944.1611167781, 42774.358384623636, 36171.819140904125, 37343.62656373402, 38064.80967595255, 38765.41851872168, 38996.63511777074, 29108.0, 29729.027097290098, 30031.0, 30087.849560752056, 30097.0], "value": 20137.390746328314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.47071160001394, 401.8955071681362, 403.88893054410033, 417.9059711564897, 423.33113680385, 14243.928780356084, 18812.811871881277, 19738.605227895434, 20407.795922040776, 20536.89731551342, 19556.608867822633, 19684.11421486033, 19699.507512312164, 19799.0, 19897.50256243591, 5648.795726096083, 5831.504322132624, 5930.525557955375, 5967.910481342783, 5968.79109231177, 5688.175214593882, 5850.561207909403, 5893.941060589382, 5922.0, 5926.644401335933, 5801.767929282823, 5805.216295800076, 5812.912806307909, 5818.359980402152, 5850.912236316459, 5789.2763404574425, 5798.942010579904, 5833.416658334175, 5844.123381492767, 6005.1892994445625, 5898.528117750569, 5917.8816423671715, 5923.141144534062, 5933.851653708649, 5964.343922168558, 13941.469022567604, 21452.678209826867, 22343.55312893733, 22887.54224915509, 24553.263402097964, 2141.2291575032978, 2461.913833015854, 2502.2368177705794, 2570.2674737699667, 3003.6996300369788, 10246.795064098676, 10267.7433064174, 10457.111145552637, 10603.310784798963, 11254.549818007352, 1971.5859669469428, 1996.9715596467831, 2007.1770574064562, 2035.3385149826365, 2052.3124753207694, 84859.15140848575, 85365.57317213436, 85618.5719071407, 85622.57188714079, 86779.13220867774, 11308.434578271053, 11431.885681143249, 11695.356755378536, 11701.356425396514, 11864.347460889561, 15668.37326506927, 15672.216389180496, 15778.368865245491, 15802.762958555631, 15839.920800395925, 8206.0, 8362.749117526484, 8370.246677799027, 8532.829343413221, 8616.138386161334, 7939.880901786478, 8126.715564955198, 8289.58552072394, 8484.36367272457, 8525.31797456202, 4629.0, 4746.95253047472, 4785.904281914342, 4801.207800712843, 5017.172166592544, 1985.5253306713253, 1988.1450976080425, 1988.5540784834734, 1992.85053620979, 2066.73132492775, 956.4978386347224, 1076.8516808966006, 1080.9244801422478, 1098.368438148052, 1128.503458478267, 19498.61002779965, 19618.411447656592, 19732.50668733293, 19843.107060182327, 20030.0, 981.4503877828439, 1000.6847842929454, 1009.4094954451728, 1009.9293049486612, 1038.901304376083, 10308.278420510642, 10967.561297548169, 10986.945065274622, 11054.944725276322, 11202.551897924155, 512384.0, 515122.0, 524523.0, 527799.0, 532193.0, 74963.62518187483, 91365.0, 101539.0, 105720.47139764253, 108047.0, 995.3576598612348, 1004.4626125023224, 1023.9897601023895, 1035.6064695415694, 1036.3522798251092, 17806.46580602584, 17846.19692113832, 18220.81779182191, 18521.9073904635, 18850.434486965412, 31126.688733113286, 34969.82515087408, 43094.13811723811, 44382.3342649867, 44458.0, 60508.0, 61765.691171543855, 63218.683906580176, 63748.36251637424, 63880.0, 8608.698695545876, 8661.42910587355, 8704.651813927625, 8741.825163496822, 8875.334349923653, 12841.614751557468, 13251.777781109125, 13324.133931294435, 13381.799273010718, 13661.726765464437, 10892.18308626872, 11535.884641153481, 11897.881021189678, 12431.689207769878, 12792.552260671204, 11511.0, 11511.136664750346, 11788.23376480526, 12049.457774399998, 12476.5009399623, 12242.87757122453, 12252.571160009356, 12476.937615311865, 12673.429695663533, 12901.935490322488, 8686.131386861263, 8704.477731336141, 8709.303255739653, 8738.825223495622, 9103.817923641622, 11092.445377731243, 11845.52617895309, 11892.821607676065, 11905.761884762429, 12360.876391235972], "value": 9475.189156368735, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.282110355374, 1464.560631810457, 1582.7704982777498, 1718.6734520441123, 1733.4193045329814, 7296.890546641805, 8401.28589069929, 8524.0, 9110.271178305737, 9131.36080474367, 8603.311735061196, 8963.686270980517, 8967.058458861808, 8992.730218093451, 9004.324675649335, 2418.2986933789225, 2442.9144979925704, 2444.7555244475498, 2447.902083916641, 2448.485817978227, 2393.4375421775867, 2417.359399759065, 2448.6571879936823, 2450.9264722058365, 2460.9753902461016, 2387.0451819272257, 2392.461696118377, 2428.732839387666, 2439.3901524618846, 2440.3655049687122, 2361.397843549884, 2379.9286021419384, 2383.261189031397, 2383.3088404362716, 2385.7017872765905, 2306.3657494189233, 2321.7330007049068, 2333.696619439462, 2337.520808234308, 2349.5888219561507, 8949.731508054769, 9025.05236950124, 9041.141091596288, 9045.140711632384, 9056.0, 5249.0, 5336.839894803162, 5375.086235340002, 5454.727263636842, 5455.18172274158, 3504.106452854531, 3580.230250496156, 3587.4798154267746, 3588.910277243064, 3591.2458383739445, 1142.5144313666658, 1164.5341863254766, 1166.854143232096, 1200.963971080869, 1213.7087099096154, 12069.879301206964, 12101.334426606532, 12107.757844843141, 12205.267683938991, 12234.632961011184, 4476.843310484118, 4553.954460455419, 4725.362076119749, 4762.047590481918, 4803.159447096744, 10292.176625869912, 10431.321964072462, 10447.425391603534, 10463.319884207502, 10472.214583906238, 5354.0, 5380.3274590676165, 5429.837104886859, 5438.83683489496, 5440.238366628675, 4183.142455796555, 4865.099956508057, 4885.071836351082, 4925.236588328815, 4997.500249975046, 4011.9598804011584, 4064.4919385076864, 4070.430139780433, 4217.641500472433, 4220.366944958281, 1329.6011196640968, 1336.211635135275, 1352.4454973460834, 1357.945682172702, 1361.7957306404119, 986.2504496582505, 1013.9087482126644, 1031.5718976624767, 1032.829583118777, 1034.6482196053228, 5876.0, 6043.214382130295, 6139.079138129227, 6190.473809726223, 6207.689615519296, 467.34104912073815, 480.4066977283053, 481.5232919409829, 482.52230292010654, 483.7774623673079, 4201.432806571073, 4262.104957958863, 4267.97866010668, 4278.657707383464, 4332.415123958288, 10608.840867386996, 11075.224734268684, 11083.168762342695, 11099.44502774858, 11131.888681113085, 10944.56221751137, 10980.341179529254, 10980.835287470694, 11016.944915275373, 11025.558977640805, 7814.4529882907655, 8104.797380065427, 8118.634661440249, 8222.437736830103, 8327.458715183615, 6243.282022567281, 6364.936350636434, 6483.805485835433, 6501.577397469149, 6576.145101136822, 10024.849627255451, 10096.141827944706, 10274.897251027394, 10390.792184156124, 10544.15646748243, 10160.949195253976, 10290.742731431475, 10304.948475257575, 10401.323913945569, 10500.317479363817, 7034.577925324497, 7826.960865195865, 7887.84224315499, 7893.763187104396, 8012.879806802786, 8598.570071496526, 8672.089430609947, 8750.212480876497, 8758.91241087581, 8772.38593298463, 7696.923030769844, 7717.652705628372, 7744.535327880345, 7904.288614024766, 8054.597270136353, 7659.808504787202, 7811.765647030598, 7869.0950540688555, 7911.802204944923, 7947.284744372803, 6951.409130223988, 7045.577265364094, 7092.893606596009, 7094.64526773649, 7107.609081500567, 5517.393086760373, 5572.526335261548, 5572.665640061609, 5619.157126431068, 5699.8860022800145, 5561.6663000220115, 5569.470900264469, 5637.46444087811, 5642.830715078554, 5693.174489699053], "value": 4674.700770738392, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.3769869987273, 342.5649425229958, 346.74860725973673, 347.15987310708084, 347.52042181789125, 5500.624843789053, 5588.413216612258, 5589.7205139743055, 5622.662640241589, 5635.915461268084, 5512.5589952803775, 5519.724013799314, 5552.805651802188, 5554.166874968757, 5575.609707320489, 4116.34138537834, 4222.9788851055855, 4318.956810431902, 4334.739915605058, 4376.19040477511, 4332.808477668635, 4341.176705783562, 4348.30427131659, 4357.3899654048455, 4359.891002724926, 4322.330038843984, 4336.718113322624, 4338.262495375778, 4342.3052311630145, 4373.0, 4242.753749694484, 4250.193667691235, 4275.230458517465, 4314.848980285675, 4319.244132276839, 3818.8663396781258, 3822.923541529182, 3824.4836947012354, 3828.3491806392703, 3845.5000849889616, 5336.199570064483, 5372.650777699437, 5388.030154572176, 5389.766140315779, 5409.702466364349, 4838.685485443435, 4847.224444088964, 4908.141075311842, 4929.433115191763, 4949.232868905326, 5681.375048744635, 5683.261176047129, 5687.516561092312, 5734.655920644733, 5771.249737534135, 4169.312063509517, 4189.560096189917, 4198.769067701275, 4199.853005144836, 4200.789960501963, 5769.769209231626, 5917.863532327873, 5924.377940316248, 5968.97015514924, 6030.66831324277, 4256.4679415073115, 4259.403683484315, 4269.594388533084, 4271.957280427218, 4281.400603915455, 4330.480342358937, 4343.913121737548, 4353.194658988097, 4358.607725304674, 4360.4331436913, 4628.166929952641, 4842.806287748451, 4902.41171059468, 4924.285978533093, 4937.333459982857, 5687.175359572839, 5725.656460612377, 5739.885202295931, 5752.0, 5807.88384232313, 1451.354147404416, 1473.3296350160651, 1474.9410023598937, 1475.1960181701, 1478.209158100411, 940.05994005994, 947.4315410753493, 949.1220620925616, 951.8286708392556, 966.1932286540817, 4787.640926930494, 4809.667311353991, 4820.3492528508905, 4831.0, 4901.108346075833, 5212.739363031833, 5213.244079608436, 5216.66091704038, 5233.450487698813, 5276.709780962007, 4660.231061874752, 4704.458987216445, 4914.287428322873, 4925.630577706686, 4968.751562421864, 2741.821781584191, 2775.875085621152, 2786.1193694256294, 2792.7207279272316, 2817.21118086936, 5408.972955135199, 5415.48552887475, 5446.509814116748, 5472.671639701631, 5497.257870187554, 5195.272661827347, 5239.580833533309, 5287.4976877196605, 5307.858810355792, 5474.945250547523, 5321.3348331458565, 5374.516293533601, 5391.29913111293, 5413.891722165614, 5441.0, 5128.0, 5235.806158243392, 5239.973800130975, 5242.895142097213, 5253.185756207794, 4820.903581928412, 5181.637285389987, 5185.585153187812, 5185.611079169153, 5211.400688920671, 5447.346318441812, 5447.400785913625, 5467.6719396836315, 5484.546595152208, 5491.341039075336, 3866.9226615468096, 3875.1668391296007, 3880.8253628586217, 3887.9028024298486, 3897.3692757389217, 4954.504549545017, 5189.584833213409, 5214.817481388133, 5215.530602245816, 5232.215167724872, 5568.021108706823, 5623.268975033219, 5810.48927278919, 5813.3605303417435, 5816.731474724946, 5751.194832723339, 5786.884262314814, 5788.421157884178, 5837.1244313351635, 5906.291245050621, 5591.944080559142, 5626.465485778845, 5727.391743201756, 5785.4214578541805, 5799.8550036249435, 5712.171735098304, 5774.335951365647, 5801.82594522165, 5861.472467477947, 5868.5645457134815, 5706.28671416073, 5710.143478478261, 5735.885282294247, 5748.166515855094, 5760.251167348386], "value": 4236.630988501905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.1490942870414, 749.2619769527018, 780.1340512031647, 799.4164260090135, 814.3973459639865, 16372.508824735261, 17427.91286043571, 17682.11589420527, 17760.0, 17803.554911127227, 15691.60770980726, 15883.285252163652, 15928.442504512344, 15938.20308984552, 15992.200389980513, 650.0898741761548, 784.5763287824597, 798.5727635714879, 809.9109097999245, 823.7487566292278, 817.2930415190847, 819.2053707903324, 819.6516480495795, 821.708293555788, 822.042320696391, 855.6833971430548, 857.1642648417806, 857.1856736100698, 857.8627419612864, 859.6131740716671, 851.8764779107057, 853.1298075962515, 854.0477367734962, 855.7389996051202, 856.3662889461816, 623.4139908486009, 623.6227082614998, 626.0421555020826, 626.1421852062658, 626.5676683088654, 15348.07911525312, 15474.22628868552, 15481.380744770197, 15521.534353969399, 15562.299696513572, 16078.356865725356, 16191.676166476722, 16487.093209873452, 16764.66470670592, 17144.914275428542, 13198.802017969738, 13242.602721918358, 13299.867001330056, 13498.122622029538, 13633.454661813515, 3984.1633257015774, 4041.191761647653, 4086.856960006415, 4128.153728485683, 4239.448871646666, 72042.63978680073, 75425.24574754237, 75753.0, 82768.0, 82778.0, 11520.884791152148, 11530.481128349244, 11564.363959982282, 11805.881941180478, 11870.703232419086, 20266.392008239778, 20268.594628107356, 20280.290189843283, 20285.89857050705, 20354.79645203529, 9099.771530843384, 9205.539723013822, 9210.22380823859, 9244.3528952974, 9628.90371096294, 4715.104130215317, 4768.499307572724, 4806.639502037361, 4877.244027175793, 4908.092002979461, 3561.71506279497, 3655.7570426054735, 3691.3540130477595, 3691.6862066724093, 3703.166787472797, 644.6100109433819, 650.3269116464531, 654.8395643067479, 663.8074958262147, 665.870155319708, 610.3377835048933, 650.8828410885991, 676.4520738202073, 682.2836022176793, 715.1704023332909, 10064.345817521838, 10082.949585252027, 10159.4920253987, 10283.303254962848, 10556.577736890438, 591.6716222496556, 615.833724894285, 620.7058283478997, 640.5484133685741, 642.5662677692538, 4777.570018698334, 5093.9745301274, 5123.7438128093445, 5185.274061631375, 5192.61055420845, 117076.0, 130288.0, 135643.2524861625, 137730.0, 141728.29135854254, 113890.0, 117131.0, 117357.41321293339, 117608.0, 118442.0, 93131.0, 97929.5103524492, 97943.0, 100934.0, 103471.0, 9504.904950950402, 9639.421634701941, 9685.951570242103, 9692.369995950241, 10011.048950349705, 57168.0, 59054.11418828635, 59924.40075599188, 59967.60129594767, 62035.0, 75970.0, 76985.0, 84194.0, 87231.0, 89522.0, 11497.562804649418, 11796.52813887435, 11904.642860714192, 11909.0, 12624.116311858083, 13103.672408189872, 13138.73722525525, 13166.539171128965, 13167.47330106785, 13537.59387218385, 12897.50022310595, 13564.186148831102, 13583.592492225249, 14227.0, 14343.211123388313, 13390.0, 13735.931320343334, 14135.717285654435, 14741.705165896836, 14756.33596488182, 12162.087843411957, 12442.37788110609, 12640.115191936477, 12920.547780827626, 13539.11995720275, 10345.327553709287, 10630.149588033093, 10833.29583577065, 11233.101351891992, 11301.773964520828, 11392.487338069972, 11684.941575292409, 11842.76314473723, 11897.46461409256, 12167.513299467922], "value": 7812.065706043388, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 109.0, 112.0, 115.0, 114.0, 118.0, 112.0, 112.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 149.0, 190.0, 121.0, 149.0, 151.0, 121.0, 178.0, 123.0], "value": 145.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 164.0, 165.0, 165.0, 179.0, 165.0, 163.0, 163.0, 163.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 77.0, 199.0, 76.0, 76.0, 75.0, 76.0, 167.0, 77.0], "value": 97.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 144.0, 85.0, 85.0, 85.0, 147.0, 88.0, 85.0, 150.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 148.0, 147.0, 146.0, 152.0, 148.0, 147.0, 147.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 98.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 57.0, 54.0, 55.0, 59.0, 54.0, 59.0, 56.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 63.0, 67.0, 62.0, 63.0, 64.0, 62.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 85.0, 87.0, 79.0, 89.0, 79.0, 83.0, 79.0, 79.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 135.0, 128.0, 125.0, 129.0, 126.0, 124.0, 131.0, 141.0, 125.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 162.0, 166.0, 182.0, 161.0, 164.0, 162.0, 163.0, 161.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 67.0, 65.0, 64.0, 65.0, 64.0, 65.0, 64.0], "value": 64.8, "unit": "score"}]}]} 02:30:26 INFO - Return code: 0 02:30:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:30:26 ERROR - # TBPL SUCCESS # 02:30:26 INFO - Running post-action listener: _resource_record_post_action 02:30:26 INFO - [mozharness: 2016-08-13 09:30:26.716563Z] Finished run-tests step (success) 02:30:26 INFO - Running post-run listener: _resource_record_post_run 02:30:26 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 409509888; Read time: 128; Write time: 293520 02:30:26 INFO - TinderboxPrint: CPU usage
13.4% 02:30:26 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 128 02:30:26 INFO - TinderboxPrint: I/O write bytes / time
409,509,888 / 293,520 02:30:26 INFO - TinderboxPrint: CPU idle
8,238.6 (86.6%) 02:30:26 INFO - TinderboxPrint: CPU user
1,214.4 (12.8%) 02:30:26 INFO - TinderboxPrint: Swap in / out
0 / 0 02:30:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117157888; Read time: 0; Write time: 71308 02:30:26 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291008512; Read time: 92; Write time: 222144 02:30:27 INFO - Running post-run listener: _upload_blobber_files 02:30:27 INFO - Blob upload gear active. 02:30:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:30:27 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 02:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:30:27 INFO - (blobuploader) - INFO - Open directory for files ... 02:30:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:30:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:30:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:29 INFO - (blobuploader) - INFO - Done attempting. 02:30:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:30:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:40 INFO - (blobuploader) - INFO - Done attempting. 02:30:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:30:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:30:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:40 INFO - (blobuploader) - INFO - Done attempting. 02:30:40 INFO - (blobuploader) - INFO - Iteration through files over. 02:30:40 INFO - Return code: 0 02:30:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:30:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:30:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5180dfc7400c181e4f665bf696bcd0c8a002a0f780bbfd4a8c33c41a82bd17b4aea8259b11163c21c5409135f3a1af28f47d40b23c1155e3a0029ea545393277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/459571ed97bd765a2b1a7ad527089017096cd28d80b27c44934658e54ca7ff280cb48d3c3f9fd856c7e449fc0a5c7548b7d641373b3e0d8714ef55228bc65444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53b321f61fc32a5468dd50f30f0c6206b5d2370305e1ce49efebf7afa5e4b1ed9bdbf39b1bd3c7dbc51cb7c45ee218a9a2f9d4f9b97f411788680a744f49f12c"} 02:30:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:30:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:30:40 INFO - Contents: 02:30:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5180dfc7400c181e4f665bf696bcd0c8a002a0f780bbfd4a8c33c41a82bd17b4aea8259b11163c21c5409135f3a1af28f47d40b23c1155e3a0029ea545393277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/459571ed97bd765a2b1a7ad527089017096cd28d80b27c44934658e54ca7ff280cb48d3c3f9fd856c7e449fc0a5c7548b7d641373b3e0d8714ef55228bc65444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53b321f61fc32a5468dd50f30f0c6206b5d2370305e1ce49efebf7afa5e4b1ed9bdbf39b1bd3c7dbc51cb7c45ee218a9a2f9d4f9b97f411788680a744f49f12c"} 02:30:40 INFO - Running post-run listener: copy_logs_to_upload_dir 02:30:40 INFO - Copying logs to upload dir... 02:30:40 INFO - mkdir: /builds/slave/test/build/upload/logs 02:30:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.971875 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-13 02:30:40.141821) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 02:30:40.146208) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5180dfc7400c181e4f665bf696bcd0c8a002a0f780bbfd4a8c33c41a82bd17b4aea8259b11163c21c5409135f3a1af28f47d40b23c1155e3a0029ea545393277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/459571ed97bd765a2b1a7ad527089017096cd28d80b27c44934658e54ca7ff280cb48d3c3f9fd856c7e449fc0a5c7548b7d641373b3e0d8714ef55228bc65444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53b321f61fc32a5468dd50f30f0c6206b5d2370305e1ce49efebf7afa5e4b1ed9bdbf39b1bd3c7dbc51cb7c45ee218a9a2f9d4f9b97f411788680a744f49f12c"} build_url:https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/CgoxjBJ8Q0-ZMc5fZT7_YQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5180dfc7400c181e4f665bf696bcd0c8a002a0f780bbfd4a8c33c41a82bd17b4aea8259b11163c21c5409135f3a1af28f47d40b23c1155e3a0029ea545393277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/459571ed97bd765a2b1a7ad527089017096cd28d80b27c44934658e54ca7ff280cb48d3c3f9fd856c7e449fc0a5c7548b7d641373b3e0d8714ef55228bc65444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53b321f61fc32a5468dd50f30f0c6206b5d2370305e1ce49efebf7afa5e4b1ed9bdbf39b1bd3c7dbc51cb7c45ee218a9a2f9d4f9b97f411788680a744f49f12c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 02:30:40.179785) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 02:30:40.180110) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1471077847.56463-882667324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 02:30:40.260630) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 02:30:40.261303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 02:30:40.261865) ========= ========= Total master_lag: 0.17 =========