builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1472188883.29 results: success (0) buildid: 20160825221426 builduid: 9db28823343141da86cdc9acef219e3a revision: 57dd530675399cb159844ceb53ce514fc129f8ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 22:21:23.286907) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 22:21:23.287363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 22:21:23.287636) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 22:21:23.302477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 22:21:23.302792) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 22:21:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.6M=0s 2016-08-25 22:21:23 (50.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109803 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 22:21:23.427786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 22:21:23.428112) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015774 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 22:21:23.479824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-25 22:21:23.480685) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 57dd530675399cb159844ceb53ce514fc129f8ed --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 57dd530675399cb159844ceb53ce514fc129f8ed --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=05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 22:21:24,101 truncating revision to first 12 chars 2016-08-25 22:21:24,101 Setting DEBUG logging. 2016-08-25 22:21:24,101 attempt 1/10 2016-08-25 22:21:24,101 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/57dd53067539?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 22:21:24,956 unpacking tar archive at: mozilla-inbound-57dd53067539/testing/mozharness/ program finished with exit code 0 elapsedTime=1.247384 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-25 22:21:24.742927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 22:21:24.743349) ========= script_repo_revision: 57dd530675399cb159844ceb53ce514fc129f8ed ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 22:21:24.743859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 22:21:24.744188) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 22:21:24.754100) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-25 22:21:24.754555) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:21:25 INFO - MultiFileLogger online at 20160825 22:21:25 in /builds/slave/test 22:21:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:21:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:21:25 INFO - {'append_to_log': False, 22:21:25 INFO - 'base_work_dir': '/builds/slave/test', 22:21:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:21:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:21:25 INFO - 'branch': 'Mozilla-Inbound', 22:21:25 INFO - 'buildbot_json_path': 'buildprops.json', 22:21:25 INFO - 'config_files': ('talos/linux_config.py',), 22:21:25 INFO - 'default_actions': ('clobber', 22:21:25 INFO - 'read-buildbot-config', 22:21:25 INFO - 'download-and-extract', 22:21:25 INFO - 'populate-webroot', 22:21:25 INFO - 'create-virtualenv', 22:21:25 INFO - 'install', 22:21:25 INFO - 'run-tests'), 22:21:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:21:25 INFO - 'download_minidump_stackwalk': True, 22:21:25 INFO - 'download_symbols': 'ondemand', 22:21:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:21:25 INFO - 'tooltool.py': '/tools/tooltool.py', 22:21:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:21:25 INFO - '/tools/misc-python/virtualenv.py')}, 22:21:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:21:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:21:25 INFO - 'installer_path': 'installer.exe', 22:21:25 INFO - 'log_level': 'info', 22:21:25 INFO - 'log_name': 'talos', 22:21:25 INFO - 'log_to_console': True, 22:21:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:21:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:21:25 INFO - 'opt_config_files': (), 22:21:25 INFO - 'pip_index': False, 22:21:25 INFO - 'sps_profile': False, 22:21:25 INFO - 'sps_profile_interval': 0, 22:21:25 INFO - 'suite': 'dromaeojs-e10s', 22:21:25 INFO - 'system_bits': '32', 22:21:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:21:25 INFO - 'title': 'talos-linux64-ix-069', 22:21:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:21:25 INFO - 'use_talos_json': True, 22:21:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:21:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:21:25 INFO - 'work_dir': 'build'} 22:21:25 INFO - [mozharness: 2016-08-26 05:21:25.472156Z] Running clobber step. 22:21:25 INFO - Running pre-action listener: _resource_record_pre_action 22:21:25 INFO - Running main action method: clobber 22:21:25 INFO - rmtree: /builds/slave/test/build 22:21:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:21:25 INFO - Running post-action listener: _resource_record_post_action 22:21:25 INFO - [mozharness: 2016-08-26 05:21:25.929547Z] Finished clobber step (success) 22:21:25 INFO - [mozharness: 2016-08-26 05:21:25.929648Z] Running read-buildbot-config step. 22:21:25 INFO - Running pre-action listener: _resource_record_pre_action 22:21:25 INFO - Running main action method: read_buildbot_config 22:21:25 INFO - Using buildbot properties: 22:21:25 INFO - { 22:21:25 INFO - "project": "", 22:21:25 INFO - "product": "firefox", 22:21:25 INFO - "script_repo_revision": "production", 22:21:25 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:21:25 INFO - "repository": "", 22:21:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:21:25 INFO - "buildid": "20160825221426", 22:21:25 INFO - "stage_platform": "linux64-pgo", 22:21:25 INFO - "basedir": "/builds/slave/test", 22:21:25 INFO - "buildnumber": 1068, 22:21:25 INFO - "platform": "ubuntu64_hw", 22:21:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:21:25 INFO - "slavebuilddir": "test", 22:21:25 INFO - "branch": "mozilla-inbound", 22:21:25 INFO - "revision": "57dd530675399cb159844ceb53ce514fc129f8ed", 22:21:25 INFO - "slavename": "talos-linux64-ix-069", 22:21:25 INFO - "builduid": "9db28823343141da86cdc9acef219e3a", 22:21:25 INFO - "repo_path": "integration/mozilla-inbound" 22:21:25 INFO - } 22:21:25 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 22:21:25 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 22:21:25 INFO - Running post-action listener: _resource_record_post_action 22:21:25 INFO - [mozharness: 2016-08-26 05:21:25.931996Z] Finished read-buildbot-config step (success) 22:21:25 INFO - [mozharness: 2016-08-26 05:21:25.932083Z] Running download-and-extract step. 22:21:25 INFO - Running pre-action listener: _resource_record_pre_action 22:21:25 INFO - Running main action method: download_and_extract 22:21:25 INFO - mkdir: /builds/slave/test/build/tests 22:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:25 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:21:25 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/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 22:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/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 22:21:25 INFO - Downloaded 1361 bytes. 22:21:25 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:21:25 INFO - Using the following test package requirements: 22:21:25 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:21:25 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:21:25 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:21:25 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:25 INFO - u'jsshell-linux-x86_64.zip'], 22:21:25 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:21:25 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:21:25 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:21:25 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:21:25 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:21:25 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:21:25 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:25 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:21:25 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/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 22:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/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 22:21:26 INFO - Downloaded 21873399 bytes. 22:21:26 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 22:21:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:21: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')]} 22:21:30 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:21:30 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/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 22:21:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/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 22:21:30 INFO - Downloaded 21873399 bytes. 22:21:30 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 22:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:35 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:21:35 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/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 22:21:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/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 22:21:35 INFO - Downloaded 14413981 bytes. 22:21:35 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 22:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:21:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/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 22:21:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/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 22:21:36 INFO - Downloaded 59747273 bytes. 22:21:36 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:21:36 INFO - mkdir: /builds/slave/test/properties 22:21:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:21:36 INFO - Writing to file /builds/slave/test/properties/build_url 22:21:36 INFO - Contents: 22:21:36 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:21:37 INFO - Running post-action listener: _resource_record_post_action 22:21:37 INFO - Running post-action listener: set_extra_try_arguments 22:21:37 INFO - [mozharness: 2016-08-26 05:21:37.196812Z] Finished download-and-extract step (success) 22:21:37 INFO - [mozharness: 2016-08-26 05:21:37.197036Z] Running populate-webroot step. 22:21:37 INFO - Running pre-action listener: _resource_record_pre_action 22:21:37 INFO - Running main action method: populate_webroot 22:21:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:21:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:21:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:21:37 INFO - '--tppagecycles', 22:21:37 INFO - '7'], 22:21:37 INFO - 'tests': ['tsvgm']}}, 22:21:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:21:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:21:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:21:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:21:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:21:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:21:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:21:37 INFO - 'talos_options': ['--disable-e10s'], 22:21:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:21:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:21:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:21:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:21:37 INFO - 'talos_options': ['--disable-e10s'], 22:21:37 INFO - 'tests': ['damp', 'tps']}, 22:21:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:21:37 INFO - 'tests': ['damp', 'tps']}, 22:21:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:21:37 INFO - 'tests': ['dromaeo_dom']}, 22:21:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:21:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:21:37 INFO - 'tests': ['basic_compositor_video']}, 22:21:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:21:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:21:37 INFO - 'tests': ['a11yr', 22:21:37 INFO - 'ts_paint', 22:21:37 INFO - 'tpaint', 22:21:37 INFO - 'sessionrestore', 22:21:37 INFO - 'sessionrestore_no_auto_restore', 22:21:37 INFO - 'tabpaint']}, 22:21:37 INFO - 'other-e10s': {'tests': ['a11yr', 22:21:37 INFO - 'ts_paint', 22:21:37 INFO - 'tpaint', 22:21:37 INFO - 'sessionrestore', 22:21:37 INFO - 'sessionrestore_no_auto_restore', 22:21:37 INFO - 'tabpaint']}, 22:21:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:21:37 INFO - 'ts_paint', 22:21:37 INFO - 'tpaint', 22:21:37 INFO - 'sessionrestore', 22:21:37 INFO - 'sessionrestore_no_auto_restore', 22:21:37 INFO - 'tabpaint']}, 22:21:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:21:37 INFO - 'ts_paint', 22:21:37 INFO - 'tpaint', 22:21:37 INFO - 'sessionrestore', 22:21:37 INFO - 'sessionrestore_no_auto_restore', 22:21:37 INFO - 'tabpaint']}, 22:21:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:21:37 INFO - 'tests': ['a11yr', 22:21:37 INFO - 'ts_paint', 22:21:37 INFO - 'tpaint', 22:21:37 INFO - 'sessionrestore', 22:21:37 INFO - 'sessionrestore_no_auto_restore', 22:21:37 INFO - 'tabpaint']}, 22:21:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:21:37 INFO - 'tests': ['a11yr', 22:21:37 INFO - 'ts_paint', 22:21:37 INFO - 'tpaint', 22:21:37 INFO - 'sessionrestore', 22:21:37 INFO - 'sessionrestore_no_auto_restore', 22:21:37 INFO - 'tabpaint']}, 22:21:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:21:37 INFO - 'tests': ['tsvgx', 22:21:37 INFO - 'tsvgr_opacity', 22:21:37 INFO - 'tart', 22:21:37 INFO - 'tscrollx', 22:21:37 INFO - 'cart']}, 22:21:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:21:37 INFO - 'tsvgr_opacity', 22:21:37 INFO - 'tart', 22:21:37 INFO - 'tscrollx', 22:21:37 INFO - 'cart']}, 22:21:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:21:37 INFO - 'talos_options': ['--disable-e10s'], 22:21:37 INFO - 'tests': ['tp5o']}, 22:21:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:21:37 INFO - 'tests': ['tp5o']}, 22:21:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:21:37 INFO - 'talos_options': ['--disable-e10s', 22:21:37 INFO - '--xperf_path', 22:21:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:21:37 INFO - 'tests': ['tp5n']}, 22:21:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:21:37 INFO - 'talos_options': ['--xperf_path', 22:21:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:21:37 INFO - 'tests': ['tp5n']}}, 22:21:37 INFO - 'talos.zip': {'path': '', 22:21:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:21:37 INFO - Running post-action listener: _resource_record_post_action 22:21:37 INFO - [mozharness: 2016-08-26 05:21:37.217121Z] Finished populate-webroot step (success) 22:21:37 INFO - [mozharness: 2016-08-26 05:21:37.217208Z] Running create-virtualenv step. 22:21:37 INFO - Running pre-action listener: _resource_record_pre_action 22:21:37 INFO - Running main action method: create_virtualenv 22:21:37 INFO - Creating virtualenv /builds/slave/test/build/venv 22:21:37 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 22:21:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:21:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:21:37 INFO - Using real prefix '/usr' 22:21:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:21:37 INFO - Installing distribute.............................................................................................................................................................................................done. 22:21:39 INFO - Installing pip.................done. 22:21:39 INFO - Return code: 0 22:21:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd437643f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x285a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285ae40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', '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 22:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:21:39 INFO - Using env: {'DISPLAY': ':0', 22:21:39 INFO - 'HOME': '/home/cltbld', 22:21:39 INFO - 'LANG': 'en_US.UTF-8', 22:21:39 INFO - 'LANGUAGE': 'en_US:en', 22:21:39 INFO - 'LOGNAME': 'cltbld', 22:21:39 INFO - 'MAIL': '/var/mail/cltbld', 22:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:39 INFO - 'MOZ_NO_REMOTE': '1', 22:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:39 INFO - 'NO_EM_RESTART': '1', 22:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:39 INFO - 'PWD': '/builds/slave/test', 22:21:39 INFO - 'SHELL': '/bin/bash', 22:21:39 INFO - 'SHLVL': '1', 22:21:39 INFO - 'TERM': 'linux', 22:21:39 INFO - 'TMOUT': '86400', 22:21:39 INFO - 'USER': 'cltbld', 22:21:39 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', 22:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:39 INFO - '_': '/tools/buildbot/bin/python'} 22:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:40 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 22:21:40 INFO - Cleaning up... 22:21:40 INFO - Return code: 0 22:21:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:21:40 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')]} 22:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:40 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')]} 22:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:40 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 0x7fd437643f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x285a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285ae40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', '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 22:21:40 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 22:21:40 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 22:21:40 INFO - Using env: {'DISPLAY': ':0', 22:21:40 INFO - 'HOME': '/home/cltbld', 22:21:40 INFO - 'LANG': 'en_US.UTF-8', 22:21:40 INFO - 'LANGUAGE': 'en_US:en', 22:21:40 INFO - 'LOGNAME': 'cltbld', 22:21:40 INFO - 'MAIL': '/var/mail/cltbld', 22:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:40 INFO - 'MOZ_NO_REMOTE': '1', 22:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:40 INFO - 'NO_EM_RESTART': '1', 22:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:40 INFO - 'PWD': '/builds/slave/test', 22:21:40 INFO - 'SHELL': '/bin/bash', 22:21:40 INFO - 'SHLVL': '1', 22:21:40 INFO - 'TERM': 'linux', 22:21:40 INFO - 'TMOUT': '86400', 22:21:40 INFO - 'USER': 'cltbld', 22:21:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', 22:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:40 INFO - '_': '/tools/buildbot/bin/python'} 22:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:40 INFO - Downloading/unpacking psutil>=3.1.1 22:21:40 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 22:21:40 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 22:21:40 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 22:21:40 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 22:21:40 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 22:21:40 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 22:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:21:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:21:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:21:42 INFO - Installing collected packages: psutil 22:21:42 INFO - Running setup.py install for psutil 22:21:42 INFO - building 'psutil._psutil_linux' extension 22:21:42 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 22:21:42 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 22:21:42 INFO - building 'psutil._psutil_posix' extension 22:21:42 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 22:21:42 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 22:21:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:21:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:21:42 INFO - Successfully installed psutil 22:21:42 INFO - Cleaning up... 22:21:42 INFO - Return code: 0 22:21:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:21:42 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')]} 22:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:42 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')]} 22:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:42 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 0x7fd437643f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x285a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285ae40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', '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 22:21:42 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 22:21:42 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 22:21:42 INFO - Using env: {'DISPLAY': ':0', 22:21:42 INFO - 'HOME': '/home/cltbld', 22:21:42 INFO - 'LANG': 'en_US.UTF-8', 22:21:42 INFO - 'LANGUAGE': 'en_US:en', 22:21:42 INFO - 'LOGNAME': 'cltbld', 22:21:42 INFO - 'MAIL': '/var/mail/cltbld', 22:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:42 INFO - 'MOZ_NO_REMOTE': '1', 22:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:42 INFO - 'NO_EM_RESTART': '1', 22:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:42 INFO - 'PWD': '/builds/slave/test', 22:21:42 INFO - 'SHELL': '/bin/bash', 22:21:42 INFO - 'SHLVL': '1', 22:21:42 INFO - 'TERM': 'linux', 22:21:42 INFO - 'TMOUT': '86400', 22:21:42 INFO - 'USER': 'cltbld', 22:21:42 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', 22:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:42 INFO - '_': '/tools/buildbot/bin/python'} 22:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:21:44 INFO - Installing collected packages: mozsystemmonitor 22:21:44 INFO - Running setup.py install for mozsystemmonitor 22:21:45 INFO - Successfully installed mozsystemmonitor 22:21:45 INFO - Cleaning up... 22:21:45 INFO - Return code: 0 22:21:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd437643f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x285a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285ae40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', '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 22:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:21:45 INFO - Using env: {'DISPLAY': ':0', 22:21:45 INFO - 'HOME': '/home/cltbld', 22:21:45 INFO - 'LANG': 'en_US.UTF-8', 22:21:45 INFO - 'LANGUAGE': 'en_US:en', 22:21:45 INFO - 'LOGNAME': 'cltbld', 22:21:45 INFO - 'MAIL': '/var/mail/cltbld', 22:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:45 INFO - 'MOZ_NO_REMOTE': '1', 22:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:45 INFO - 'NO_EM_RESTART': '1', 22:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:45 INFO - 'PWD': '/builds/slave/test', 22:21:45 INFO - 'SHELL': '/bin/bash', 22:21:45 INFO - 'SHLVL': '1', 22:21:45 INFO - 'TERM': 'linux', 22:21:45 INFO - 'TMOUT': '86400', 22:21:45 INFO - 'USER': 'cltbld', 22:21:45 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', 22:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:45 INFO - '_': '/tools/buildbot/bin/python'} 22:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:45 INFO - Downloading/unpacking jsonschema==2.5.1 22:21:45 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 22:21:45 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 22:21:45 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 22:21:45 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 22:21:45 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 22:21:45 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 22:21:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:21:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:21:47 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 22:21:47 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 22:21:47 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 22:21:47 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 22:21:47 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 22:21:47 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 22:21:47 INFO - Downloading functools32-3.2.3-2.tar.gz 22:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:21:47 INFO - warning: no files found matching '*.txt' 22:21:47 INFO - no previously-included directories found matching 'build' 22:21:47 INFO - no previously-included directories found matching 'dist' 22:21:47 INFO - no previously-included directories found matching '.git*' 22:21:47 INFO - Installing collected packages: jsonschema, functools32 22:21:47 INFO - Running setup.py install for functools32 22:21:47 INFO - warning: no files found matching '*.txt' 22:21:47 INFO - no previously-included directories found matching 'build' 22:21:47 INFO - no previously-included directories found matching 'dist' 22:21:47 INFO - no previously-included directories found matching '.git*' 22:21:47 INFO - Successfully installed jsonschema functools32 22:21:47 INFO - Cleaning up... 22:21:47 INFO - Return code: 0 22:21:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:21:47 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')]} 22:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:47 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')]} 22:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:47 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 0x7fd437643f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x285a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285ae40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', '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 22:21:47 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 22:21:47 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 22:21:47 INFO - Using env: {'DISPLAY': ':0', 22:21:47 INFO - 'HOME': '/home/cltbld', 22:21:47 INFO - 'LANG': 'en_US.UTF-8', 22:21:47 INFO - 'LANGUAGE': 'en_US:en', 22:21:47 INFO - 'LOGNAME': 'cltbld', 22:21:47 INFO - 'MAIL': '/var/mail/cltbld', 22:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:47 INFO - 'MOZ_NO_REMOTE': '1', 22:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:47 INFO - 'NO_EM_RESTART': '1', 22:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:47 INFO - 'PWD': '/builds/slave/test', 22:21:47 INFO - 'SHELL': '/bin/bash', 22:21:47 INFO - 'SHLVL': '1', 22:21:47 INFO - 'TERM': 'linux', 22:21:47 INFO - 'TMOUT': '86400', 22:21:47 INFO - 'USER': 'cltbld', 22:21:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', 22:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:47 INFO - '_': '/tools/buildbot/bin/python'} 22:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:21:47 INFO - Cleaning up... 22:21:47 INFO - Return code: 0 22:21:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:21:47 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')]} 22:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:47 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')]} 22:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:47 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 0x7fd437643f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x285a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285ae40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', '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 22:21:47 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 22:21:47 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 22:21:47 INFO - Using env: {'DISPLAY': ':0', 22:21:47 INFO - 'HOME': '/home/cltbld', 22:21:47 INFO - 'LANG': 'en_US.UTF-8', 22:21:47 INFO - 'LANGUAGE': 'en_US:en', 22:21:47 INFO - 'LOGNAME': 'cltbld', 22:21:47 INFO - 'MAIL': '/var/mail/cltbld', 22:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:47 INFO - 'MOZ_NO_REMOTE': '1', 22:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:47 INFO - 'NO_EM_RESTART': '1', 22:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:47 INFO - 'PWD': '/builds/slave/test', 22:21:47 INFO - 'SHELL': '/bin/bash', 22:21:47 INFO - 'SHLVL': '1', 22:21:47 INFO - 'TERM': 'linux', 22:21:47 INFO - 'TMOUT': '86400', 22:21:47 INFO - 'USER': 'cltbld', 22:21:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', 22:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:47 INFO - '_': '/tools/buildbot/bin/python'} 22:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:48 INFO - Downloading/unpacking blobuploader==1.2.4 22:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:49 INFO - Downloading blobuploader-1.2.4.tar.gz 22:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:21:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:21:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:50 INFO - Downloading docopt-0.6.1.tar.gz 22:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:21:50 INFO - Installing collected packages: blobuploader, requests, docopt 22:21:50 INFO - Running setup.py install for blobuploader 22:21:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:21:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:21:50 INFO - Running setup.py install for requests 22:21:51 INFO - Running setup.py install for docopt 22:21:51 INFO - Successfully installed blobuploader requests docopt 22:21:51 INFO - Cleaning up... 22:21:51 INFO - Return code: 0 22:21:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:21: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')]} 22:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21: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')]} 22:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:51 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 0x7fd437643f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x285a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285ae40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', '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 22:21:51 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 22:21:51 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 22:21:51 INFO - Using env: {'DISPLAY': ':0', 22:21:51 INFO - 'HOME': '/home/cltbld', 22:21:51 INFO - 'LANG': 'en_US.UTF-8', 22:21:51 INFO - 'LANGUAGE': 'en_US:en', 22:21:51 INFO - 'LOGNAME': 'cltbld', 22:21:51 INFO - 'MAIL': '/var/mail/cltbld', 22:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:51 INFO - 'MOZ_NO_REMOTE': '1', 22:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:51 INFO - 'NO_EM_RESTART': '1', 22:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:51 INFO - 'PWD': '/builds/slave/test', 22:21:51 INFO - 'SHELL': '/bin/bash', 22:21:51 INFO - 'SHLVL': '1', 22:21:51 INFO - 'TERM': 'linux', 22:21:51 INFO - 'TMOUT': '86400', 22:21:51 INFO - 'USER': 'cltbld', 22:21:51 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', 22:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:51 INFO - '_': '/tools/buildbot/bin/python'} 22:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:21:51 INFO - Running setup.py (path:/tmp/pip-jw2xpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:21:51 INFO - Running setup.py (path:/tmp/pip-CtE8SQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:21:51 INFO - Running setup.py (path:/tmp/pip-aq5kUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:21:51 INFO - Running setup.py (path:/tmp/pip-nak3bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:21:51 INFO - Running setup.py (path:/tmp/pip-pn_CHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:21:51 INFO - Running setup.py (path:/tmp/pip-fjSMdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:21:51 INFO - Running setup.py (path:/tmp/pip-qDAI8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:21:52 INFO - Running setup.py (path:/tmp/pip-jsGDNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:21:52 INFO - Running setup.py (path:/tmp/pip-9ylC3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:21:52 INFO - Running setup.py (path:/tmp/pip-HSOUzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:21:52 INFO - Running setup.py (path:/tmp/pip-wrmtDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:21:52 INFO - Running setup.py (path:/tmp/pip-O9CczA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:21:52 INFO - Running setup.py (path:/tmp/pip-5j4BLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:21:52 INFO - Running setup.py (path:/tmp/pip-KXp5er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:21:52 INFO - Running setup.py (path:/tmp/pip-3MDc0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:21:52 INFO - Running setup.py (path:/tmp/pip-7B4tFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:21:52 INFO - Running setup.py (path:/tmp/pip-eZ8sOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:21:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:21:52 INFO - Running setup.py install for manifestparser 22:21:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:21:52 INFO - Running setup.py install for mozcrash 22:21:52 INFO - Running setup.py install for mozdebug 22:21:53 INFO - Running setup.py install for mozdevice 22:21:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:21:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:21:53 INFO - Running setup.py install for mozfile 22:21:53 INFO - Running setup.py install for mozhttpd 22:21:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:21:53 INFO - Running setup.py install for mozinfo 22:21:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:21:53 INFO - Running setup.py install for mozInstall 22:21:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:21:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:21:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:21:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:21:53 INFO - Running setup.py install for mozleak 22:21:53 INFO - Running setup.py install for mozlog 22:21:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:21:53 INFO - Running setup.py install for moznetwork 22:21:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:21:53 INFO - Running setup.py install for mozprocess 22:21:53 INFO - Running setup.py install for mozprofile 22:21:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:21:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:21:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:21:54 INFO - Running setup.py install for mozrunner 22:21:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:21:54 INFO - Running setup.py install for mozscreenshot 22:21:54 INFO - Running setup.py install for moztest 22:21:54 INFO - Running setup.py install for mozversion 22:21:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:21:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:21:54 INFO - Cleaning up... 22:21:54 INFO - Return code: 0 22:21:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:21: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')]} 22:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21: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')]} 22:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:54 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 0x7fd437643f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x285a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285ae40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', '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 22:21:54 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 22:21:54 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 22:21:54 INFO - Using env: {'DISPLAY': ':0', 22:21:54 INFO - 'HOME': '/home/cltbld', 22:21:54 INFO - 'LANG': 'en_US.UTF-8', 22:21:54 INFO - 'LANGUAGE': 'en_US:en', 22:21:54 INFO - 'LOGNAME': 'cltbld', 22:21:54 INFO - 'MAIL': '/var/mail/cltbld', 22:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:54 INFO - 'MOZ_NO_REMOTE': '1', 22:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:54 INFO - 'NO_EM_RESTART': '1', 22:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:54 INFO - 'PWD': '/builds/slave/test', 22:21:54 INFO - 'SHELL': '/bin/bash', 22:21:54 INFO - 'SHLVL': '1', 22:21:54 INFO - 'TERM': 'linux', 22:21:54 INFO - 'TMOUT': '86400', 22:21:54 INFO - 'USER': 'cltbld', 22:21:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', 22:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:54 INFO - '_': '/tools/buildbot/bin/python'} 22:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:21:54 INFO - Running setup.py (path:/tmp/pip-IgJt26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:21:54 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)) 22:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:21:54 INFO - Running setup.py (path:/tmp/pip-ca3tes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:21:54 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)) 22:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:21:54 INFO - Running setup.py (path:/tmp/pip-eAGH54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:21:54 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)) 22:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:21:54 INFO - Running setup.py (path:/tmp/pip-6BRFxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:21:55 INFO - Running setup.py (path:/tmp/pip-PT7HE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:21:55 INFO - Running setup.py (path:/tmp/pip-oHOs4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:21:55 INFO - Running setup.py (path:/tmp/pip-Qs4LxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:21:55 INFO - Running setup.py (path:/tmp/pip-WqOS3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:21:55 INFO - Running setup.py (path:/tmp/pip-OseAEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:21:55 INFO - Running setup.py (path:/tmp/pip-xSmcgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:21:55 INFO - Running setup.py (path:/tmp/pip-5mi6YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:21:55 INFO - Running setup.py (path:/tmp/pip-7UA0U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:21:55 INFO - Running setup.py (path:/tmp/pip-W4kRO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:21:55 INFO - Running setup.py (path:/tmp/pip-Q38h4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:21:55 INFO - Running setup.py (path:/tmp/pip-GHlin5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:21:55 INFO - Running setup.py (path:/tmp/pip-o8CB2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:21:55 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)) 22:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:21:55 INFO - Running setup.py (path:/tmp/pip-jd7flw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:21:55 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)) 22:21:55 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)) 22:21:55 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)) 22:21:55 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)) 22:21:55 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)) 22:21:55 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)) 22:21:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:57 INFO - Downloading blessings-1.6.tar.gz 22:21:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:21:57 INFO - Installing collected packages: blessings 22:21:57 INFO - Running setup.py install for blessings 22:21:58 INFO - Successfully installed blessings 22:21:58 INFO - Cleaning up... 22:21:58 INFO - Return code: 0 22:21:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:21:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:21:58 INFO - Reading from file tmpfile_stdout 22:21:58 INFO - Current package versions: 22:21:58 INFO - argparse == 1.2.1 22:21:58 INFO - blessings == 1.6 22:21:58 INFO - blobuploader == 1.2.4 22:21:58 INFO - docopt == 0.6.1 22:21:58 INFO - functools32 == 3.2.3-2 22:21:58 INFO - jsonschema == 2.5.1 22:21:58 INFO - manifestparser == 1.1 22:21:58 INFO - mozInstall == 1.12 22:21:58 INFO - mozcrash == 0.17 22:21:58 INFO - mozdebug == 0.1 22:21:58 INFO - mozdevice == 0.48 22:21:58 INFO - mozfile == 1.2 22:21:58 INFO - mozhttpd == 0.7 22:21:58 INFO - mozinfo == 0.9 22:21:58 INFO - mozleak == 0.1 22:21:58 INFO - mozlog == 3.3 22:21:58 INFO - moznetwork == 0.27 22:21:58 INFO - mozprocess == 0.23 22:21:58 INFO - mozprofile == 0.28 22:21:58 INFO - mozrunner == 6.12 22:21:58 INFO - mozscreenshot == 0.1 22:21:58 INFO - mozsystemmonitor == 0.3 22:21:58 INFO - moztest == 0.7 22:21:58 INFO - mozversion == 1.4 22:21:58 INFO - psutil == 3.1.1 22:21:58 INFO - requests == 1.2.3 22:21:58 INFO - wsgiref == 0.1.2 22:21:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:58 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 0x7fd437643f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x285a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285ae40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', '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 22:21:58 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 22:21:58 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 22:21:58 INFO - Using env: {'DISPLAY': ':0', 22:21:58 INFO - 'HOME': '/home/cltbld', 22:21:58 INFO - 'LANG': 'en_US.UTF-8', 22:21:58 INFO - 'LANGUAGE': 'en_US:en', 22:21:58 INFO - 'LOGNAME': 'cltbld', 22:21:58 INFO - 'MAIL': '/var/mail/cltbld', 22:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:58 INFO - 'MOZ_NO_REMOTE': '1', 22:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:58 INFO - 'NO_EM_RESTART': '1', 22:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:58 INFO - 'PWD': '/builds/slave/test', 22:21:58 INFO - 'SHELL': '/bin/bash', 22:21:58 INFO - 'SHLVL': '1', 22:21:58 INFO - 'TERM': 'linux', 22:21:58 INFO - 'TMOUT': '86400', 22:21:58 INFO - 'USER': 'cltbld', 22:21:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', 22:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:58 INFO - '_': '/tools/buildbot/bin/python'} 22:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:58 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)) 22:21:58 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)) 22:21:58 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)) 22:21:58 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)) 22:21:58 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)) 22:21:58 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)) 22:21:58 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)) 22:21:58 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)) 22:21:58 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)) 22:21:58 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)) 22:21:58 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)) 22:21:58 INFO - Cleaning up... 22:21:58 INFO - Return code: 0 22:21:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:58 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 0x7fd437643f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x285a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285ae40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', '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 22:21:58 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 22:21:58 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 22:21:58 INFO - Using env: {'DISPLAY': ':0', 22:21:58 INFO - 'HOME': '/home/cltbld', 22:21:58 INFO - 'LANG': 'en_US.UTF-8', 22:21:58 INFO - 'LANGUAGE': 'en_US:en', 22:21:58 INFO - 'LOGNAME': 'cltbld', 22:21:58 INFO - 'MAIL': '/var/mail/cltbld', 22:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:58 INFO - 'MOZ_NO_REMOTE': '1', 22:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:58 INFO - 'NO_EM_RESTART': '1', 22:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:58 INFO - 'PWD': '/builds/slave/test', 22:21:58 INFO - 'SHELL': '/bin/bash', 22:21:58 INFO - 'SHLVL': '1', 22:21:58 INFO - 'TERM': 'linux', 22:21:58 INFO - 'TMOUT': '86400', 22:21:58 INFO - 'USER': 'cltbld', 22:21:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', 22:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:58 INFO - '_': '/tools/buildbot/bin/python'} 22:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:21:58 INFO - Cleaning up... 22:21:58 INFO - Return code: 0 22:21:58 INFO - Running post-action listener: _resource_record_post_action 22:21:58 INFO - Running post-action listener: _start_resource_monitoring 22:21:58 INFO - Starting resource monitoring. 22:21:58 INFO - [mozharness: 2016-08-26 05:21:58.835574Z] Finished create-virtualenv step (success) 22:21:58 INFO - [mozharness: 2016-08-26 05:21:58.836163Z] Running install step. 22:21:58 INFO - Running pre-action listener: _resource_record_pre_action 22:21:58 INFO - Running main action method: install 22:21:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:21:59 INFO - Reading from file tmpfile_stdout 22:21:59 INFO - Detecting whether we're running mozinstall >=1.0... 22:21:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:21:59 INFO - Reading from file tmpfile_stdout 22:21:59 INFO - Output received: 22:21:59 INFO - Usage: mozinstall [options] installer 22:21:59 INFO - Options: 22:21:59 INFO - -h, --help show this help message and exit 22:21:59 INFO - -d DEST, --destination=DEST 22:21:59 INFO - Directory to install application into. [default: 22:21:59 INFO - "/builds/slave/test"] 22:21:59 INFO - --app=APP Application being installed. [default: firefox] 22:21:59 INFO - mkdir: /builds/slave/test/build/application 22:21:59 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'] 22:21:59 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 22:22:16 INFO - Reading from file tmpfile_stdout 22:22:16 INFO - Output received: 22:22:16 INFO - /builds/slave/test/build/application/firefox/firefox 22:22:16 INFO - Running post-action listener: _resource_record_post_action 22:22:16 INFO - [mozharness: 2016-08-26 05:22:16.154858Z] Finished install step (success) 22:22:16 INFO - [mozharness: 2016-08-26 05:22:16.155140Z] Running run-tests step. 22:22:16 INFO - Running pre-action listener: _resource_record_pre_action 22:22:16 INFO - Running main action method: run_tests 22:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:22:16 INFO - Python 2.7.3 22:22:16 INFO - Return code: 0 22:22:16 INFO - grabbing minidump binary from tooltool 22:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x285a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285ae40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:22:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:22:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:22:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:22:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:22:16 INFO - Return code: 0 22:22:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:22:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:22:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:22:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:22:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 22:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 22:22:16 INFO - Using env: {'DISPLAY': ':0', 22:22:16 INFO - 'HOME': '/home/cltbld', 22:22:16 INFO - 'LANG': 'en_US.UTF-8', 22:22:16 INFO - 'LANGUAGE': 'en_US:en', 22:22:16 INFO - 'LOGNAME': 'cltbld', 22:22:16 INFO - 'MAIL': '/var/mail/cltbld', 22:22:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:22:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:16 INFO - 'MOZ_NO_REMOTE': '1', 22:22:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:16 INFO - 'NO_EM_RESTART': '1', 22:22:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:16 INFO - 'PWD': '/builds/slave/test', 22:22:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:22:16 INFO - 'SHELL': '/bin/bash', 22:22:16 INFO - 'SHLVL': '1', 22:22:16 INFO - 'TERM': 'linux', 22:22:16 INFO - 'TMOUT': '86400', 22:22:16 INFO - 'USER': 'cltbld', 22:22:16 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212', 22:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:16 INFO - '_': '/tools/buildbot/bin/python'} 22:22:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 22:22:16 INFO - mozversion application_buildid: 20160825193025 22:22:16 INFO - mozversion application_changeset: 57dd530675399cb159844ceb53ce514fc129f8ed 22:22:16 INFO - mozversion application_display_name: Nightly 22:22:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:22:16 INFO - mozversion application_name: Firefox 22:22:16 INFO - mozversion application_remotingname: firefox 22:22:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:22:16 INFO - mozversion application_vendor: Mozilla 22:22:16 INFO - mozversion application_version: 51.0a1 22:22:16 INFO - mozversion platform_buildid: 20160825193025 22:22:16 INFO - mozversion platform_changeset: 57dd530675399cb159844ceb53ce514fc129f8ed 22:22:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:22:16 INFO - mozversion platform_version: 51.0a1 22:22:16 INFO - using testdate: 1472188936 22:22:16 INFO - actual date: 1472188936 22:22:16 INFO - starting webserver on 'localhost:57388' 22:22:16 INFO - SUITE-START | Running 2 tests 22:22:16 INFO - TEST-START | dromaeo_css 22:22:16 INFO - operating with platform_type : linux_ 22:22:16 INFO - Initialising browser for dromaeo_css test... 22:22:16 INFO - TEST-INFO | started process 29236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboUiO5/profile http://localhost:57388/getInfo.html) 22:22:21 INFO - PROCESS | 29236 | __metrics Screen width/height:1600/1200 22:22:21 INFO - PROCESS | 29236 | colorDepth:24 22:22:21 INFO - PROCESS | 29236 | Browser inner width/height: 1024/697 22:22:21 INFO - PROCESS | 29236 | __metrics 22:22:22 ERROR - PROCESS | 29236 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 22:22:23 INFO - TEST-INFO | 29236: exit 0 22:22:23 INFO - Browser initialized. 22:22:23 INFO - Running cycle 1/1 for dromaeo_css test... 22:22:23 INFO - TEST-INFO | started process 29358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboUiO5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:22:35 INFO - PROCESS | 29358 | RSS: Main: 191004672 22:22:35 INFO - PROCESS | 29358 | 22:23:24 INFO - PROCESS | 29358 | 1472189004894 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] 22:25:35 INFO - PROCESS | 29358 | Cycle 1(1): loaded http://localhost:57388/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57388/tests/dromaeo/cssquery-ext.html) 22:25:36 INFO - PROCESS | 29358 | RSS: Main: 207286272 22:25:36 INFO - PROCESS | 29358 | 22:28:38 INFO - PROCESS | 29358 | Cycle 1(1): loaded http://localhost:57388/tests/dromaeo/cssquery-ext.html (next: http://localhost:57388/tests/dromaeo/cssquery-jquery.html) 22:28:38 INFO - PROCESS | 29358 | RSS: Main: 200237056 22:28:38 INFO - PROCESS | 29358 | 22:31:40 INFO - PROCESS | 29358 | Cycle 1(1): loaded http://localhost:57388/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57388/tests/dromaeo/cssquery-mootools.html) 22:31:41 INFO - PROCESS | 29358 | RSS: Main: 197656576 22:31:41 INFO - PROCESS | 29358 | 22:34:43 INFO - PROCESS | 29358 | Cycle 1(1): loaded http://localhost:57388/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57388/tests/dromaeo/cssquery-prototype.html) 22:34:43 INFO - PROCESS | 29358 | RSS: Main: 193908736 22:34:43 INFO - PROCESS | 29358 | 22:37:46 INFO - PROCESS | 29358 | Cycle 1(1): loaded http://localhost:57388/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57388/tests/dromaeo/cssquery-yui.html) 22:37:47 INFO - PROCESS | 29358 | RSS: Main: 197808128 22:37:47 INFO - PROCESS | 29358 | 22:40:49 INFO - PROCESS | 29358 | Cycle 1(1): loaded http://localhost:57388/tests/dromaeo/cssquery-yui.html (next: http://localhost:57388/tests/dromaeo/cssquery-dojo.html) 22:40:50 INFO - PROCESS | 29358 | RSS: Main: 198209536 22:40:50 INFO - PROCESS | 29358 | 22:40:50 INFO - PROCESS | 29358 | __start_tp_report 22:40:50 INFO - PROCESS | 29358 | _x_x_mozilla_page_load 22:40:50 INFO - PROCESS | 29358 | _x_x_mozilla_page_load_details 22:40:50 INFO - PROCESS | 29358 | |i|pagename|runs| 22:40:50 INFO - PROCESS | 29358 | |0;dojo.html;3123.312871168343;3128.280495486038;3147.6694947030555;3169.8256595887233;3176.2218256527153;5495.6153069285165;5512.33851937767;5521.97843398971;5619.6066275360745;5653.604247702662;5462.617616766828;5508.118701007839;5559.58303127266;5559.722013899299;5581.2186293918885;4820.421549414075;4940.505949405048;5098.286239926395;5159.484051594848;5196.818111366103;5116.539511443969;5163;5163.044836705203;5242.239875218091;5242.266082748418;4973.676711013773;4995.775190116417;5036.345275114249;5074.391073071237;5083.415407228179;5050.141475949061;5055;5063.873403164914;5084.339035925343;5134.1528647773075;5006.974965125151;5044.798208071673;5047.3438453001245;5053.267276244961;5108.974455127738;5378;5452.40023597404;5514.6691198527815;5535.25274087997;5577.247071645316;5930.021546444875;5934.6142500737315;5956.076808094752;5956.16613674086;5997.460228579449;5952.880942381128;5956.076808094752;5961.821145365646;6014.609050411709;6018.097285407181;5467.972660136674;5530.917036244459;5556.722163891789;5590.832275031756;5591.384947655754;6114.66235542843;6121.5845156403;6124.300770772471;6128.533679014772;6137.936202632845;5879.941200588025;5884.705764711833;5884.911726324109;5886.8822623547285;5894.233749612523;5673.971630141906;5928.644281343133;5966.791162309299;5984.222051133324;5995.52035837132;5747.568932330092;5918.585699001114;5923.022701254331;5949.25634295713;5990.311114221833;6025.6083354581815;6032.276126864805;6040.244969378828;6042.486388656926;6103.755849766048;4593.356930029799;4620.4686461056735;4623.606993405599;4629.930551041737;4683.859484215479;3932.744371615836;4006.4991876015497;4008.4388185654034;4026.2350153470748;4036.2129384769687;5700.25896633435;5718.742656580381;5730.426957304319;5802.709864506758;5818.389069147764;5945.316288626776;5976.133460648181;6007.339192688801;6014.909776353358;6017.608855424383;5604.495595396434;5635.971820140873;5657.264555607745;5730.398308177665;5733.397993210736;5151.4333423323405;5172.793088276502;5180.1711726124395;5216.295800067019;5227.607929405233;6092.8781424372155;6123.08153776937;6127.785527506516;6127.785527506605;6139.2325959255095;5847.1229315603;5901.940980590139;5902.203202567598;5939.07944268639;5959.851003724768;6123.783052809673;6133.693315334126;6152.384761523812;6153.384661533811;6160.568760186923;5842.678652674143;5853.590248682722;5865.589408741347;5874.060150375919;5874.676892770768;5781.392953739965;5917.437843404869;5934.910976335272;5950.107483877453;5950.880982380415;5858.794942177004;5870.090136028923;5874.383189765013;5875.441833025856;5962.5528085394635;5810.5061069809535;5829.621074630136;5841.269841269841;5848.53211743068;5851.297844258716;5531.612787104864;5688.3742788294085;5815.709214539172;5843.532517398513;5849.766009359578;5946.910796338145;5947.762089516371;5951.940480595139;5955.940440595712;6031.7587296507645;5734.770609175586;5822.097574875901;5823.068309070529;5825.2135961644635;5828.271466066742 22:40:50 INFO - PROCESS | 29358 | |1;ext.html;554.4083423471515;574.5719439017932;601.4406601860271;603.2670305578722;642.5149012495565;38975.415368769456;42697;42738.57261427385;42974.57025429748;43121.35317970233;43404.34893476601;43721;43972.3404148938;44049;44245.805587217736;8800.647974081028;8838.42550234236;8903.287736981027;8955.149260820212;8959.328050396214;8714.912850871506;8823.338249631272;8838.823223535526;8867.68963086292;8879.378443508956;8867.423617464845;8898.110188981082;8898.777530561723;8920.776980575472;8930.10698930105;8876.201141897229;8895.73312800617;8899.199072083544;8905.465672059698;8927.553622318857;8784.560771961376;8822.514761688104;8853.822923541493;8855.291576673852;8876.112388761137;41524.792376038225;41745.79127104375;41793.582064179274;41970.79014604938;42632.57367426317;3387.085486918518;3756.136088699587;3783.5838057813617;3913.1977944521304;4024.5371782245124;32258;32474;32636;33076.66923330784;34016.48975265373;4379.1022840317655;4385.736855788663;4406;4409.426774519324;4437.977810110929;376220;377653;378101;380191;380592;35068.473972889915;36054;59008.70495647494;59237.70381148153;59309;37483.4377484338;37520.24959500795;37523;37536.24927501435;37630.62369376326;16063.839361606235;16112.355505779871;16185.67628647444;16187.109708965885;16288.104154271392;13616.727665446635;13655;13677.794833077513;13684.863151368558;13688.52090176839;8496.107908669625;8525.658973640984;8556.18716221958;8612.956935215283;8621.31029517637;3310.1228174533767;3359.3617212729505;3366.865325387006;3370.6629337066097;3386.593608766964;923.8845144356956;998.4159266828987;1023.7747695506977;1102.4038389592554;1122.8371886076472;32400.67599324024;32561.18597035093;32712;32810.50784238238;33106.50340244898;1102.4267380961855;1201.285235285004;1222.6576558563615;1237.8611677256945;1254.1346470935025;16787;17004.574885627957;17015.404460843813;17090.230939607747;17292.65414691699;551621;557158;559774;560445;560936;58418.41581584215;58667.4133258662;58938.41061589415;59065.70467147637;59337.109943350886;1317.440087962612;1320.854705982341;1332.4536939854613;1361.4418088583436;1377.1805775563523;30246;31218.843905780326;31899.68100318967;32159.67840321567;32321.35357292888;49913;50663.49336506588;50675.49324506855;50709.746451268984;50725.23912141395;480795;483397;484225;484716;486702;28807;29285.41429171362;29441.85279073591;29442.263943401587;29467.263318416353;47543.286850696575;50020.49979500158;50028.749856250484;53120.734396327774;53150.4684953161;41665.79167104145;42566.361504578075;43635.78182109069;44230.55769442264;44503.332450012625;42054;42194.78902605467;42474;44004;44190.55809441993;40611.390829136995;41154.79422602868;41649.79175104105;41882.37176442295;41997.37003945004;35486.82256588701;37457.62542374541;38079.619203807604;38545.229095418494;38919.805400972815;28709.138725838257;28833.855830720713;29154;29241.561376578942;29478.557821632265 22:40:50 INFO - PROCESS | 29358 | |2;jquery.html;401.0935286253067;402.1574800792339;412.53795748761394;417.78066515079587;431.65036320580333;18209.635807283863;19819.702704459443;19894.10476528556;19918.900405497952;20459.18163273471;19203;19313.324033658824;19362.70955935662;19368.4189474316;19409.902950485262;5631.380548139701;5754.74103665336;6015.308239552463;6057.697115144225;6141.754329826824;5876.147958546008;6026.638401695912;6044.576879618428;6065.666388348639;6070;6006.099085137221;6030.577859549811;6049.425304596079;6054.243219597551;6061.302950160743;5997.520198384119;6032.487238584704;6041.003234466308;6466.191726034246;6566.901496477557;5908.468237858613;5914.053751399755;5916.083007133901;5921.407859214044;5934.228550288478;12608.219971924056;22057.779422205735;23167.189148379894;23365.88317058421;23522.29433116992;2411.855288682667;2426.842255253403;2494.6881639795024;2944.823310601371;3016.170553097894;10180.796384072277;10526.000029997138;10738.946305268502;10747.516361763739;11019.393933333664;1953.3163392812544;1961.117497126299;1984.0575726529783;2020.737304150451;2068.534579719566;80243.59878200572;81393.59303203506;81610.59194704048;86193.56903215506;87692;11110.833337499944;11426.94286528562;11529.250598711056;11609;11716.121290903046;16046.037237765539;16064.518064458085;16065.678686426207;16069.919650401907;16121.758173627404;8230.547319897343;8354.373421993254;8357.958210209032;8402.117777633383;8651.567421628893;7813.726519571901;7888.566128862853;7911;8036.83926321482;8405.285550728257;4858.951410485921;4886.780094895738;4893.290472881412;4941.407031156285;4992.653452877142;1883.2655264446876;1957.4812674641232;1991.442396129086;1999.9100040498213;2009.085865930998;873.7073080518097;932.2495391210006;962.6726912849665;996.9302148849656;1003.3979612232602;18659.375921547926;19050.428487145407;19120.426387208405;19233;19642;974.5560245281539;989.8762654668167;1012.731626119079;1022.6267412394571;1064.9041586257274;10468.005539473737;10792.190585706103;10944.616938407118;10958.616448424267;11034.558617655204;496920;500134;504241;506200;509937;78209.60895195487;93271;93305.53347233355;93592.53203734074;94040.52979735195;992.5087081894364;1018.7809620931683;1023.8259495885717;1024.7130803375067;1026.3585259212991;16595.087270200256;17351.785375023628;17718.202680879134;17725.55686107806;17848.67043187388;37542.624573753914;43080;43393.78303108464;43611.78194109009;43624.56375436332;48081.5191848077;55661.721691391285;57476.137857933;57495;57857.710711446176;8380;8646.913530864611;8694.739157825275;8724.651013959625;8854.645814167361;12451.688707782016;12725.109242353317;13338.599842004756;13778.104423212459;14119.858801411854;11496.367699776592;11942.283462992249;11996.160268781101;12163.939180304042;12550.246985180918;10611.946940265248;11627.244229125079;11704.531818727497;11734.589289374831;11823.408829558315;11058.336499810037;12095.75808483843;12195.390230488618;12468.251904885736;12629.74740505203;7560.58416787082;8828.07305232967;8878.911210887809;8935.865962010444;9206.907930920604;10985.505652245509;11253.268537545033;11598.246114002563;11733.589324373606;12028.398580071136 22:40:50 INFO - PROCESS | 29358 | |3;mootools.html;1465.45045607897;1482.4070371851262;1652.545549973757;1741.1120328632394;1768.9027103509302;7584.886226706604;8527.914720852797;8871.556422178897;9256.398334108279;9271.768205794859;9035.819283614324;9117.133872282138;9123.726288211348;9147.131022552847;9175.357724959256;2396.736359000513;2417.851520527744;2424.2363655448476;2431.0154387473103;2449.0448724997264;2358.563665721847;2364.8344615876895;2429.149797570854;2431.914882979096;2446.7675570820743;2369.040538581877;2391.9043238270447;2392.497575509145;2396.7483414241515;2423.0792298926385;2328.6274196128625;2340.531893621274;2348.5537747827857;2356.081128359941;2382.60686986647;2302.102180149743;2307.699999000136;2314.6990891184205;2326.930192094223;2344.601417758985;8716.694915677985;8721.476711397336;8802.163794439582;8831.3376496763;8863.157999989991;5382.461753824626;5483.451654834525;5541.722913854291;5543.168524721284;5544.16837474378;3552.5381700379044;3564.679178873888;3575.570931488212;3603.9279214415565;3643.908902277438;1212.1878341511208;1219.603628820637;1231.0828432817518;1234.969125771854;1274.898008159345;12398.31809250491;12458.688532786662;12466.688332791662;12487.188332758342;12535.498580056877;4350.129974005212;4560.931586026212;4662.883427914261;4667.113248482845;4685.390899183084;10291.382517049002;10336.948315258376;10347;10399.740006499747;10446.791064178673;5299.364076310867;5325.307709997675;5341.732913354317;5348.732563371816;5363.5440987516495;4302.741835489881;4824.565789079;4825.469198388175;4963.883126296554;4976.726280054631;3921.862734804325;4038.9798051009557;4064.085580744368;4107.404426358161;4143.212789570032;1328.4818920620964;1351.2029001428077;1361.5438827992534;1370.1984339161702;1373.1074801379184;926.6941909169958;985.8422652375585;1013.8428543575758;1015.9339642923186;1050.201846596592;5965.701714914237;5970.2238708968425;5994.490468310155;6179.073139029092;6268.322424906073;482.2693619166965;483.2992161366033;504.271327931136;507.46462482081756;509.38364578859995;4163.562825903297;4191.517975432804;4196.706230563831;4203.4115223868685;4226.281532139544;11010.119190464744;11197.824228456058;11223.663290101147;11233.775324493465;11299.887001129884;11093.83359249612;11115.055220306203;11175.38535380562;11195.160362972809;11278.605248816251;7915.327197188303;8167.42828002046;8251.793705157299;8371.95814020926;8414.200650938152;5934.554908381975;5976.701164941648;6056.485198758155;6144.907826382519;6153.476954458921;9708.854367184356;10031.498425078862;10050.798984020425;10084.747881303027;10155.695329140137;10036.949815250877;10070.899291006996;10077.899221007696;10196.643117490852;10209.54057067419;7893.881591776013;8006.599670016592;8092.959535202286;8437.789055273668;8460.619272132892;8561.1866872647;8801.07588703177;8813.118688131392;8815.515146666994;8834.867476987722;7725.690972361267;7730.22697730245;7732.497387669783;7767.650455729393;7920.287174154354;7480;7521.210272921265;7681.347085497795;7724.382049436144;7871.960640196762;6822.215445223863;6996.930030699627;7014.263502332182;7030.50786444944;7051.6474176292;5190.117679994334;5192.584593232456;5379.865503362447;5586.52514536269;5636.436356364331;5420.593455490775;5463.453654634504;5475.342958844804;5502.8349149525575;5626.774929002958 22:40:50 INFO - PROCESS | 29358 | |4;prototype.html;329.1829103349511;342.874850679502;350.044378845751;355.01129354747036;355.58041511017007;5364.222187782769;5410.56715462763;5616.859578510534;5652.886942261158;5679.261695979522;5362.034833729927;5470.152126420401;5474.479924407185;5484.478974497416;5485.120311836288;4342.457192850894;4376.518582955872;4379.4963579188325;4382.737035777847;4403.955960440403;4179.185058913513;4292.356146578023;4320.265554855667;4394.318880573516;4413.867583972486;4315.266404711191;4316.266234740102;4318.589733975283;4335.089631177457;4339.849939765964;4337.956620433818;4338.631216346615;4351.825926962918;4356.259435895905;4368.170047690928;3666.395044817602;3886.7667939923695;3893.377059670439;3900.3759398496104;3902.180542086165;5373.382061062989;5391.495527906892;5407.351117865881;5432;5441.4969114207515;5036.6726162799305;5040.42035165957;5042.949570504285;5065.049955767019;5070.6957582545165;5473.808416705396;5811.912821307684;5824.825255242349;5840.2991641003355;5860.765569377219;4235.3858690490015;4250.404943307939;4251.532331443539;4256.361545768129;4281.9509220240925;6033.245844269466;6069.423404776539;6074.240719910012;6113.144159817629;6116.510679145702;4207.936880946788;4285.5928686774705;4292.291771857671;4404.383386325917;4416.205083085011;4372.825086996548;4374.650027997753;4375.584319489643;4377.817989142977;4400.845970391021;4967.751612419364;4993.550580447777;5012.949870501321;5035.917277785294;5036.496350365008;5713.000674645761;5791.449812267828;5837.503812175928;5872.76671898906;5918.763249469973;1482.7553453680023;1520.1259275916393;1522.9466968656043;1523.6800271942795;1527.1676936069869;940.4216406909838;974.6734843827397;977.2719324103589;1004.6031817432073;1007.2697294461457;4837.516248375135;4873.41519017713;4880.6583539152625;4880.804767809248;4899.730514821719;5103.5661968733075;5117.667351622133;5127.923136141378;5128.410232823198;5134.358205224347;4685.437747470325;4847.345608342828;4853.781579828917;4894.510548945077;4943.382077240345;2761.613374127624;2762.640856688658;2769.6676398831864;2776.486350025252;2784.986075069652;5275.920861187085;5277.762500687479;5291.576673866081;5324.254604355393;5330.546903513167;4983.327250821093;5251.973740131275;5277.656952298088;5292.153255479182;5308.6462951947005;5221.12837939132;5237.397699264633;5247.501487358695;5254.343207099113;5317.574594032468;5109.616778741683;5120.1567435723855;5121.61587880903;5137.357830271216;5157.355330583677;5101.668391554537;5377.973110134424;5851.970740146272;5871.412858714094;5877.471027607365;6024.909626355696;6058.727357269022;6113.449789518964;6115.541334399849;6120.663363515049;4049.2913740094777;4094.795260237036;4111.403846442309;4123.60825721556;4145.253854306254;5702.201691763239;5766.826995190151;5880.26496687914;5895.322037965689;5909.379515151019;5763.913541296968;5799.420057994167;5806.796762113306;5812.570583355671;5817.8364327133895;5804.65172089676;5805.245318108618;5808.419158084158;5811.501054546586;5818.33089194748;5582.190582365615;5754.856128596819;5794.768209271582;5802.564807639359;5804.9709751452665;5832.387599302182;5838.824835254949;5841.737121829443;5851.239338885917;5876.676782776988;5337.6797392156595;5642.9403267807775;5706.686132262766;5707.286589176353;5710.143478478261 22:40:50 INFO - PROCESS | 29358 | |5;yui.html;708.4474110194051;737.8007937856783;752.3116348541085;820.7373640435061;865.7272959017911;15027.17350545721;15855.445059422922;15904.20478976051;15916.124613146287;15926.442574509894;14806.25968701566;15596.986195897258;15725.685486290267;15810.84189158108;15848.920755396235;791.2996997657086;793.7102957420543;813.6460639621754;814.7189219719218;814.7840822182127;813.9389545784061;819.2094628683319;822.3462347433774;822.6010384963288;822.995885020577;858.5449711652834;865.6537385045968;865.8787769712245;865.9307255419551;868.68727258187;854.7563944275882;855.4653341661461;856.195176534056;861.3884142258972;863.5207459859776;623.663221860195;624.9218847644045;627.2723640576954;627.9434850863398;630.5365556316104;15027.849721502755;15061;15119.54641360761;15152.393904243818;15203.847961520354;14282.928585357111;14661.706765864623;14741.11553306805;14848.183349915751;14919.552413427615;12283.877161228364;12358.134930554865;12602.109604251009;12898.290594017326;12899.871001290056;3920.4119382092913;3935.940960885589;3988.082740969593;4062.0251139726547;4080.4491393661774;84822.57588712078;85382;85502.57248713842;86045.24434445694;86538.56730716306;11291.322520648788;11601.12991525639;11829.290242585472;11925.463354149084;12109.515619375303;22114;22205.888970555043;22348.32955011352;22395.32814015582;22400.215992440186;8581.613827377783;8621.31029517637;8773.736787896374;8907.955460222658;8916.108389161162;4455.192344934804;4457.621102206349;4511.774411279423;4657.69724967876;4691.812327506861;3604;3708.8331025103935;3710.5547334320054;3725.18046029873;3765.021094515391;614.9969250153721;615.6306216270202;615.9322474527798;624.6782906803;639.8880195965687;571.0862619808356;578.1356871477169;615.2371059885799;686.5297271369128;719.2591630620469;9877.851832222523;10009.849852252222;10055.949720251352;10202.744931376776;10387.740306492398;599.1851082527759;622.2595111816923;668.0413606474627;686.2211390072304;722.1154086244413;4810.2063159578975;5001.399832020108;5013.724245166551;5031.899362012812;5061.5950723942;69358;73861;122167;129880;131474.34262828625;99972.50013749885;102907.48546257221;105145;107677;108929;94637;95682.57315059712;98676.50661746645;100007.49996249973;101910;9154.542272886196;9215.571586404118;9363.905693728791;9366.203872670627;9426.057394260519;53940;54558.45441545534;55754.72122639361;55830.44169558415;56442;73980.63009685132;77442.6767196985;83627.5818620903;87031;87253.56373218093;12808.807867881802;12809.975201983632;13332.333383330988;13441.663958401119;13620.795688064885;14031.298435078;14232.857671423153;14319.284035798377;14428.485009073896;14459.13245205291;13412.597622071353;13655.931720341334;14477.420903164177;14537.20045397471;14581.125132492085;13868.445262189804;13943.790843137564;14450.060746051473;14685;14865.405383784528;13348.93325533405;13910.860891391361;13986.230757308445;14116.717665646423;14455.421783128977;10001.849972250277;11214.607488737855;11250;11532.36571988515;11941.402929853646;10286.074253317238;10699.037086661927;10884.861142189466;11103.833442498208;11794.646160615195 22:40:50 INFO - PROCESS | 29358 | __end_tp_report 22:40:50 INFO - PROCESS | 29358 | __start_cc_report 22:40:50 INFO - PROCESS | 29358 | _x_x_mozilla_cycle_collect,316 22:40:50 INFO - PROCESS | 29358 | __end_cc_report 22:40:50 INFO - PROCESS | 29358 | __startTimestamp1472190050096__endTimestamp 22:40:50 INFO - PROCESS | 29358 | 22:40:50 INFO - PROCESS | 29358 | ------- Summary: start ------- 22:40:50 INFO - PROCESS | 29358 | Number of tests: 6 22:40:50 INFO - PROCESS | 29358 | 22:40:50 INFO - PROCESS | 29358 | [#0] dojo.html Cycles:165 Average:5542.91 Median:5818.39 stddev:639.75 (11.0%) stddev-sans-first:612.91 22:40:50 INFO - PROCESS | 29358 | Values: 3123.3 3128.3 3147.7 3169.8 3176.2 5495.6 5512.3 5522.0 5619.6 5653.6 5462.6 5508.1 5559.6 5559.7 5581.2 4820.4 4940.5 5098.3 5159.5 5196.8 5116.5 5163.0 5163.0 5242.2 5242.3 4973.7 4995.8 5036.3 5074.4 5083.4 5050.1 5055.0 5063.9 5084.3 5134.2 5007.0 5044.8 5047.3 5053.3 5109.0 5378.0 5452.4 5514.7 5535.3 5577.2 5930.0 5934.6 5956.1 5956.2 5997.5 5952.9 5956.1 5961.8 6014.6 6018.1 5468.0 5530.9 5556.7 5590.8 5591.4 6114.7 6121.6 6124.3 6128.5 6137.9 5879.9 5884.7 5884.9 5886.9 5894.2 5674.0 5928.6 5966.8 5984.2 5995.5 5747.6 5918.6 5923.0 5949.3 5990.3 6025.6 6032.3 6040.2 6042.5 6103.8 4593.4 4620.5 4623.6 4629.9 4683.9 3932.7 4006.5 4008.4 4026.2 4036.2 5700.3 5718.7 5730.4 5802.7 5818.4 5945.3 5976.1 6007.3 6014.9 6017.6 5604.5 5636.0 5657.3 5730.4 5733.4 5151.4 5172.8 5180.2 5216.3 5227.6 6092.9 6123.1 6127.8 6127.8 6139.2 5847.1 5901.9 5902.2 5939.1 5959.9 6123.8 6133.7 6152.4 6153.4 6160.6 5842.7 5853.6 5865.6 5874.1 5874.7 5781.4 5917.4 5934.9 5950.1 5950.9 5858.8 5870.1 5874.4 5875.4 5962.6 5810.5 5829.6 5841.3 5848.5 5851.3 5531.6 5688.4 5815.7 5843.5 5849.8 5946.9 5947.8 5951.9 5955.9 6031.8 5734.8 5822.1 5823.1 5825.2 5828.3 22:40:50 INFO - PROCESS | 29358 | 22:40:50 INFO - PROCESS | 29358 | [#1] ext.html Cycles:180 Average:62011.17 Median:42025.69 stddev:127449.78 (303.3%) stddev-sans-first:127723.79 22:40:50 INFO - PROCESS | 29358 | Values: 554.4 574.6 601.4 603.3 642.5 38975.4 42697.0 42738.6 42974.6 43121.4 43404.3 43721.0 43972.3 44049.0 44245.8 8800.6 8838.4 8903.3 8955.1 8959.3 8714.9 8823.3 8838.8 8867.7 8879.4 8867.4 8898.1 8898.8 8920.8 8930.1 8876.2 8895.7 8899.2 8905.5 8927.6 8784.6 8822.5 8853.8 8855.3 8876.1 41524.8 41745.8 41793.6 41970.8 42632.6 3387.1 3756.1 3783.6 3913.2 4024.5 32258.0 32474.0 32636.0 33076.7 34016.5 4379.1 4385.7 4406.0 4409.4 4438.0 376220.0 377653.0 378101.0 380191.0 380592.0 35068.5 36054.0 59008.7 59237.7 59309.0 37483.4 37520.2 37523.0 37536.2 37630.6 16063.8 16112.4 16185.7 16187.1 16288.1 13616.7 13655.0 13677.8 13684.9 13688.5 8496.1 8525.7 8556.2 8613.0 8621.3 3310.1 3359.4 3366.9 3370.7 3386.6 923.9 998.4 1023.8 1102.4 1122.8 32400.7 32561.2 32712.0 32810.5 33106.5 1102.4 1201.3 1222.7 1237.9 1254.1 16787.0 17004.6 17015.4 17090.2 17292.7 551621.0 557158.0 559774.0 560445.0 560936.0 58418.4 58667.4 58938.4 59065.7 59337.1 1317.4 1320.9 1332.5 1361.4 1377.2 30246.0 31218.8 31899.7 32159.7 32321.4 49913.0 50663.5 50675.5 50709.7 50725.2 480795.0 483397.0 484225.0 484716.0 486702.0 28807.0 29285.4 29441.9 29442.3 29467.3 47543.3 50020.5 50028.7 53120.7 53150.5 41665.8 42566.4 43635.8 44230.6 44503.3 42054.0 42194.8 42474.0 44004.0 44190.6 40611.4 41154.8 41649.8 41882.4 41997.4 35486.8 37457.6 38079.6 38545.2 38919.8 28709.1 28833.9 29154.0 29241.6 29478.6 22:40:50 INFO - PROCESS | 29358 | 22:40:50 INFO - PROCESS | 29358 | [#2] jquery.html Cycles:180 Average:29437.47 Median:2719.76 stddev:82916.95 (3048.7%) stddev-sans-first:83120.89 22:40:50 INFO - PROCESS | 29358 | Values: 401.1 402.2 412.5 417.8 431.7 18209.6 19819.7 19894.1 19918.9 20459.2 19203.0 19313.3 19362.7 19368.4 19409.9 5631.4 5754.7 6015.3 6057.7 6141.8 5876.1 6026.6 6044.6 6065.7 6070.0 6006.1 6030.6 6049.4 6054.2 6061.3 5997.5 6032.5 6041.0 6466.2 6566.9 5908.5 5914.1 5916.1 5921.4 5934.2 12608.2 22057.8 23167.2 23365.9 23522.3 2411.9 2426.8 2494.7 2944.8 3016.2 10180.8 10526.0 10738.9 10747.5 11019.4 1953.3 1961.1 1984.1 2020.7 2068.5 80243.6 81393.6 81610.6 86193.6 87692.0 11110.8 11426.9 11529.3 11609.0 11716.1 16046.0 16064.5 16065.7 16069.9 16121.8 8230.5 8354.4 8358.0 8402.1 8651.6 7813.7 7888.6 7911.0 8036.8 8405.3 4859.0 4886.8 4893.3 4941.4 4992.7 1883.3 1957.5 1991.4 1999.9 2009.1 873.7 932.2 962.7 996.9 1003.4 18659.4 19050.4 19120.4 19233.0 19642.0 974.6 989.9 1012.7 1022.6 1064.9 10468.0 10792.2 10944.6 10958.6 11034.6 496920.0 500134.0 504241.0 506200.0 509937.0 78209.6 93271.0 93305.5 93592.5 94040.5 992.5 1018.8 1023.8 1024.7 1026.4 16595.1 17351.8 17718.2 17725.6 17848.7 37542.6 43080.0 43393.8 43611.8 43624.6 48081.5 55661.7 57476.1 57495.0 57857.7 8380.0 8646.9 8694.7 8724.7 8854.6 12451.7 12725.1 13338.6 13778.1 14119.9 11496.4 11942.3 11996.2 12163.9 12550.2 10611.9 11627.2 11704.5 11734.6 11823.4 11058.3 12095.8 12195.4 12468.3 12629.7 7560.6 8828.1 8878.9 8935.9 9206.9 10985.5 11253.3 11598.2 11733.6 12028.4 22:40:50 INFO - PROCESS | 29358 | 22:40:50 INFO - PROCESS | 29358 | [#3] mootools.html Cycles:180 Average:5893.91 Median:4665.00 stddev:3338.11 (71.6%) stddev-sans-first:3330.88 22:40:50 INFO - PROCESS | 29358 | Values: 1465.5 1482.4 1652.5 1741.1 1768.9 7584.9 8527.9 8871.6 9256.4 9271.8 9035.8 9117.1 9123.7 9147.1 9175.4 2396.7 2417.9 2424.2 2431.0 2449.0 2358.6 2364.8 2429.1 2431.9 2446.8 2369.0 2391.9 2392.5 2396.7 2423.1 2328.6 2340.5 2348.6 2356.1 2382.6 2302.1 2307.7 2314.7 2326.9 2344.6 8716.7 8721.5 8802.2 8831.3 8863.2 5382.5 5483.5 5541.7 5543.2 5544.2 3552.5 3564.7 3575.6 3603.9 3643.9 1212.2 1219.6 1231.1 1235.0 1274.9 12398.3 12458.7 12466.7 12487.2 12535.5 4350.1 4560.9 4662.9 4667.1 4685.4 10291.4 10336.9 10347.0 10399.7 10446.8 5299.4 5325.3 5341.7 5348.7 5363.5 4302.7 4824.6 4825.5 4963.9 4976.7 3921.9 4039.0 4064.1 4107.4 4143.2 1328.5 1351.2 1361.5 1370.2 1373.1 926.7 985.8 1013.8 1015.9 1050.2 5965.7 5970.2 5994.5 6179.1 6268.3 482.3 483.3 504.3 507.5 509.4 4163.6 4191.5 4196.7 4203.4 4226.3 11010.1 11197.8 11223.7 11233.8 11299.9 11093.8 11115.1 11175.4 11195.2 11278.6 7915.3 8167.4 8251.8 8372.0 8414.2 5934.6 5976.7 6056.5 6144.9 6153.5 9708.9 10031.5 10050.8 10084.7 10155.7 10036.9 10070.9 10077.9 10196.6 10209.5 7893.9 8006.6 8093.0 8437.8 8460.6 8561.2 8801.1 8813.1 8815.5 8834.9 7725.7 7730.2 7732.5 7767.7 7920.3 7480.0 7521.2 7681.3 7724.4 7872.0 6822.2 6996.9 7014.3 7030.5 7051.6 5190.1 5192.6 5379.9 5586.5 5636.4 5420.6 5463.5 5475.3 5502.8 5626.8 22:40:50 INFO - PROCESS | 29358 | 22:40:50 INFO - PROCESS | 29358 | [#4] prototype.html Cycles:180 Average:4726.32 Median:5131.38 stddev:1360.92 (26.5%) stddev-sans-first:1324.11 22:40:50 INFO - PROCESS | 29358 | Values: 329.2 342.9 350.0 355.0 355.6 5364.2 5410.6 5616.9 5652.9 5679.3 5362.0 5470.2 5474.5 5484.5 5485.1 4342.5 4376.5 4379.5 4382.7 4404.0 4179.2 4292.4 4320.3 4394.3 4413.9 4315.3 4316.3 4318.6 4335.1 4339.8 4338.0 4338.6 4351.8 4356.3 4368.2 3666.4 3886.8 3893.4 3900.4 3902.2 5373.4 5391.5 5407.4 5432.0 5441.5 5036.7 5040.4 5042.9 5065.0 5070.7 5473.8 5811.9 5824.8 5840.3 5860.8 4235.4 4250.4 4251.5 4256.4 4282.0 6033.2 6069.4 6074.2 6113.1 6116.5 4207.9 4285.6 4292.3 4404.4 4416.2 4372.8 4374.7 4375.6 4377.8 4400.8 4967.8 4993.6 5012.9 5035.9 5036.5 5713.0 5791.4 5837.5 5872.8 5918.8 1482.8 1520.1 1522.9 1523.7 1527.2 940.4 974.7 977.3 1004.6 1007.3 4837.5 4873.4 4880.7 4880.8 4899.7 5103.6 5117.7 5127.9 5128.4 5134.4 4685.4 4847.3 4853.8 4894.5 4943.4 2761.6 2762.6 2769.7 2776.5 2785.0 5275.9 5277.8 5291.6 5324.3 5330.5 4983.3 5252.0 5277.7 5292.2 5308.6 5221.1 5237.4 5247.5 5254.3 5317.6 5109.6 5120.2 5121.6 5137.4 5157.4 5101.7 5378.0 5852.0 5871.4 5877.5 6024.9 6058.7 6113.4 6115.5 6120.7 4049.3 4094.8 4111.4 4123.6 4145.3 5702.2 5766.8 5880.3 5895.3 5909.4 5763.9 5799.4 5806.8 5812.6 5817.8 5804.7 5805.2 5808.4 5811.5 5818.3 5582.2 5754.9 5794.8 5802.6 5805.0 5832.4 5838.8 5841.7 5851.2 5876.7 5337.7 5642.9 5706.7 5707.3 5710.1 22:40:50 INFO - PROCESS | 29358 | 22:40:50 INFO - PROCESS | 29358 | [#5] yui.html Cycles:180 Average:21755.68 Median:4025.05 stddev:31677.72 (787.0%) stddev-sans-first:31727.16 22:40:50 INFO - PROCESS | 29358 | Values: 708.4 737.8 752.3 820.7 865.7 15027.2 15855.4 15904.2 15916.1 15926.4 14806.3 15597.0 15725.7 15810.8 15848.9 791.3 793.7 813.6 814.7 814.8 813.9 819.2 822.3 822.6 823.0 858.5 865.7 865.9 865.9 868.7 854.8 855.5 856.2 861.4 863.5 623.7 624.9 627.3 627.9 630.5 15027.8 15061.0 15119.5 15152.4 15203.8 14282.9 14661.7 14741.1 14848.2 14919.6 12283.9 12358.1 12602.1 12898.3 12899.9 3920.4 3935.9 3988.1 4062.0 4080.4 84822.6 85382.0 85502.6 86045.2 86538.6 11291.3 11601.1 11829.3 11925.5 12109.5 22114.0 22205.9 22348.3 22395.3 22400.2 8581.6 8621.3 8773.7 8908.0 8916.1 4455.2 4457.6 4511.8 4657.7 4691.8 3604.0 3708.8 3710.6 3725.2 3765.0 615.0 615.6 615.9 624.7 639.9 571.1 578.1 615.2 686.5 719.3 9877.9 10009.8 10055.9 10202.7 10387.7 599.2 622.3 668.0 686.2 722.1 4810.2 5001.4 5013.7 5031.9 5061.6 69358.0 73861.0 122167.0 129880.0 131474.3 99972.5 102907.5 105145.0 107677.0 108929.0 94637.0 95682.6 98676.5 100007.5 101910.0 9154.5 9215.6 9363.9 9366.2 9426.1 53940.0 54558.5 55754.7 55830.4 56442.0 73980.6 77442.7 83627.6 87031.0 87253.6 12808.8 12810.0 13332.3 13441.7 13620.8 14031.3 14232.9 14319.3 14428.5 14459.1 13412.6 13655.9 14477.4 14537.2 14581.1 13868.4 13943.8 14450.1 14685.0 14865.4 13348.9 13910.9 13986.2 14116.7 14455.4 10001.8 11214.6 11250.0 11532.4 11941.4 10286.1 10699.0 10884.9 11103.8 11794.6 22:40:50 INFO - PROCESS | 29358 | -------- Summary: end -------- 22:40:50 INFO - PROCESS | 29358 | 22:40:51 INFO - TEST-INFO | 29358: exit 0 22:40:51 INFO - TEST-OK | dromaeo_css | took 1114700ms 22:40:51 INFO - TEST-START | kraken 22:40:51 INFO - operating with platform_type : linux_ 22:40:51 INFO - Initialising browser for kraken test... 22:40:51 INFO - TEST-INFO | started process 29716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpclOfBU/profile http://localhost:57388/getInfo.html) 22:40:56 INFO - PROCESS | 29716 | __metrics Screen width/height:1600/1200 22:40:56 INFO - PROCESS | 29716 | colorDepth:24 22:40:56 INFO - PROCESS | 29716 | Browser inner width/height: 1024/697 22:40:56 INFO - PROCESS | 29716 | __metrics 22:40:56 ERROR - PROCESS | 29716 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 22:40:57 INFO - TEST-INFO | 29716: exit 0 22:40:57 INFO - Browser initialized. 22:40:57 INFO - Running cycle 1/1 for kraken test... 22:40:57 INFO - TEST-INFO | started process 29839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpclOfBU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:41:09 INFO - PROCESS | 29839 | RSS: Main: 191414272 22:41:09 INFO - PROCESS | 29839 | 22:41:12 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57388/tests/kraken/driver.html?testName=audio-beat-detection) 22:41:13 INFO - PROCESS | 29839 | RSS: Main: 203833344 22:41:13 INFO - PROCESS | 29839 | 22:41:16 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57388/tests/kraken/driver.html?testName=audio-dft) 22:41:16 INFO - PROCESS | 29839 | RSS: Main: 202674176 22:41:16 INFO - PROCESS | 29839 | 22:41:19 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57388/tests/kraken/driver.html?testName=audio-fft) 22:41:20 INFO - PROCESS | 29839 | RSS: Main: 193998848 22:41:20 INFO - PROCESS | 29839 | 22:41:22 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57388/tests/kraken/driver.html?testName=audio-oscillator) 22:41:22 INFO - PROCESS | 29839 | RSS: Main: 195088384 22:41:22 INFO - PROCESS | 29839 | 22:41:25 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57388/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:41:25 INFO - PROCESS | 29839 | RSS: Main: 194936832 22:41:25 INFO - PROCESS | 29839 | 22:41:28 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57388/tests/kraken/driver.html?testName=imaging-darkroom) 22:41:29 INFO - PROCESS | 29839 | RSS: Main: 195072000 22:41:29 INFO - PROCESS | 29839 | 22:41:32 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57388/tests/kraken/driver.html?testName=imaging-desaturate) 22:41:33 INFO - PROCESS | 29839 | RSS: Main: 193216512 22:41:33 INFO - PROCESS | 29839 | 22:41:36 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57388/tests/kraken/driver.html?testName=json-parse-financial) 22:41:37 INFO - PROCESS | 29839 | RSS: Main: 194940928 22:41:37 INFO - PROCESS | 29839 | 22:41:38 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57388/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:41:39 INFO - PROCESS | 29839 | RSS: Main: 195223552 22:41:39 INFO - PROCESS | 29839 | 22:41:41 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57388/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:41:41 INFO - PROCESS | 29839 | RSS: Main: 194867200 22:41:41 INFO - PROCESS | 29839 | 22:41:43 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57388/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:41:44 INFO - PROCESS | 29839 | RSS: Main: 195383296 22:41:44 INFO - PROCESS | 29839 | 22:41:47 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:41:47 INFO - PROCESS | 29839 | RSS: Main: 195440640 22:41:47 INFO - PROCESS | 29839 | 22:41:50 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:41:51 INFO - PROCESS | 29839 | RSS: Main: 195928064 22:41:51 INFO - PROCESS | 29839 | 22:41:52 INFO - PROCESS | 29839 | Cycle 1(1): loaded http://localhost:57388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57388/tests/kraken/driver.html?testName=ai-astar) 22:41:53 INFO - PROCESS | 29839 | RSS: Main: 198008832 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | __start_tp_report 22:41:53 INFO - PROCESS | 29839 | _x_x_mozilla_page_load 22:41:53 INFO - PROCESS | 29839 | _x_x_mozilla_page_load_details 22:41:53 INFO - PROCESS | 29839 | |i|pagename|runs| 22:41:53 INFO - PROCESS | 29839 | |0;ai-astar;106;113;112;113;111;113;113;114;113;130 22:41:53 INFO - PROCESS | 29839 | |1;audio-beat-detection;154;120;151;182;123;156;150;121;174;120 22:41:53 INFO - PROCESS | 29839 | |2;audio-dft;164;163;166;175;163;165;170;162;164;164 22:41:53 INFO - PROCESS | 29839 | |3;audio-fft;76;78;75;174;77;76;74;77;160;75 22:41:53 INFO - PROCESS | 29839 | |4;audio-oscillator;83;83;145;86;83;83;148;85;82;136 22:41:53 INFO - PROCESS | 29839 | |5;imaging-gaussian-blur;117;117;117;117;119;119;118;119;118;118 22:41:53 INFO - PROCESS | 29839 | |6;imaging-darkroom;146;148;147;148;147;147;147;148;147;146 22:41:53 INFO - PROCESS | 29839 | |7;imaging-desaturate;104;97;95;96;96;96;96;96;97;97 22:41:53 INFO - PROCESS | 29839 | |8;json-parse-financial;52;52;51;54;52;56;54;55;53;53 22:41:53 INFO - PROCESS | 29839 | |9;json-stringify-tinderbox;63;63;63;63;66;62;62;65;64;63 22:41:53 INFO - PROCESS | 29839 | |10;stanford-crypto-aes;82;87;86;80;85;79;79;78;79;79 22:41:53 INFO - PROCESS | 29839 | |11;stanford-crypto-ccm;124;131;147;133;126;136;134;136;164;137 22:41:53 INFO - PROCESS | 29839 | |12;stanford-crypto-pbkdf2;165;167;167;171;168;166;163;164;166;170 22:41:53 INFO - PROCESS | 29839 | |13;stanford-crypto-sha256-iterative;66;67;67;66;68;65;64;64;68;72 22:41:53 INFO - PROCESS | 29839 | __end_tp_report 22:41:53 INFO - PROCESS | 29839 | __start_cc_report 22:41:53 INFO - PROCESS | 29839 | _x_x_mozilla_cycle_collect,801 22:41:53 INFO - PROCESS | 29839 | __end_cc_report 22:41:53 INFO - PROCESS | 29839 | __startTimestamp1472190113249__endTimestamp 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | ------- Summary: start ------- 22:41:53 INFO - PROCESS | 29839 | Number of tests: 14 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.00 stddev:6.12 (5.4%) stddev-sans-first:5.81 22:41:53 INFO - PROCESS | 29839 | Values: 106.0 113.0 112.0 113.0 111.0 113.0 113.0 114.0 113.0 130.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:152.50 stddev:23.05 (15.1%) stddev-sans-first:24.23 22:41:53 INFO - PROCESS | 29839 | Values: 154.0 120.0 151.0 182.0 123.0 156.0 150.0 121.0 174.0 120.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.50 stddev:3.98 (2.4%) stddev-sans-first:4.18 22:41:53 INFO - PROCESS | 29839 | Values: 164.0 163.0 166.0 175.0 163.0 165.0 170.0 162.0 164.0 164.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:38.53 (50.7%) stddev-sans-first:40.30 22:41:53 INFO - PROCESS | 29839 | Values: 76.0 78.0 75.0 174.0 77.0 76.0 74.0 77.0 160.0 75.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:83.00 stddev:28.88 (34.8%) stddev-sans-first:29.85 22:41:53 INFO - PROCESS | 29839 | Values: 83.0 83.0 145.0 86.0 83.0 83.0 148.0 85.0 82.0 136.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.87 22:41:53 INFO - PROCESS | 29839 | Values: 117.0 117.0 117.0 117.0 119.0 119.0 118.0 119.0 118.0 118.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 22:41:53 INFO - PROCESS | 29839 | Values: 146.0 148.0 147.0 148.0 147.0 147.0 147.0 148.0 147.0 146.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:2.54 (2.6%) stddev-sans-first:0.67 22:41:53 INFO - PROCESS | 29839 | Values: 104.0 97.0 95.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:1.55 (2.9%) stddev-sans-first:1.58 22:41:53 INFO - PROCESS | 29839 | Values: 52.0 52.0 51.0 54.0 52.0 56.0 54.0 55.0 53.0 53.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.00 stddev:1.26 (2.0%) stddev-sans-first:1.33 22:41:53 INFO - PROCESS | 29839 | Values: 63.0 63.0 63.0 63.0 66.0 62.0 62.0 65.0 64.0 63.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:3.37 (4.2%) stddev-sans-first:3.57 22:41:53 INFO - PROCESS | 29839 | Values: 82.0 87.0 86.0 80.0 85.0 79.0 79.0 78.0 79.0 79.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:136.00 stddev:11.46 (8.4%) stddev-sans-first:11.18 22:41:53 INFO - PROCESS | 29839 | Values: 124.0 131.0 147.0 133.0 126.0 136.0 134.0 136.0 164.0 137.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.00 stddev:2.50 (1.5%) stddev-sans-first:2.57 22:41:53 INFO - PROCESS | 29839 | Values: 165.0 167.0 167.0 171.0 168.0 166.0 163.0 164.0 166.0 170.0 22:41:53 INFO - PROCESS | 29839 | 22:41:53 INFO - PROCESS | 29839 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:2.36 (3.5%) stddev-sans-first:2.49 22:41:53 INFO - PROCESS | 29839 | Values: 66.0 67.0 67.0 66.0 68.0 65.0 64.0 64.0 68.0 72.0 22:41:53 INFO - PROCESS | 29839 | -------- Summary: end -------- 22:41:53 INFO - PROCESS | 29839 | 22:41:54 INFO - TEST-INFO | 29839: exit 0 22:41:54 INFO - TEST-OK | kraken | took 63282ms 22:41:54 INFO - SUITE-END | took 1177s 22:41:54 INFO - Completed test suite (00:19:38) 22:41:54 INFO - javascript benchmark 22:41:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7323.3182188948895, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.312871168343, 3128.280495486038, 3147.6694947030555, 3169.8256595887233, 3176.2218256527153, 5495.6153069285165, 5512.33851937767, 5521.97843398971, 5619.6066275360745, 5653.604247702662, 5462.617616766828, 5508.118701007839, 5559.58303127266, 5559.722013899299, 5581.2186293918885, 4820.421549414075, 4940.505949405048, 5098.286239926395, 5159.484051594848, 5196.818111366103, 5116.539511443969, 5163.0, 5163.044836705203, 5242.239875218091, 5242.266082748418, 4973.676711013773, 4995.775190116417, 5036.345275114249, 5074.391073071237, 5083.415407228179, 5050.141475949061, 5055.0, 5063.873403164914, 5084.339035925343, 5134.1528647773075, 5006.974965125151, 5044.798208071673, 5047.3438453001245, 5053.267276244961, 5108.974455127738, 5378.0, 5452.40023597404, 5514.6691198527815, 5535.25274087997, 5577.247071645316, 5930.021546444875, 5934.6142500737315, 5956.076808094752, 5956.16613674086, 5997.460228579449, 5952.880942381128, 5956.076808094752, 5961.821145365646, 6014.609050411709, 6018.097285407181, 5467.972660136674, 5530.917036244459, 5556.722163891789, 5590.832275031756, 5591.384947655754, 6114.66235542843, 6121.5845156403, 6124.300770772471, 6128.533679014772, 6137.936202632845, 5879.941200588025, 5884.705764711833, 5884.911726324109, 5886.8822623547285, 5894.233749612523, 5673.971630141906, 5928.644281343133, 5966.791162309299, 5984.222051133324, 5995.52035837132, 5747.568932330092, 5918.585699001114, 5923.022701254331, 5949.25634295713, 5990.311114221833, 6025.6083354581815, 6032.276126864805, 6040.244969378828, 6042.486388656926, 6103.755849766048, 4593.356930029799, 4620.4686461056735, 4623.606993405599, 4629.930551041737, 4683.859484215479, 3932.744371615836, 4006.4991876015497, 4008.4388185654034, 4026.2350153470748, 4036.2129384769687, 5700.25896633435, 5718.742656580381, 5730.426957304319, 5802.709864506758, 5818.389069147764, 5945.316288626776, 5976.133460648181, 6007.339192688801, 6014.909776353358, 6017.608855424383, 5604.495595396434, 5635.971820140873, 5657.264555607745, 5730.398308177665, 5733.397993210736, 5151.4333423323405, 5172.793088276502, 5180.1711726124395, 5216.295800067019, 5227.607929405233, 6092.8781424372155, 6123.08153776937, 6127.785527506516, 6127.785527506605, 6139.2325959255095, 5847.1229315603, 5901.940980590139, 5902.203202567598, 5939.07944268639, 5959.851003724768, 6123.783052809673, 6133.693315334126, 6152.384761523812, 6153.384661533811, 6160.568760186923, 5842.678652674143, 5853.590248682722, 5865.589408741347, 5874.060150375919, 5874.676892770768, 5781.392953739965, 5917.437843404869, 5934.910976335272, 5950.107483877453, 5950.880982380415, 5858.794942177004, 5870.090136028923, 5874.383189765013, 5875.441833025856, 5962.5528085394635, 5810.5061069809535, 5829.621074630136, 5841.269841269841, 5848.53211743068, 5851.297844258716, 5531.612787104864, 5688.3742788294085, 5815.709214539172, 5843.532517398513, 5849.766009359578, 5946.910796338145, 5947.762089516371, 5951.940480595139, 5955.940440595712, 6031.7587296507645, 5734.770609175586, 5822.097574875901, 5823.068309070529, 5825.2135961644635, 5828.271466066742], "value": 5498.336211369346, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.4083423471515, 574.5719439017932, 601.4406601860271, 603.2670305578722, 642.5149012495565, 38975.415368769456, 42697.0, 42738.57261427385, 42974.57025429748, 43121.35317970233, 43404.34893476601, 43721.0, 43972.3404148938, 44049.0, 44245.805587217736, 8800.647974081028, 8838.42550234236, 8903.287736981027, 8955.149260820212, 8959.328050396214, 8714.912850871506, 8823.338249631272, 8838.823223535526, 8867.68963086292, 8879.378443508956, 8867.423617464845, 8898.110188981082, 8898.777530561723, 8920.776980575472, 8930.10698930105, 8876.201141897229, 8895.73312800617, 8899.199072083544, 8905.465672059698, 8927.553622318857, 8784.560771961376, 8822.514761688104, 8853.822923541493, 8855.291576673852, 8876.112388761137, 41524.792376038225, 41745.79127104375, 41793.582064179274, 41970.79014604938, 42632.57367426317, 3387.085486918518, 3756.136088699587, 3783.5838057813617, 3913.1977944521304, 4024.5371782245124, 32258.0, 32474.0, 32636.0, 33076.66923330784, 34016.48975265373, 4379.1022840317655, 4385.736855788663, 4406.0, 4409.426774519324, 4437.977810110929, 376220.0, 377653.0, 378101.0, 380191.0, 380592.0, 35068.473972889915, 36054.0, 59008.70495647494, 59237.70381148153, 59309.0, 37483.4377484338, 37520.24959500795, 37523.0, 37536.24927501435, 37630.62369376326, 16063.839361606235, 16112.355505779871, 16185.67628647444, 16187.109708965885, 16288.104154271392, 13616.727665446635, 13655.0, 13677.794833077513, 13684.863151368558, 13688.52090176839, 8496.107908669625, 8525.658973640984, 8556.18716221958, 8612.956935215283, 8621.31029517637, 3310.1228174533767, 3359.3617212729505, 3366.865325387006, 3370.6629337066097, 3386.593608766964, 923.8845144356956, 998.4159266828987, 1023.7747695506977, 1102.4038389592554, 1122.8371886076472, 32400.67599324024, 32561.18597035093, 32712.0, 32810.50784238238, 33106.50340244898, 1102.4267380961855, 1201.285235285004, 1222.6576558563615, 1237.8611677256945, 1254.1346470935025, 16787.0, 17004.574885627957, 17015.404460843813, 17090.230939607747, 17292.65414691699, 551621.0, 557158.0, 559774.0, 560445.0, 560936.0, 58418.41581584215, 58667.4133258662, 58938.41061589415, 59065.70467147637, 59337.109943350886, 1317.440087962612, 1320.854705982341, 1332.4536939854613, 1361.4418088583436, 1377.1805775563523, 30246.0, 31218.843905780326, 31899.68100318967, 32159.67840321567, 32321.35357292888, 49913.0, 50663.49336506588, 50675.49324506855, 50709.746451268984, 50725.23912141395, 480795.0, 483397.0, 484225.0, 484716.0, 486702.0, 28807.0, 29285.41429171362, 29441.85279073591, 29442.263943401587, 29467.263318416353, 47543.286850696575, 50020.49979500158, 50028.749856250484, 53120.734396327774, 53150.4684953161, 41665.79167104145, 42566.361504578075, 43635.78182109069, 44230.55769442264, 44503.332450012625, 42054.0, 42194.78902605467, 42474.0, 44004.0, 44190.55809441993, 40611.390829136995, 41154.79422602868, 41649.79175104105, 41882.37176442295, 41997.37003945004, 35486.82256588701, 37457.62542374541, 38079.619203807604, 38545.229095418494, 38919.805400972815, 28709.138725838257, 28833.855830720713, 29154.0, 29241.561376578942, 29478.557821632265], "value": 19286.23443338153, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.0935286253067, 402.1574800792339, 412.53795748761394, 417.78066515079587, 431.65036320580333, 18209.635807283863, 19819.702704459443, 19894.10476528556, 19918.900405497952, 20459.18163273471, 19203.0, 19313.324033658824, 19362.70955935662, 19368.4189474316, 19409.902950485262, 5631.380548139701, 5754.74103665336, 6015.308239552463, 6057.697115144225, 6141.754329826824, 5876.147958546008, 6026.638401695912, 6044.576879618428, 6065.666388348639, 6070.0, 6006.099085137221, 6030.577859549811, 6049.425304596079, 6054.243219597551, 6061.302950160743, 5997.520198384119, 6032.487238584704, 6041.003234466308, 6466.191726034246, 6566.901496477557, 5908.468237858613, 5914.053751399755, 5916.083007133901, 5921.407859214044, 5934.228550288478, 12608.219971924056, 22057.779422205735, 23167.189148379894, 23365.88317058421, 23522.29433116992, 2411.855288682667, 2426.842255253403, 2494.6881639795024, 2944.823310601371, 3016.170553097894, 10180.796384072277, 10526.000029997138, 10738.946305268502, 10747.516361763739, 11019.393933333664, 1953.3163392812544, 1961.117497126299, 1984.0575726529783, 2020.737304150451, 2068.534579719566, 80243.59878200572, 81393.59303203506, 81610.59194704048, 86193.56903215506, 87692.0, 11110.833337499944, 11426.94286528562, 11529.250598711056, 11609.0, 11716.121290903046, 16046.037237765539, 16064.518064458085, 16065.678686426207, 16069.919650401907, 16121.758173627404, 8230.547319897343, 8354.373421993254, 8357.958210209032, 8402.117777633383, 8651.567421628893, 7813.726519571901, 7888.566128862853, 7911.0, 8036.83926321482, 8405.285550728257, 4858.951410485921, 4886.780094895738, 4893.290472881412, 4941.407031156285, 4992.653452877142, 1883.2655264446876, 1957.4812674641232, 1991.442396129086, 1999.9100040498213, 2009.085865930998, 873.7073080518097, 932.2495391210006, 962.6726912849665, 996.9302148849656, 1003.3979612232602, 18659.375921547926, 19050.428487145407, 19120.426387208405, 19233.0, 19642.0, 974.5560245281539, 989.8762654668167, 1012.731626119079, 1022.6267412394571, 1064.9041586257274, 10468.005539473737, 10792.190585706103, 10944.616938407118, 10958.616448424267, 11034.558617655204, 496920.0, 500134.0, 504241.0, 506200.0, 509937.0, 78209.60895195487, 93271.0, 93305.53347233355, 93592.53203734074, 94040.52979735195, 992.5087081894364, 1018.7809620931683, 1023.8259495885717, 1024.7130803375067, 1026.3585259212991, 16595.087270200256, 17351.785375023628, 17718.202680879134, 17725.55686107806, 17848.67043187388, 37542.624573753914, 43080.0, 43393.78303108464, 43611.78194109009, 43624.56375436332, 48081.5191848077, 55661.721691391285, 57476.137857933, 57495.0, 57857.710711446176, 8380.0, 8646.913530864611, 8694.739157825275, 8724.651013959625, 8854.645814167361, 12451.688707782016, 12725.109242353317, 13338.599842004756, 13778.104423212459, 14119.858801411854, 11496.367699776592, 11942.283462992249, 11996.160268781101, 12163.939180304042, 12550.246985180918, 10611.946940265248, 11627.244229125079, 11704.531818727497, 11734.589289374831, 11823.408829558315, 11058.336499810037, 12095.75808483843, 12195.390230488618, 12468.251904885736, 12629.74740505203, 7560.58416787082, 8828.07305232967, 8878.911210887809, 8935.865962010444, 9206.907930920604, 10985.505652245509, 11253.268537545033, 11598.246114002563, 11733.589324373606, 12028.398580071136], "value": 9400.768878963088, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.45045607897, 1482.4070371851262, 1652.545549973757, 1741.1120328632394, 1768.9027103509302, 7584.886226706604, 8527.914720852797, 8871.556422178897, 9256.398334108279, 9271.768205794859, 9035.819283614324, 9117.133872282138, 9123.726288211348, 9147.131022552847, 9175.357724959256, 2396.736359000513, 2417.851520527744, 2424.2363655448476, 2431.0154387473103, 2449.0448724997264, 2358.563665721847, 2364.8344615876895, 2429.149797570854, 2431.914882979096, 2446.7675570820743, 2369.040538581877, 2391.9043238270447, 2392.497575509145, 2396.7483414241515, 2423.0792298926385, 2328.6274196128625, 2340.531893621274, 2348.5537747827857, 2356.081128359941, 2382.60686986647, 2302.102180149743, 2307.699999000136, 2314.6990891184205, 2326.930192094223, 2344.601417758985, 8716.694915677985, 8721.476711397336, 8802.163794439582, 8831.3376496763, 8863.157999989991, 5382.461753824626, 5483.451654834525, 5541.722913854291, 5543.168524721284, 5544.16837474378, 3552.5381700379044, 3564.679178873888, 3575.570931488212, 3603.9279214415565, 3643.908902277438, 1212.1878341511208, 1219.603628820637, 1231.0828432817518, 1234.969125771854, 1274.898008159345, 12398.31809250491, 12458.688532786662, 12466.688332791662, 12487.188332758342, 12535.498580056877, 4350.129974005212, 4560.931586026212, 4662.883427914261, 4667.113248482845, 4685.390899183084, 10291.382517049002, 10336.948315258376, 10347.0, 10399.740006499747, 10446.791064178673, 5299.364076310867, 5325.307709997675, 5341.732913354317, 5348.732563371816, 5363.5440987516495, 4302.741835489881, 4824.565789079, 4825.469198388175, 4963.883126296554, 4976.726280054631, 3921.862734804325, 4038.9798051009557, 4064.085580744368, 4107.404426358161, 4143.212789570032, 1328.4818920620964, 1351.2029001428077, 1361.5438827992534, 1370.1984339161702, 1373.1074801379184, 926.6941909169958, 985.8422652375585, 1013.8428543575758, 1015.9339642923186, 1050.201846596592, 5965.701714914237, 5970.2238708968425, 5994.490468310155, 6179.073139029092, 6268.322424906073, 482.2693619166965, 483.2992161366033, 504.271327931136, 507.46462482081756, 509.38364578859995, 4163.562825903297, 4191.517975432804, 4196.706230563831, 4203.4115223868685, 4226.281532139544, 11010.119190464744, 11197.824228456058, 11223.663290101147, 11233.775324493465, 11299.887001129884, 11093.83359249612, 11115.055220306203, 11175.38535380562, 11195.160362972809, 11278.605248816251, 7915.327197188303, 8167.42828002046, 8251.793705157299, 8371.95814020926, 8414.200650938152, 5934.554908381975, 5976.701164941648, 6056.485198758155, 6144.907826382519, 6153.476954458921, 9708.854367184356, 10031.498425078862, 10050.798984020425, 10084.747881303027, 10155.695329140137, 10036.949815250877, 10070.899291006996, 10077.899221007696, 10196.643117490852, 10209.54057067419, 7893.881591776013, 8006.599670016592, 8092.959535202286, 8437.789055273668, 8460.619272132892, 8561.1866872647, 8801.07588703177, 8813.118688131392, 8815.515146666994, 8834.867476987722, 7725.690972361267, 7730.22697730245, 7732.497387669783, 7767.650455729393, 7920.287174154354, 7480.0, 7521.210272921265, 7681.347085497795, 7724.382049436144, 7871.960640196762, 6822.215445223863, 6996.930030699627, 7014.263502332182, 7030.50786444944, 7051.6474176292, 5190.117679994334, 5192.584593232456, 5379.865503362447, 5586.52514536269, 5636.436356364331, 5420.593455490775, 5463.453654634504, 5475.342958844804, 5502.8349149525575, 5626.774929002958], "value": 4668.906659904854, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.1829103349511, 342.874850679502, 350.044378845751, 355.01129354747036, 355.58041511017007, 5364.222187782769, 5410.56715462763, 5616.859578510534, 5652.886942261158, 5679.261695979522, 5362.034833729927, 5470.152126420401, 5474.479924407185, 5484.478974497416, 5485.120311836288, 4342.457192850894, 4376.518582955872, 4379.4963579188325, 4382.737035777847, 4403.955960440403, 4179.185058913513, 4292.356146578023, 4320.265554855667, 4394.318880573516, 4413.867583972486, 4315.266404711191, 4316.266234740102, 4318.589733975283, 4335.089631177457, 4339.849939765964, 4337.956620433818, 4338.631216346615, 4351.825926962918, 4356.259435895905, 4368.170047690928, 3666.395044817602, 3886.7667939923695, 3893.377059670439, 3900.3759398496104, 3902.180542086165, 5373.382061062989, 5391.495527906892, 5407.351117865881, 5432.0, 5441.4969114207515, 5036.6726162799305, 5040.42035165957, 5042.949570504285, 5065.049955767019, 5070.6957582545165, 5473.808416705396, 5811.912821307684, 5824.825255242349, 5840.2991641003355, 5860.765569377219, 4235.3858690490015, 4250.404943307939, 4251.532331443539, 4256.361545768129, 4281.9509220240925, 6033.245844269466, 6069.423404776539, 6074.240719910012, 6113.144159817629, 6116.510679145702, 4207.936880946788, 4285.5928686774705, 4292.291771857671, 4404.383386325917, 4416.205083085011, 4372.825086996548, 4374.650027997753, 4375.584319489643, 4377.817989142977, 4400.845970391021, 4967.751612419364, 4993.550580447777, 5012.949870501321, 5035.917277785294, 5036.496350365008, 5713.000674645761, 5791.449812267828, 5837.503812175928, 5872.76671898906, 5918.763249469973, 1482.7553453680023, 1520.1259275916393, 1522.9466968656043, 1523.6800271942795, 1527.1676936069869, 940.4216406909838, 974.6734843827397, 977.2719324103589, 1004.6031817432073, 1007.2697294461457, 4837.516248375135, 4873.41519017713, 4880.6583539152625, 4880.804767809248, 4899.730514821719, 5103.5661968733075, 5117.667351622133, 5127.923136141378, 5128.410232823198, 5134.358205224347, 4685.437747470325, 4847.345608342828, 4853.781579828917, 4894.510548945077, 4943.382077240345, 2761.613374127624, 2762.640856688658, 2769.6676398831864, 2776.486350025252, 2784.986075069652, 5275.920861187085, 5277.762500687479, 5291.576673866081, 5324.254604355393, 5330.546903513167, 4983.327250821093, 5251.973740131275, 5277.656952298088, 5292.153255479182, 5308.6462951947005, 5221.12837939132, 5237.397699264633, 5247.501487358695, 5254.343207099113, 5317.574594032468, 5109.616778741683, 5120.1567435723855, 5121.61587880903, 5137.357830271216, 5157.355330583677, 5101.668391554537, 5377.973110134424, 5851.970740146272, 5871.412858714094, 5877.471027607365, 6024.909626355696, 6058.727357269022, 6113.449789518964, 6115.541334399849, 6120.663363515049, 4049.2913740094777, 4094.795260237036, 4111.403846442309, 4123.60825721556, 4145.253854306254, 5702.201691763239, 5766.826995190151, 5880.26496687914, 5895.322037965689, 5909.379515151019, 5763.913541296968, 5799.420057994167, 5806.796762113306, 5812.570583355671, 5817.8364327133895, 5804.65172089676, 5805.245318108618, 5808.419158084158, 5811.501054546586, 5818.33089194748, 5582.190582365615, 5754.856128596819, 5794.768209271582, 5802.564807639359, 5804.9709751452665, 5832.387599302182, 5838.824835254949, 5841.737121829443, 5851.239338885917, 5876.676782776988, 5337.6797392156595, 5642.9403267807775, 5706.686132262766, 5707.286589176353, 5710.143478478261], "value": 4298.039703914119, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.4474110194051, 737.8007937856783, 752.3116348541085, 820.7373640435061, 865.7272959017911, 15027.17350545721, 15855.445059422922, 15904.20478976051, 15916.124613146287, 15926.442574509894, 14806.25968701566, 15596.986195897258, 15725.685486290267, 15810.84189158108, 15848.920755396235, 791.2996997657086, 793.7102957420543, 813.6460639621754, 814.7189219719218, 814.7840822182127, 813.9389545784061, 819.2094628683319, 822.3462347433774, 822.6010384963288, 822.995885020577, 858.5449711652834, 865.6537385045968, 865.8787769712245, 865.9307255419551, 868.68727258187, 854.7563944275882, 855.4653341661461, 856.195176534056, 861.3884142258972, 863.5207459859776, 623.663221860195, 624.9218847644045, 627.2723640576954, 627.9434850863398, 630.5365556316104, 15027.849721502755, 15061.0, 15119.54641360761, 15152.393904243818, 15203.847961520354, 14282.928585357111, 14661.706765864623, 14741.11553306805, 14848.183349915751, 14919.552413427615, 12283.877161228364, 12358.134930554865, 12602.109604251009, 12898.290594017326, 12899.871001290056, 3920.4119382092913, 3935.940960885589, 3988.082740969593, 4062.0251139726547, 4080.4491393661774, 84822.57588712078, 85382.0, 85502.57248713842, 86045.24434445694, 86538.56730716306, 11291.322520648788, 11601.12991525639, 11829.290242585472, 11925.463354149084, 12109.515619375303, 22114.0, 22205.888970555043, 22348.32955011352, 22395.32814015582, 22400.215992440186, 8581.613827377783, 8621.31029517637, 8773.736787896374, 8907.955460222658, 8916.108389161162, 4455.192344934804, 4457.621102206349, 4511.774411279423, 4657.69724967876, 4691.812327506861, 3604.0, 3708.8331025103935, 3710.5547334320054, 3725.18046029873, 3765.021094515391, 614.9969250153721, 615.6306216270202, 615.9322474527798, 624.6782906803, 639.8880195965687, 571.0862619808356, 578.1356871477169, 615.2371059885799, 686.5297271369128, 719.2591630620469, 9877.851832222523, 10009.849852252222, 10055.949720251352, 10202.744931376776, 10387.740306492398, 599.1851082527759, 622.2595111816923, 668.0413606474627, 686.2211390072304, 722.1154086244413, 4810.2063159578975, 5001.399832020108, 5013.724245166551, 5031.899362012812, 5061.5950723942, 69358.0, 73861.0, 122167.0, 129880.0, 131474.34262828625, 99972.50013749885, 102907.48546257221, 105145.0, 107677.0, 108929.0, 94637.0, 95682.57315059712, 98676.50661746645, 100007.49996249973, 101910.0, 9154.542272886196, 9215.571586404118, 9363.905693728791, 9366.203872670627, 9426.057394260519, 53940.0, 54558.45441545534, 55754.72122639361, 55830.44169558415, 56442.0, 73980.63009685132, 77442.6767196985, 83627.5818620903, 87031.0, 87253.56373218093, 12808.807867881802, 12809.975201983632, 13332.333383330988, 13441.663958401119, 13620.795688064885, 14031.298435078, 14232.857671423153, 14319.284035798377, 14428.485009073896, 14459.13245205291, 13412.597622071353, 13655.931720341334, 14477.420903164177, 14537.20045397471, 14581.125132492085, 13868.445262189804, 13943.790843137564, 14450.060746051473, 14685.0, 14865.405383784528, 13348.93325533405, 13910.860891391361, 13986.230757308445, 14116.717665646423, 14455.421783128977, 10001.849972250277, 11214.607488737855, 11250.0, 11532.36571988515, 11941.402929853646, 10286.074253317238, 10699.037086661927, 10884.861142189466, 11103.833442498208, 11794.646160615195], "value": 7710.409577718006, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 112.0, 113.0, 111.0, 113.0, 113.0, 114.0, 113.0, 130.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 120.0, 151.0, 182.0, 123.0, 156.0, 150.0, 121.0, 174.0, 120.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 166.0, 175.0, 163.0, 165.0, 170.0, 162.0, 164.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 174.0, 77.0, 76.0, 74.0, 77.0, 160.0, 75.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 145.0, 86.0, 83.0, 83.0, 148.0, 85.0, 82.0, 136.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 119.0, 119.0, 118.0, 119.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 54.0, 52.0, 56.0, 54.0, 55.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 66.0, 62.0, 62.0, 65.0, 64.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 86.0, 80.0, 85.0, 79.0, 79.0, 78.0, 79.0, 79.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 131.0, 147.0, 133.0, 126.0, 136.0, 134.0, 136.0, 164.0, 137.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 167.0, 171.0, 168.0, 166.0, 163.0, 164.0, 166.0, 170.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 68.0, 65.0, 64.0, 64.0, 68.0, 72.0], "value": 66.7, "unit": "score"}]}]} 22:41:54 INFO - Return code: 0 22:41:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:41:55 ERROR - # TBPL SUCCESS # 22:41:55 INFO - Running post-action listener: _resource_record_post_action 22:41:55 INFO - [mozharness: 2016-08-26 05:41:55.057090Z] Finished run-tests step (success) 22:41:55 INFO - Running post-run listener: _resource_record_post_run 22:41:55 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 419045376; Read time: 12; Write time: 657256 22:41:55 INFO - TinderboxPrint: CPU usage
13.4% 22:41:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:41:55 INFO - TinderboxPrint: I/O write bytes / time
419,045,376 / 657,256 22:41:55 INFO - TinderboxPrint: CPU idle
8,255.2 (86.5%) 22:41:55 INFO - TinderboxPrint: CPU user
1,216.4 (12.8%) 22:41:55 INFO - TinderboxPrint: Swap in / out
0 / 0 22:41:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 129351680; Read time: 0; Write time: 168916 22:41:55 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289288192; Read time: 0; Write time: 488316 22:41:55 INFO - Running post-run listener: _upload_blobber_files 22:41:55 INFO - Blob upload gear active. 22:41:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:41:55 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 22:41:55 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:41:55 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:41:56 INFO - (blobuploader) - INFO - Open directory for files ... 22:41:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:41:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:41:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:41:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:41:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:41:57 INFO - (blobuploader) - INFO - Done attempting. 22:41:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:41:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:41:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:42:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:42:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:42:00 INFO - (blobuploader) - INFO - Done attempting. 22:42:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:42:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:42:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:42:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:42:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:42:02 INFO - (blobuploader) - INFO - Done attempting. 22:42:02 INFO - (blobuploader) - INFO - Iteration through files over. 22:42:02 INFO - Return code: 0 22:42:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:42:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:42:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a02555bb3518f37ef28da085e0fc1bf6779db7a16dd98d35b16ab12d2afd4a97de406d8f81657ba40b57100eaf2c65d5db4d357a42a73cdc798a1bc2b8248b97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84c72d0b9dc78f147a46c2c0c7b78cacd02090627c1bff630e3a257ff67a1fb2ace701ede715f16b28bea059e859e7ab965f9c4c22ddfb691c979a302f5e1057", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f317bfa1a7e5316132f0d9d2713bfbf1963dfbeb523587afd94a2b8bf7c6eace02a4df9d732c2e0e4043508d25e1080c2ef74a3b2dee257b37081c7b4274fcdd"} 22:42:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:42:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:42:02 INFO - Contents: 22:42:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a02555bb3518f37ef28da085e0fc1bf6779db7a16dd98d35b16ab12d2afd4a97de406d8f81657ba40b57100eaf2c65d5db4d357a42a73cdc798a1bc2b8248b97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84c72d0b9dc78f147a46c2c0c7b78cacd02090627c1bff630e3a257ff67a1fb2ace701ede715f16b28bea059e859e7ab965f9c4c22ddfb691c979a302f5e1057", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f317bfa1a7e5316132f0d9d2713bfbf1963dfbeb523587afd94a2b8bf7c6eace02a4df9d732c2e0e4043508d25e1080c2ef74a3b2dee257b37081c7b4274fcdd"} 22:42:02 INFO - Running post-run listener: copy_logs_to_upload_dir 22:42:02 INFO - Copying logs to upload dir... 22:42:02 INFO - mkdir: /builds/slave/test/build/upload/logs 22:42:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.955331 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-25 22:42:01.703784) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 22:42:01.707637) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212 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/Mozilla-Inbound/sha512/a02555bb3518f37ef28da085e0fc1bf6779db7a16dd98d35b16ab12d2afd4a97de406d8f81657ba40b57100eaf2c65d5db4d357a42a73cdc798a1bc2b8248b97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84c72d0b9dc78f147a46c2c0c7b78cacd02090627c1bff630e3a257ff67a1fb2ace701ede715f16b28bea059e859e7ab965f9c4c22ddfb691c979a302f5e1057", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f317bfa1a7e5316132f0d9d2713bfbf1963dfbeb523587afd94a2b8bf7c6eace02a4df9d732c2e0e4043508d25e1080c2ef74a3b2dee257b37081c7b4274fcdd"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011557 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472178625/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a02555bb3518f37ef28da085e0fc1bf6779db7a16dd98d35b16ab12d2afd4a97de406d8f81657ba40b57100eaf2c65d5db4d357a42a73cdc798a1bc2b8248b97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84c72d0b9dc78f147a46c2c0c7b78cacd02090627c1bff630e3a257ff67a1fb2ace701ede715f16b28bea059e859e7ab965f9c4c22ddfb691c979a302f5e1057", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f317bfa1a7e5316132f0d9d2713bfbf1963dfbeb523587afd94a2b8bf7c6eace02a4df9d732c2e0e4043508d25e1080c2ef74a3b2dee257b37081c7b4274fcdd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 22:42:01.733592) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 22:42:01.733930) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1472188882.891391-219134212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 22:42:01.817007) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 22:42:01.817346) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 22:42:01.817662) ========= ========= Total master_lag: 0.15 =========