builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1474563511.9 results: success (0) buildid: 20160922092950 builduid: 9cbe538d3bc24988b34cbaf42a079e17 revision: f0e6cc6360213ba21fd98c887b55fce5c680df68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 09:58:31.904517) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 09:58:31.905188) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 09:58:31.905605) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 09:58:31.921601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:58:31.922023) ========= 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=0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 09:58:32-- 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% 43.0M=0s 2016-09-22 09:58:32 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109752 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:58:32.046230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:58:32.046548) ========= 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=0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018923 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:58:32.095474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 09:58:32.095832) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f0e6cc6360213ba21fd98c887b55fce5c680df68 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f0e6cc6360213ba21fd98c887b55fce5c680df68 --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=0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 09:58:32,836 truncating revision to first 12 chars 2016-09-22 09:58:32,836 Setting DEBUG logging. 2016-09-22 09:58:32,836 attempt 1/10 2016-09-22 09:58:32,836 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f0e6cc636021?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 09:58:33,898 unpacking tar archive at: fx-team-f0e6cc636021/testing/mozharness/ program finished with exit code 0 elapsedTime=1.387773 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 09:58:33.497140) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 09:58:33.497460) ========= script_repo_revision: f0e6cc6360213ba21fd98c887b55fce5c680df68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 09:58:33.497874) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 09:58:33.498154) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 09:58:33.512121) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-09-22 09:58:33.512483) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:58:34 INFO - MultiFileLogger online at 20160922 09:58:34 in /builds/slave/test 09:58:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:58:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:58:34 INFO - {'append_to_log': False, 09:58:34 INFO - 'base_work_dir': '/builds/slave/test', 09:58:34 INFO - 'blob_upload_branch': 'Fx-Team', 09:58:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:58:34 INFO - 'branch': 'Fx-Team', 09:58:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:58:34 INFO - 'config_files': ('talos/linux_config.py',), 09:58:34 INFO - 'default_actions': ('clobber', 09:58:34 INFO - 'read-buildbot-config', 09:58:34 INFO - 'download-and-extract', 09:58:34 INFO - 'populate-webroot', 09:58:34 INFO - 'create-virtualenv', 09:58:34 INFO - 'install', 09:58:34 INFO - 'run-tests'), 09:58:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:58:34 INFO - 'download_minidump_stackwalk': True, 09:58:34 INFO - 'download_symbols': 'ondemand', 09:58:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:58:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:58:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:58:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:58:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:58:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:58:34 INFO - 'installer_path': 'installer.exe', 09:58:34 INFO - 'log_level': 'info', 09:58:34 INFO - 'log_name': 'talos', 09:58:34 INFO - 'log_to_console': True, 09:58:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:58:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:58:34 INFO - 'opt_config_files': (), 09:58:34 INFO - 'pip_index': False, 09:58:34 INFO - 'sps_profile': False, 09:58:34 INFO - 'sps_profile_interval': 0, 09:58:34 INFO - 'suite': 'dromaeojs-e10s', 09:58:34 INFO - 'system_bits': '32', 09:58:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:58:34 INFO - 'title': 'talos-linux64-ix-017', 09:58:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:58:34 INFO - 'use_talos_json': True, 09:58:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:58:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:58:34 INFO - 'work_dir': 'build'} 09:58:34 INFO - [mozharness: 2016-09-22 16:58:34.349530Z] Running clobber step. 09:58:34 INFO - Running pre-action listener: _resource_record_pre_action 09:58:34 INFO - Running main action method: clobber 09:58:34 INFO - rmtree: /builds/slave/test/build 09:58:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:58:35 INFO - Running post-action listener: _resource_record_post_action 09:58:35 INFO - [mozharness: 2016-09-22 16:58:35.324312Z] Finished clobber step (success) 09:58:35 INFO - [mozharness: 2016-09-22 16:58:35.324411Z] Running read-buildbot-config step. 09:58:35 INFO - Running pre-action listener: _resource_record_pre_action 09:58:35 INFO - Running main action method: read_buildbot_config 09:58:35 INFO - Using buildbot properties: 09:58:35 INFO - { 09:58:35 INFO - "project": "", 09:58:35 INFO - "product": "firefox", 09:58:35 INFO - "script_repo_revision": "production", 09:58:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:58:35 INFO - "repository": "", 09:58:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 09:58:35 INFO - "buildid": "20160922092950", 09:58:35 INFO - "stage_platform": "linux64-pgo", 09:58:35 INFO - "basedir": "/builds/slave/test", 09:58:35 INFO - "buildnumber": 1194, 09:58:35 INFO - "platform": "ubuntu64_hw", 09:58:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:58:35 INFO - "slavebuilddir": "test", 09:58:35 INFO - "branch": "fx-team", 09:58:35 INFO - "revision": "f0e6cc6360213ba21fd98c887b55fce5c680df68", 09:58:35 INFO - "slavename": "talos-linux64-ix-017", 09:58:35 INFO - "builduid": "9cbe538d3bc24988b34cbaf42a079e17", 09:58:35 INFO - "repo_path": "integration/fx-team" 09:58:35 INFO - } 09:58:35 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:58:35 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 09:58:35 INFO - Running post-action listener: _resource_record_post_action 09:58:35 INFO - [mozharness: 2016-09-22 16:58:35.326794Z] Finished read-buildbot-config step (success) 09:58:35 INFO - [mozharness: 2016-09-22 16:58:35.326883Z] Running download-and-extract step. 09:58:35 INFO - Running pre-action listener: _resource_record_pre_action 09:58:35 INFO - Running main action method: download_and_extract 09:58:35 INFO - mkdir: /builds/slave/test/build/tests 09:58: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')]} 09:58:35 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:58:35 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:58:35 INFO - Downloaded 1361 bytes. 09:58:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:58:35 INFO - Using the following test package requirements: 09:58:35 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:35 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:58:35 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:58:35 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'jsshell-linux-x86_64.zip'], 09:58:35 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:58:35 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:35 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:58:35 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:58:35 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:58:35 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:58:35 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:58:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:58:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:58:35 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:58:35 INFO - Expected file size: 21943973 09:58:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:58:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:58:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:58:39 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:58:39 INFO - Expected file size: 21943973 09:58:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:58:44 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:58:44 INFO - Expected file size: 14414059 09:58: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')]} 09:58:45 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:58:45 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:58:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:58:46 INFO - Downloaded 59609451 bytes. 09:58:46 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:58:46 INFO - mkdir: /builds/slave/test/properties 09:58:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:46 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:46 INFO - Contents: 09:58:46 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:58:46 INFO - Running post-action listener: _resource_record_post_action 09:58:46 INFO - Running post-action listener: set_extra_try_arguments 09:58:46 INFO - [mozharness: 2016-09-22 16:58:46.815656Z] Finished download-and-extract step (success) 09:58:46 INFO - [mozharness: 2016-09-22 16:58:46.815918Z] Running populate-webroot step. 09:58:46 INFO - Running pre-action listener: _resource_record_pre_action 09:58:46 INFO - Running main action method: populate_webroot 09:58:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:46 INFO - '--tppagecycles', 09:58:46 INFO - '7'], 09:58:46 INFO - 'tests': ['tsvgm']}}, 09:58:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:58:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:58:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:58:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:58:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:58:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:46 INFO - 'talos_options': ['--disable-e10s'], 09:58:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:46 INFO - 'talos_options': ['--disable-e10s'], 09:58:46 INFO - 'tests': ['damp', 'tps']}, 09:58:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:46 INFO - 'tests': ['damp', 'tps']}, 09:58:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:58:46 INFO - 'tests': ['dromaeo_dom']}, 09:58:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:58:46 INFO - 'tests': ['basic_compositor_video']}, 09:58:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:58:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:58:46 INFO - 'tests': ['a11yr', 09:58:46 INFO - 'ts_paint', 09:58:46 INFO - 'tpaint', 09:58:46 INFO - 'sessionrestore', 09:58:46 INFO - 'sessionrestore_no_auto_restore', 09:58:46 INFO - 'tabpaint']}, 09:58:46 INFO - 'other-e10s': {'tests': ['a11yr', 09:58:46 INFO - 'ts_paint', 09:58:46 INFO - 'tpaint', 09:58:46 INFO - 'sessionrestore', 09:58:46 INFO - 'sessionrestore_no_auto_restore', 09:58:46 INFO - 'tabpaint']}, 09:58:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:58:46 INFO - 'ts_paint', 09:58:46 INFO - 'tpaint', 09:58:46 INFO - 'sessionrestore', 09:58:46 INFO - 'sessionrestore_no_auto_restore', 09:58:46 INFO - 'tabpaint']}, 09:58:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:58:46 INFO - 'ts_paint', 09:58:46 INFO - 'tpaint', 09:58:46 INFO - 'sessionrestore', 09:58:46 INFO - 'sessionrestore_no_auto_restore', 09:58:46 INFO - 'tabpaint']}, 09:58:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:58:46 INFO - 'tests': ['a11yr', 09:58:46 INFO - 'ts_paint', 09:58:46 INFO - 'tpaint', 09:58:46 INFO - 'sessionrestore', 09:58:46 INFO - 'sessionrestore_no_auto_restore', 09:58:46 INFO - 'tabpaint']}, 09:58:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:58:46 INFO - 'tests': ['a11yr', 09:58:46 INFO - 'ts_paint', 09:58:46 INFO - 'tpaint', 09:58:46 INFO - 'sessionrestore', 09:58:46 INFO - 'sessionrestore_no_auto_restore', 09:58:46 INFO - 'tabpaint']}, 09:58:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:58:46 INFO - 'tests': ['tsvgx', 09:58:46 INFO - 'tsvgr_opacity', 09:58:46 INFO - 'tart', 09:58:46 INFO - 'tscrollx', 09:58:46 INFO - 'cart']}, 09:58:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:58:46 INFO - 'tsvgr_opacity', 09:58:46 INFO - 'tart', 09:58:46 INFO - 'tscrollx', 09:58:46 INFO - 'cart']}, 09:58:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:46 INFO - 'talos_options': ['--disable-e10s'], 09:58:46 INFO - 'tests': ['tp5o']}, 09:58:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:46 INFO - 'tests': ['tp5o']}, 09:58:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:46 INFO - 'talos_options': ['--disable-e10s', 09:58:46 INFO - '--xperf_path', 09:58:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:46 INFO - 'tests': ['tp5n']}, 09:58:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:46 INFO - 'talos_options': ['--xperf_path', 09:58:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:46 INFO - 'tests': ['tp5n']}}, 09:58:46 INFO - 'talos.zip': {'path': '', 09:58:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:46 INFO - Running post-action listener: _resource_record_post_action 09:58:46 INFO - [mozharness: 2016-09-22 16:58:46.836763Z] Finished populate-webroot step (success) 09:58:46 INFO - [mozharness: 2016-09-22 16:58:46.836852Z] Running create-virtualenv step. 09:58:46 INFO - Running pre-action listener: _resource_record_pre_action 09:58:46 INFO - Running main action method: create_virtualenv 09:58:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58:46 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 09:58:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:46 INFO - Using real prefix '/usr' 09:58:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:49 INFO - Installing pip.................done. 09:58:49 INFO - Return code: 0 09:58:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9414f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce790>, '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 0x27cf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cfb20>, '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': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', '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 09:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:58:49 INFO - Using env: {'DISPLAY': ':0', 09:58:49 INFO - 'HOME': '/home/cltbld', 09:58:49 INFO - 'LANG': 'en_US.UTF-8', 09:58:49 INFO - 'LANGUAGE': 'en_US:en', 09:58:49 INFO - 'LOGNAME': 'cltbld', 09:58:49 INFO - 'MAIL': '/var/mail/cltbld', 09:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:49 INFO - 'MOZ_NO_REMOTE': '1', 09:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:49 INFO - 'NO_EM_RESTART': '1', 09:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:49 INFO - 'PWD': '/builds/slave/test', 09:58:49 INFO - 'SHELL': '/bin/bash', 09:58:49 INFO - 'SHLVL': '1', 09:58:49 INFO - 'TERM': 'linux', 09:58:49 INFO - 'TMOUT': '86400', 09:58:49 INFO - 'USER': 'cltbld', 09:58:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', 09:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:49 INFO - '_': '/tools/buildbot/bin/python'} 09:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:49 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 09:58:49 INFO - Cleaning up... 09:58:49 INFO - Return code: 0 09:58:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9414f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce790>, '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 0x27cf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cfb20>, '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': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', '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 09:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:58:49 INFO - Using env: {'DISPLAY': ':0', 09:58:49 INFO - 'HOME': '/home/cltbld', 09:58:49 INFO - 'LANG': 'en_US.UTF-8', 09:58:49 INFO - 'LANGUAGE': 'en_US:en', 09:58:49 INFO - 'LOGNAME': 'cltbld', 09:58:49 INFO - 'MAIL': '/var/mail/cltbld', 09:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:49 INFO - 'MOZ_NO_REMOTE': '1', 09:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:49 INFO - 'NO_EM_RESTART': '1', 09:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:49 INFO - 'PWD': '/builds/slave/test', 09:58:49 INFO - 'SHELL': '/bin/bash', 09:58:49 INFO - 'SHLVL': '1', 09:58:49 INFO - 'TERM': 'linux', 09:58:49 INFO - 'TMOUT': '86400', 09:58:49 INFO - 'USER': 'cltbld', 09:58:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', 09:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:49 INFO - '_': '/tools/buildbot/bin/python'} 09:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:49 INFO - Downloading/unpacking psutil>=3.1.1 09:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:51 INFO - Installing collected packages: psutil 09:58:51 INFO - Running setup.py install for psutil 09:58:51 INFO - building 'psutil._psutil_linux' extension 09:58:51 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 09:58:52 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 09:58:52 INFO - building 'psutil._psutil_posix' extension 09:58:52 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 09:58:52 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 09:58:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:52 INFO - Successfully installed psutil 09:58:52 INFO - Cleaning up... 09:58:52 INFO - Return code: 0 09:58:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9414f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce790>, '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 0x27cf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cfb20>, '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': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', '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 09:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:58:52 INFO - Using env: {'DISPLAY': ':0', 09:58:52 INFO - 'HOME': '/home/cltbld', 09:58:52 INFO - 'LANG': 'en_US.UTF-8', 09:58:52 INFO - 'LANGUAGE': 'en_US:en', 09:58:52 INFO - 'LOGNAME': 'cltbld', 09:58:52 INFO - 'MAIL': '/var/mail/cltbld', 09:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:52 INFO - 'MOZ_NO_REMOTE': '1', 09:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:52 INFO - 'NO_EM_RESTART': '1', 09:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:52 INFO - 'PWD': '/builds/slave/test', 09:58:52 INFO - 'SHELL': '/bin/bash', 09:58:52 INFO - 'SHLVL': '1', 09:58:52 INFO - 'TERM': 'linux', 09:58:52 INFO - 'TMOUT': '86400', 09:58:52 INFO - 'USER': 'cltbld', 09:58:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', 09:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:52 INFO - '_': '/tools/buildbot/bin/python'} 09:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:58:54 INFO - Installing collected packages: mozsystemmonitor 09:58:54 INFO - Running setup.py install for mozsystemmonitor 09:58:54 INFO - Successfully installed mozsystemmonitor 09:58:54 INFO - Cleaning up... 09:58:54 INFO - Return code: 0 09:58:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:54 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 0x7f9414f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce790>, '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 0x27cf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cfb20>, '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': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', '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 09:58:54 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 09:58:54 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 09:58:54 INFO - Using env: {'DISPLAY': ':0', 09:58:54 INFO - 'HOME': '/home/cltbld', 09:58:54 INFO - 'LANG': 'en_US.UTF-8', 09:58:54 INFO - 'LANGUAGE': 'en_US:en', 09:58:54 INFO - 'LOGNAME': 'cltbld', 09:58:54 INFO - 'MAIL': '/var/mail/cltbld', 09:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:54 INFO - 'MOZ_NO_REMOTE': '1', 09:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:54 INFO - 'NO_EM_RESTART': '1', 09:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:54 INFO - 'PWD': '/builds/slave/test', 09:58:54 INFO - 'SHELL': '/bin/bash', 09:58:54 INFO - 'SHLVL': '1', 09:58:54 INFO - 'TERM': 'linux', 09:58:54 INFO - 'TMOUT': '86400', 09:58:54 INFO - 'USER': 'cltbld', 09:58:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', 09:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:54 INFO - '_': '/tools/buildbot/bin/python'} 09:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:54 INFO - Downloading/unpacking jsonschema==2.5.1 09:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:57 INFO - warning: no files found matching '*.txt' 09:58:57 INFO - no previously-included directories found matching 'build' 09:58:57 INFO - no previously-included directories found matching 'dist' 09:58:57 INFO - no previously-included directories found matching '.git*' 09:58:57 INFO - Installing collected packages: jsonschema, functools32 09:58:57 INFO - Running setup.py install for functools32 09:58:57 INFO - warning: no files found matching '*.txt' 09:58:57 INFO - no previously-included directories found matching 'build' 09:58:57 INFO - no previously-included directories found matching 'dist' 09:58:57 INFO - no previously-included directories found matching '.git*' 09:58:57 INFO - Successfully installed jsonschema functools32 09:58:57 INFO - Cleaning up... 09:58:57 INFO - Return code: 0 09:58:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:57 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 0x7f9414f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce790>, '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 0x27cf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cfb20>, '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': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', '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 09:58:57 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 09:58:57 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 09:58:57 INFO - Using env: {'DISPLAY': ':0', 09:58:57 INFO - 'HOME': '/home/cltbld', 09:58:57 INFO - 'LANG': 'en_US.UTF-8', 09:58:57 INFO - 'LANGUAGE': 'en_US:en', 09:58:57 INFO - 'LOGNAME': 'cltbld', 09:58:57 INFO - 'MAIL': '/var/mail/cltbld', 09:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:57 INFO - 'MOZ_NO_REMOTE': '1', 09:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:57 INFO - 'NO_EM_RESTART': '1', 09:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:57 INFO - 'PWD': '/builds/slave/test', 09:58:57 INFO - 'SHELL': '/bin/bash', 09:58:57 INFO - 'SHLVL': '1', 09:58:57 INFO - 'TERM': 'linux', 09:58:57 INFO - 'TMOUT': '86400', 09:58:57 INFO - 'USER': 'cltbld', 09:58:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', 09:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:57 INFO - '_': '/tools/buildbot/bin/python'} 09:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:58:57 INFO - Cleaning up... 09:58:57 INFO - Return code: 0 09:58:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:57 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 0x7f9414f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce790>, '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 0x27cf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cfb20>, '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': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', '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 09:58:57 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 09:58:57 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 09:58:57 INFO - Using env: {'DISPLAY': ':0', 09:58:57 INFO - 'HOME': '/home/cltbld', 09:58:57 INFO - 'LANG': 'en_US.UTF-8', 09:58:57 INFO - 'LANGUAGE': 'en_US:en', 09:58:57 INFO - 'LOGNAME': 'cltbld', 09:58:57 INFO - 'MAIL': '/var/mail/cltbld', 09:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:57 INFO - 'MOZ_NO_REMOTE': '1', 09:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:57 INFO - 'NO_EM_RESTART': '1', 09:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:57 INFO - 'PWD': '/builds/slave/test', 09:58:57 INFO - 'SHELL': '/bin/bash', 09:58:57 INFO - 'SHLVL': '1', 09:58:57 INFO - 'TERM': 'linux', 09:58:57 INFO - 'TMOUT': '86400', 09:58:57 INFO - 'USER': 'cltbld', 09:58:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', 09:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:57 INFO - '_': '/tools/buildbot/bin/python'} 09:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:57 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 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 09:58:59 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:59 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 09:58:59 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 09:58:59 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 09:58:59 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 09:58:59 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 09:58:59 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 09:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:59:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:00 INFO - Downloading docopt-0.6.1.tar.gz 09:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:59:00 INFO - Installing collected packages: blobuploader, requests, docopt 09:59:00 INFO - Running setup.py install for blobuploader 09:59:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:59:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:59:00 INFO - Running setup.py install for requests 09:59:00 INFO - Running setup.py install for docopt 09:59:00 INFO - Successfully installed blobuploader requests docopt 09:59:00 INFO - Cleaning up... 09:59:00 INFO - Return code: 0 09:59:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:00 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 0x7f9414f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce790>, '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 0x27cf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cfb20>, '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': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', '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 09:59:00 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 09:59:00 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 09:59:00 INFO - Using env: {'DISPLAY': ':0', 09:59:00 INFO - 'HOME': '/home/cltbld', 09:59:00 INFO - 'LANG': 'en_US.UTF-8', 09:59:00 INFO - 'LANGUAGE': 'en_US:en', 09:59:00 INFO - 'LOGNAME': 'cltbld', 09:59:00 INFO - 'MAIL': '/var/mail/cltbld', 09:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:00 INFO - 'MOZ_NO_REMOTE': '1', 09:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:00 INFO - 'NO_EM_RESTART': '1', 09:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:00 INFO - 'PWD': '/builds/slave/test', 09:59:00 INFO - 'SHELL': '/bin/bash', 09:59:00 INFO - 'SHLVL': '1', 09:59:00 INFO - 'TERM': 'linux', 09:59:00 INFO - 'TMOUT': '86400', 09:59:00 INFO - 'USER': 'cltbld', 09:59:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', 09:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:00 INFO - '_': '/tools/buildbot/bin/python'} 09:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:01 INFO - Running setup.py (path:/tmp/pip-oTHkwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:01 INFO - Running setup.py (path:/tmp/pip-LRprg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:01 INFO - Running setup.py (path:/tmp/pip-OERATm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:01 INFO - Running setup.py (path:/tmp/pip-noLoFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:01 INFO - Running setup.py (path:/tmp/pip-QXAtE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:01 INFO - Running setup.py (path:/tmp/pip-S6aVws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:01 INFO - Running setup.py (path:/tmp/pip-mpV5e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:01 INFO - Running setup.py (path:/tmp/pip-ax_74H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:01 INFO - Running setup.py (path:/tmp/pip-IKMUEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:01 INFO - Running setup.py (path:/tmp/pip-10vjFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:01 INFO - Running setup.py (path:/tmp/pip-m5V4qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:01 INFO - Running setup.py (path:/tmp/pip-Oamk3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:02 INFO - Running setup.py (path:/tmp/pip-oAauzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:02 INFO - Running setup.py (path:/tmp/pip-yQzIeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:02 INFO - Running setup.py (path:/tmp/pip-ruCn9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:02 INFO - Running setup.py (path:/tmp/pip-GmcqsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:02 INFO - Running setup.py (path:/tmp/pip-QaETEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:59:02 INFO - Running setup.py install for manifestparser 09:59:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:59:02 INFO - Running setup.py install for mozcrash 09:59:02 INFO - Running setup.py install for mozdebug 09:59:02 INFO - Running setup.py install for mozdevice 09:59:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:59:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:59:02 INFO - Running setup.py install for mozfile 09:59:02 INFO - Running setup.py install for mozhttpd 09:59:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:59:03 INFO - Running setup.py install for mozinfo 09:59:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:59:03 INFO - Running setup.py install for mozInstall 09:59:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:59:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:59:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:59:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:59:03 INFO - Running setup.py install for mozleak 09:59:03 INFO - Running setup.py install for mozlog 09:59:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:59:03 INFO - Running setup.py install for moznetwork 09:59:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:59:03 INFO - Running setup.py install for mozprocess 09:59:03 INFO - Running setup.py install for mozprofile 09:59:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:59:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:59:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:59:03 INFO - Running setup.py install for mozrunner 09:59:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:59:03 INFO - Running setup.py install for mozscreenshot 09:59:03 INFO - Running setup.py install for moztest 09:59:04 INFO - Running setup.py install for mozversion 09:59:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:59:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:59:04 INFO - Cleaning up... 09:59:04 INFO - Return code: 0 09:59:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:04 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 0x7f9414f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce790>, '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 0x27cf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cfb20>, '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': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', '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 09:59:04 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 09:59:04 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 09:59:04 INFO - Using env: {'DISPLAY': ':0', 09:59:04 INFO - 'HOME': '/home/cltbld', 09:59:04 INFO - 'LANG': 'en_US.UTF-8', 09:59:04 INFO - 'LANGUAGE': 'en_US:en', 09:59:04 INFO - 'LOGNAME': 'cltbld', 09:59:04 INFO - 'MAIL': '/var/mail/cltbld', 09:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:04 INFO - 'MOZ_NO_REMOTE': '1', 09:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:04 INFO - 'NO_EM_RESTART': '1', 09:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:04 INFO - 'PWD': '/builds/slave/test', 09:59:04 INFO - 'SHELL': '/bin/bash', 09:59:04 INFO - 'SHLVL': '1', 09:59:04 INFO - 'TERM': 'linux', 09:59:04 INFO - 'TMOUT': '86400', 09:59:04 INFO - 'USER': 'cltbld', 09:59:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', 09:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:04 INFO - '_': '/tools/buildbot/bin/python'} 09:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:04 INFO - Running setup.py (path:/tmp/pip-pxRcOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:04 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)) 09:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:04 INFO - Running setup.py (path:/tmp/pip-bMqwEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:04 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)) 09:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:04 INFO - Running setup.py (path:/tmp/pip-qpeU5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:04 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)) 09:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:04 INFO - Running setup.py (path:/tmp/pip-tEXlpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:04 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)) 09:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:04 INFO - Running setup.py (path:/tmp/pip-zUYIEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:04 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)) 09:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:04 INFO - Running setup.py (path:/tmp/pip-ZKTxgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:04 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)) 09:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:04 INFO - Running setup.py (path:/tmp/pip-S3gZiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:04 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)) 09:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:04 INFO - Running setup.py (path:/tmp/pip-TQW_hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:04 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)) 09:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:04 INFO - Running setup.py (path:/tmp/pip-C7eA8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:05 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)) 09:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:05 INFO - Running setup.py (path:/tmp/pip-qqrQhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 09:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:05 INFO - Running setup.py (path:/tmp/pip-Vg71_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:05 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)) 09:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:05 INFO - Running setup.py (path:/tmp/pip-2CJOD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:05 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)) 09:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:05 INFO - Running setup.py (path:/tmp/pip-eEE22n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:05 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)) 09:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:05 INFO - Running setup.py (path:/tmp/pip-pRZIJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:05 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)) 09:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:05 INFO - Running setup.py (path:/tmp/pip-lzO_F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:05 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)) 09:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:05 INFO - Running setup.py (path:/tmp/pip-M9jn1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:05 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)) 09:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:05 INFO - Running setup.py (path:/tmp/pip-6h4zMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:05 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)) 09:59:05 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)) 09:59:05 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)) 09:59:05 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)) 09:59:05 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)) 09:59:05 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)) 09:59:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:59:05 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 09:59:05 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 09:59:05 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 09:59:05 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 09:59:05 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 09:59:05 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 09:59:07 INFO - Downloading blessings-1.6.tar.gz 09:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:59:07 INFO - Installing collected packages: blessings 09:59:07 INFO - Running setup.py install for blessings 09:59:07 INFO - Successfully installed blessings 09:59:07 INFO - Cleaning up... 09:59:07 INFO - Return code: 0 09:59:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:59:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:08 INFO - Reading from file tmpfile_stdout 09:59:08 INFO - Current package versions: 09:59:08 INFO - argparse == 1.2.1 09:59:08 INFO - blessings == 1.6 09:59:08 INFO - blobuploader == 1.2.4 09:59:08 INFO - docopt == 0.6.1 09:59:08 INFO - functools32 == 3.2.3-2 09:59:08 INFO - jsonschema == 2.5.1 09:59:08 INFO - manifestparser == 1.1 09:59:08 INFO - mozInstall == 1.12 09:59:08 INFO - mozcrash == 0.17 09:59:08 INFO - mozdebug == 0.1 09:59:08 INFO - mozdevice == 0.48 09:59:08 INFO - mozfile == 1.2 09:59:08 INFO - mozhttpd == 0.7 09:59:08 INFO - mozinfo == 0.9 09:59:08 INFO - mozleak == 0.1 09:59:08 INFO - mozlog == 3.4 09:59:08 INFO - moznetwork == 0.27 09:59:08 INFO - mozprocess == 0.23 09:59:08 INFO - mozprofile == 0.28 09:59:08 INFO - mozrunner == 6.12 09:59:08 INFO - mozscreenshot == 0.1 09:59:08 INFO - mozsystemmonitor == 0.3 09:59:08 INFO - moztest == 0.7 09:59:08 INFO - mozversion == 1.4 09:59:08 INFO - psutil == 3.1.1 09:59:08 INFO - requests == 1.2.3 09:59:08 INFO - wsgiref == 0.1.2 09:59:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:08 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')]} 09:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:08 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')]} 09:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:08 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 0x7f9414f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce790>, '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 0x27cf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cfb20>, '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': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', '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 09:59:08 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 09:59:08 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 09:59:08 INFO - Using env: {'DISPLAY': ':0', 09:59:08 INFO - 'HOME': '/home/cltbld', 09:59:08 INFO - 'LANG': 'en_US.UTF-8', 09:59:08 INFO - 'LANGUAGE': 'en_US:en', 09:59:08 INFO - 'LOGNAME': 'cltbld', 09:59:08 INFO - 'MAIL': '/var/mail/cltbld', 09:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:08 INFO - 'MOZ_NO_REMOTE': '1', 09:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:08 INFO - 'NO_EM_RESTART': '1', 09:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:08 INFO - 'PWD': '/builds/slave/test', 09:59:08 INFO - 'SHELL': '/bin/bash', 09:59:08 INFO - 'SHLVL': '1', 09:59:08 INFO - 'TERM': 'linux', 09:59:08 INFO - 'TMOUT': '86400', 09:59:08 INFO - 'USER': 'cltbld', 09:59:08 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', 09:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:08 INFO - '_': '/tools/buildbot/bin/python'} 09:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:08 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)) 09:59:08 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)) 09:59:08 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)) 09:59:08 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)) 09:59:08 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)) 09:59:08 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)) 09:59:08 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)) 09:59:08 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)) 09:59:08 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)) 09:59:08 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)) 09:59:08 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)) 09:59:08 INFO - Cleaning up... 09:59:08 INFO - Return code: 0 09:59:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:59:08 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')]} 09:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:08 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')]} 09:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:08 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 0x7f9414f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce790>, '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 0x27cf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cfb20>, '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': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', '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 09:59:08 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 09:59:08 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 09:59:08 INFO - Using env: {'DISPLAY': ':0', 09:59:08 INFO - 'HOME': '/home/cltbld', 09:59:08 INFO - 'LANG': 'en_US.UTF-8', 09:59:08 INFO - 'LANGUAGE': 'en_US:en', 09:59:08 INFO - 'LOGNAME': 'cltbld', 09:59:08 INFO - 'MAIL': '/var/mail/cltbld', 09:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:08 INFO - 'MOZ_NO_REMOTE': '1', 09:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:08 INFO - 'NO_EM_RESTART': '1', 09:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:08 INFO - 'PWD': '/builds/slave/test', 09:59:08 INFO - 'SHELL': '/bin/bash', 09:59:08 INFO - 'SHLVL': '1', 09:59:08 INFO - 'TERM': 'linux', 09:59:08 INFO - 'TMOUT': '86400', 09:59:08 INFO - 'USER': 'cltbld', 09:59:08 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', 09:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:08 INFO - '_': '/tools/buildbot/bin/python'} 09:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:59:08 INFO - Cleaning up... 09:59:08 INFO - Return code: 0 09:59:08 INFO - Running post-action listener: _resource_record_post_action 09:59:08 INFO - Running post-action listener: _start_resource_monitoring 09:59:08 INFO - Starting resource monitoring. 09:59:08 INFO - [mozharness: 2016-09-22 16:59:08.469247Z] Finished create-virtualenv step (success) 09:59:08 INFO - [mozharness: 2016-09-22 16:59:08.469757Z] Running install step. 09:59:08 INFO - Running pre-action listener: _resource_record_pre_action 09:59:08 INFO - Running main action method: install 09:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:08 INFO - Reading from file tmpfile_stdout 09:59:08 INFO - Detecting whether we're running mozinstall >=1.0... 09:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:59:08 INFO - Reading from file tmpfile_stdout 09:59:08 INFO - Output received: 09:59:08 INFO - Usage: mozinstall [options] installer 09:59:08 INFO - Options: 09:59:08 INFO - -h, --help show this help message and exit 09:59:08 INFO - -d DEST, --destination=DEST 09:59:08 INFO - Directory to install application into. [default: 09:59:08 INFO - "/builds/slave/test"] 09:59:08 INFO - --app=APP Application being installed. [default: firefox] 09:59:08 INFO - mkdir: /builds/slave/test/build/application 09:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:59:25 INFO - Reading from file tmpfile_stdout 09:59:25 INFO - Output received: 09:59:25 INFO - /builds/slave/test/build/application/firefox/firefox 09:59:25 INFO - Running post-action listener: _resource_record_post_action 09:59:25 INFO - [mozharness: 2016-09-22 16:59:25.769544Z] Finished install step (success) 09:59:25 INFO - [mozharness: 2016-09-22 16:59:25.769787Z] Running run-tests step. 09:59:25 INFO - Running pre-action listener: _resource_record_pre_action 09:59:25 INFO - Running main action method: run_tests 09:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:59:25 INFO - Python 2.7.3 09:59:25 INFO - Return code: 0 09:59:25 INFO - grabbing minidump binary from tooltool 09:59: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')]} 09:59:25 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 0x27ce790>, '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 0x27cf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:59:25 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 09:59:25 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 09:59:25 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 09:59:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:25 INFO - Return code: 0 09:59:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:59:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:59:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:59:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:59:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 09:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 09:59:25 INFO - Using env: {'DISPLAY': ':0', 09:59:25 INFO - 'HOME': '/home/cltbld', 09:59:25 INFO - 'LANG': 'en_US.UTF-8', 09:59:25 INFO - 'LANGUAGE': 'en_US:en', 09:59:25 INFO - 'LOGNAME': 'cltbld', 09:59:25 INFO - 'MAIL': '/var/mail/cltbld', 09:59:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:59:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:25 INFO - 'MOZ_NO_REMOTE': '1', 09:59:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:25 INFO - 'NO_EM_RESTART': '1', 09:59:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:25 INFO - 'PWD': '/builds/slave/test', 09:59:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:59:25 INFO - 'SHELL': '/bin/bash', 09:59:25 INFO - 'SHLVL': '1', 09:59:25 INFO - 'TERM': 'linux', 09:59:25 INFO - 'TMOUT': '86400', 09:59:25 INFO - 'USER': 'cltbld', 09:59:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120', 09:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:25 INFO - '_': '/tools/buildbot/bin/python'} 09:59:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 09:59:26 INFO - mozversion application_buildid: 20160922063015 09:59:26 INFO - mozversion application_changeset: f0e6cc6360213ba21fd98c887b55fce5c680df68 09:59:26 INFO - mozversion application_display_name: Nightly 09:59:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:26 INFO - mozversion application_name: Firefox 09:59:26 INFO - mozversion application_remotingname: firefox 09:59:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:59:26 INFO - mozversion application_vendor: Mozilla 09:59:26 INFO - mozversion application_version: 52.0a1 09:59:26 INFO - mozversion platform_buildid: 20160922063015 09:59:26 INFO - mozversion platform_changeset: f0e6cc6360213ba21fd98c887b55fce5c680df68 09:59:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:59:26 INFO - mozversion platform_version: 52.0a1 09:59:26 INFO - using testdate: 1474563566 09:59:26 INFO - actual date: 1474563566 09:59:26 INFO - starting webserver on 'localhost:53601' 09:59:26 INFO - SUITE-START | Running 2 tests 09:59:26 INFO - TEST-START | dromaeo_css 09:59:26 INFO - operating with platform_type : linux_ 09:59:26 INFO - Initialising browser for dromaeo_css test... 09:59:26 INFO - TEST-INFO | started process 3271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMYPfxH/profile http://localhost:53601/getInfo.html) 09:59:30 INFO - PROCESS | 3271 | __metrics Screen width/height:1600/1200 09:59:30 INFO - PROCESS | 3271 | colorDepth:24 09:59:30 INFO - PROCESS | 3271 | Browser inner width/height: 1024/697 09:59:30 INFO - PROCESS | 3271 | __metrics 09:59:30 ERROR - PROCESS | 3271 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 09:59:31 INFO - TEST-INFO | 3271: exit 0 09:59:31 INFO - Browser initialized. 09:59:31 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:31 INFO - TEST-INFO | started process 3396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMYPfxH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:43 INFO - PROCESS | 3396 | RSS: Main: 184684544 09:59:43 INFO - PROCESS | 3396 | 10:00:33 INFO - PROCESS | 3396 | 1474563633611 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] 10:02:43 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:53601/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53601/tests/dromaeo/cssquery-ext.html) 10:02:45 INFO - PROCESS | 3396 | RSS: Main: 201850880 10:02:45 INFO - PROCESS | 3396 | 10:05:47 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:53601/tests/dromaeo/cssquery-ext.html (next: http://localhost:53601/tests/dromaeo/cssquery-jquery.html) 10:05:47 INFO - PROCESS | 3396 | RSS: Main: 197193728 10:05:47 INFO - PROCESS | 3396 | 10:08:49 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:53601/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53601/tests/dromaeo/cssquery-mootools.html) 10:08:50 INFO - PROCESS | 3396 | RSS: Main: 197885952 10:08:50 INFO - PROCESS | 3396 | 10:11:52 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:53601/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53601/tests/dromaeo/cssquery-prototype.html) 10:11:52 INFO - PROCESS | 3396 | RSS: Main: 194387968 10:11:52 INFO - PROCESS | 3396 | 10:14:55 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:53601/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53601/tests/dromaeo/cssquery-yui.html) 10:14:56 INFO - PROCESS | 3396 | RSS: Main: 197742592 10:14:56 INFO - PROCESS | 3396 | 10:17:59 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:53601/tests/dromaeo/cssquery-yui.html (next: http://localhost:53601/tests/dromaeo/cssquery-dojo.html) 10:17:59 INFO - PROCESS | 3396 | RSS: Main: 198402048 10:17:59 INFO - PROCESS | 3396 | 10:17:59 INFO - PROCESS | 3396 | __start_tp_report 10:17:59 INFO - PROCESS | 3396 | _x_x_mozilla_page_load 10:17:59 INFO - PROCESS | 3396 | _x_x_mozilla_page_load_details 10:17:59 INFO - PROCESS | 3396 | |i|pagename|runs| 10:17:59 INFO - PROCESS | 3396 | |0;dojo.html;3017.6831432699564;3047.801892876962;3065.9080227593167;3066.7699922505817;3105.673904240053;5302.3902251241025;5367.785288588457;5418.647787893784;5429.077056900326;5471.316085489314;5404.162354835007;5421.512063914247;5442.91835622466;5451.863703407417;5503.752331145098;4880.219164933603;5009.574186194178;5012.448630650625;5029.4216165141115;5046.44489106198;4985.40175178979;4987.501249875002;4988.800447982077;5053.974730126362;5062.797488100471;4854.199057155565;4888.095702295087;4915.213565829486;4931.65478416511;4996.075725990667;4887.36464259644;4914.385701787277;4935.185694360426;4938.4814594467425;5009.198528235502;4797.136515427222;4822.107910036654;4865.635077369176;4891.070696567641;4918.9754051229875;5264.631475796696;5299.867503312409;5337.519623233928;5347.572194224453;5347.6256662033675;5661.037623603997;5662.943370566283;5677.801276955287;5751.683657398841;5763.250777398953;5784.508316793078;5848.7075646217945;5851.297844258674;5851.76592936282;5856.648601083949;5355.919661205046;5389.110796718537;5406.972965135149;5422.484863937999;5435.293411856473;5876.44173803488;5911.645301281937;5929.881402372014;5930.851728706731;5931.703414829241;5599.692016939108;5635.154726791015;5677.148427735872;5693.829185124453;5705.258316418839;5657.32112146545;5687.800926967537;5705.600607957404;5714.05718056516;5715.514181294553;5748.798792042258;5765.769369225268;5769.278840144982;5769.826905192851;5775.33583637887;5784.421557844266;5788.652680839163;5793.594448388572;5793.884122317614;5802.767889284466;4440.35614835847;4456.7548784817145;4484.57396547334;4484.686071974996;4486.259767138451;3986.720929534905;4040.7171497995446;4051.1290072634524;4078;4134.4005119258145;5579.77245006098;5591.7483713233005;5592.608517403824;5596.804111856066;5605.607607467438;5562.554995600342;5895.587308888336;5904.261967254093;5904.704764761745;5905.822825315247;5356.437574054746;5405.729713514309;5413.242146099549;5523.061079616475;5559.6664200148125;5066.06277838601;5083.466236045236;5087.491250874957;5107.00413419387;5120.641555091108;5976.491998180203;5984.940150598525;5985.102234664835;5993.250843644544;6008.309044459943;5704.401037890962;5775.826725198251;5792.275965504312;5804.94195058044;5823.7379317931645;5859.296884373903;5898.439648233411;5930.940690593211;5933.465988061095;6003.519718422603;5647.407022262603;5648.745806438638;5652.095664693629;5653.660780353192;5664.518515926027;5686.943130568641;5689.687067211343;5737.168110623853;5748.568857335633;5759.539236860957;5589.776408943597;5647.491725744702;5654.208410822571;5670.773169073191;5701.116326969326;5627.184058311604;5627.324721033338;5636;5636.2954630671165;5643.181738647791;5556.638818476786;5562.9443705564045;5580.35825880029;5580.832575022756;5585.078462053716;5454.536364409069;5476.890462190654;5479.260299859628;5480.479354461319;5538.584606154635;5352.277442545363;5354.330708661418;5359;5360.3299587551555;5399.676019438689 10:17:59 INFO - PROCESS | 3396 | |1;ext.html;566.4024454200818;572.499063319595;581.0876923230529;595.8242318516038;596.1236981636993;42843.78578107109;44956.77521612391;44986.10027799442;48085.519144808626;48117;45047.32429013559;45671.31493027607;45839.541604583945;45864.770676146654;46042;8937.910620893805;9056.501892395916;9063.184313411792;9072.501012444312;9093.454392736425;8891.11088891109;8929.196372326489;8948.955255223715;8963.193312601865;8979.865302020475;9001.639934402616;9037.774055648595;9041.186293233608;9047.819043619123;9054.909450905472;8861.512616806072;8944.5080520572;8948.06045365237;8964.19322260993;8982.730518084469;8820.250278726317;8849.51327676984;8860.291176705849;8884.466931984038;8925.19673229406;42383;42670.57329426697;42763.35854962178;42774;42788.78605606983;3220.7262382697263;3227.8386080695873;3234;3297.604287485493;3376.7129793967542;31784.205394865312;32046.839765801255;32071.358572828412;32138.678613213804;32380;4316.740995540277;4381.824727010916;4531.388262584542;4652.883677908046;4668.043051174501;330176.0947171589;330716.3464182688;330841;331794;332770;34819.477707834405;35477.467837982455;35530.64469355325;57795.422045779844;58291;37134.628653713655;37342.8132859334;37488.25023499515;37523.249535009694;37777.24445511075;13693.041487096007;13811.102278351875;13861.445542178402;13894.374753136133;13988.370523326272;11259.774804503864;11342.659720208407;11366.772664546663;11372.203945723886;11381.487833047533;8491.19333663301;8567.614457349435;8581.613827377658;8599.39804213699;8645.827083458296;3293.983530082382;3298.835058247078;3329.9500507492407;3339.482380231068;3389.881354152593;926.9026752190923;942.3121121581147;1018.495844556949;1106.363840791548;1154.6074334726234;29830.850845745634;30820.468654324162;30841.8457907709;30928;31076.533851992237;1060.3796778884284;1079.643717573199;1086.4241951765578;1101.8512500812449;1124.5108377855659;15974.920125399298;16175.19124043793;16416.343346266254;16431.424900128677;16463.588410289598;125566;460946;461397;461850;463665;56763.148552771745;57234;57553;57593.71203144041;57681.71159144177;1213.9635810925686;1240.3984067727145;1253.5111306590436;1269.9873001270055;1273.6370134511806;29342.11973640794;29878.850605746833;30617.693823062375;30845.845770771004;30951.535726963662;47098.76450617725;47462.52537474581;47467.28799067948;47525;47603.28595071146;353711;357532;359882;359939;360124;28132.43735125327;28171.295717607223;28285.717142828307;28517.28706782264;28706;45227.321590176834;45284.094318112795;45435.318470222315;45969.77015114903;47034.529654703016;38984;39270.607293926696;40150.79924600358;40877.1824563513;41399.7930010348;39011.80494097511;39790.403143953445;40230.798846005586;41118.79440602778;41312.1737565241;39462.210755785294;39532.80233598813;39760.60239397569;39881.40177897276;40548.391774124;35031;35997.82001089978;36236.81881590681;36621.450678239315;36679.449808252364;27760.583591245744;27853.227906700657;28083.86056320556;28108.43783124367;28397.858010709813 10:17:59 INFO - PROCESS | 3396 | |2;jquery.html;388.50659662228986;393.20768651167884;393.23908237560323;396.90275882408815;421.75748944357;17862;18984.145713442893;19435.805641943578;19443.805561944395;20185.899070504664;18744.625107497843;18978.240870365167;19082.23671053156;19149.234030638792;19182.808171918277;5638.210650508932;5746.454086861752;5911.586188966774;5933.169356290123;5963.940360596382;5935.10973353996;5965.910511342333;5980.043193089106;5980.700964951757;5995.580309378345;5788.913166302509;5985.401459854023;6009.669468179249;6011.969940150293;6021.668808215546;5542.224088627595;5951.375105613892;5978.970105149447;6005.039193729004;6044.788432404866;5587.245721827542;5677.205191273225;5682.346530149044;5682.801101961411;5704.942950570483;22721;23013.53972920549;23037.53924921509;23081.88459057711;23179.420514487272;2136.4124865662066;2173.369722780392;2198.769129241439;2263.2531264682616;2288.78256565626;9675.225981921429;9811.411315321104;9847.556859941249;10114.190864730805;10165.034321739497;1888.8111188881003;1919.376301638899;1964.2437661500283;1970.7240986261934;2061.5567652954687;75275.49449011043;77519.22480775233;77870.61064694697;82380.58809705974;82982;11079.169062320358;11167.553297867995;11209.439528023566;11388.601398950997;11475.655730328104;15835.208239587975;15856.365745370287;15924.840751592568;15936;15977;7649.923500765032;7700.460967732205;7916.722914697958;7958.960205199052;7968.84062318762;7234.168070671835;7290.890636640454;7402.481826272217;7578.3179513842915;7643.827811458294;4757.619390448755;4850.902981940341;4863.173260545645;4868.9269660955115;4915.582175515121;1849.6763066463316;1937.1960636336044;1969.3796454116907;1974.6544354737864;1996.6106609211354;782.9608519574113;865.974020779365;928.3640706116197;998.3460833154296;1012.3116280929039;17495.125243738017;18906;19162.04189790505;19499;19552.360431341873;890.7594949363765;896.6727144592177;946.6308139825474;984.2470510059667;991.7818080022383;9954.253430992705;10936;10947.178961577914;10979.396133212591;10981.945090274497;387215;412891;450060;453182;453562;89187;90320.54839725759;90432.5478372617;90926;92426;940.0881145289195;944.9858252126223;982.6953644370268;985.5515740338129;993.2749093162032;16694.165291735608;16861.747073793656;17051.658966820843;17091.48725538236;17361.131943402528;40114.39828402635;40855.1828963425;41033.589664102976;41457.58542414537;41493;54781.72609136929;55899;56127;57375;57911.420885790605;8442.451240669337;8511.148885111439;8564.443311184754;8655.610497527501;8668.30653547702;10961.287516311415;12764.106512544033;12882.162659427107;13054.54309099177;13214.669633259246;10251.48742562854;10274.691759247235;10383.688489345332;10454.372737635766;10552.630657926935;10156.542955567165;10477.16182705397;10737.516811743646;10805.837912431478;10908.345499269752;10630.574777008833;10633.149348051982;10721.802030583867;10754.946225268823;10892.455377231265;7041.894371584533;7155.677994490365;7226.566406015656;8132.471389359673;8226.588670566329;9979.550920208463;10002.099811017044;10091.848622270525;10257;10322.741931451774 10:17:59 INFO - PROCESS | 3396 | |3;mootools.html;1431.9570412887613;1480.0231846980992;1619.5060506545499;1755.3329734700828;1758.8680848936333;8492.915070849289;8723.258523025535;9019.143181397756;9200.079992000796;9249.953750231249;9030.729078127666;9165.77085572861;9207.125323094295;9283.396579222346;9295.163435290822;2206.5255969966493;2236.6980457638256;2237.026893301419;2239.7984181423667;2241.7982381585653;2228.9888550557307;2235.418791114314;2251.684764133023;2269.795718385345;2278.202629079817;2228.253535065755;2232.821374290061;2258.322503249027;2260.886955652211;2270.5231901300745;2153.7092492513466;2180.8473406861526;2188.9781102188936;2195.4401627585025;2204.0853045985896;2075.242536474191;2086.415803574986;2097.28692244636;2104.9052792624216;2108.219958615322;9073.909260907438;9146.588403521791;9163.083691630784;9226.492542910137;9254.2133918617;5081.923771143436;5174.146265866128;5177.378714554277;5178.352705911761;5180.43015268324;3179.3641271745514;3219.8390080496115;3347.8995630131135;3373.9831300843584;3374.797512149279;1081.4106312059946;1087.6030248959073;1093.6718984304678;1104.9447527623668;1111.2332490581555;12232.082593805411;12341.382930853422;12385.566505172366;12400.56598019065;12444.937775311066;4348.565143485626;4420.535843736426;4502.482214545304;4548.636109111263;4567.223571992769;9677.758056048655;9729.318947673595;9743.415395076318;9764.218862490983;9835;5150.665206761549;5192.24712416705;5193.76628051731;5203.8178663746585;5204.34945631796;4309.202797482413;4394.626456751148;4832.637552183601;4833.830815921426;4909.803607855717;3600.837962291703;3711.721620878445;3725.795081270502;3785.488958990556;3807.676347510437;1087.1737479515466;1094.1684319916922;1102.6251074634663;1123.2586492914636;1125.133647091751;839.5508403004485;852.7058164933088;883.8630012348096;928.9860652090224;964.0841200859212;5578.832635020955;5699.601027928005;5700.201971723962;5741.397153298927;5835.649861008353;934.63082082577;936.990630093704;983.2183414185597;985.5614251658087;1011.9797604047877;3840.9615903840604;3970.861019864291;3986.421968814506;4042.615951484663;4078.2455245779624;10494.42280674555;11144.721381965515;11171.553137874394;11217.102631789438;11227.38249396291;11017.228793984345;11088.279261847954;11161;11161.609343673095;11167;8080.878786818203;8188.099309075997;8232.382571307176;8253;8258.545779982158;5699.601027928005;5738.139279108167;5748;5854.619449735754;5891.970540147272;9727.464989425649;9847.803043938939;9893.406395615999;9930.702078937644;9953.402795832273;9845.60617575289;10216.335938163995;10235.590576376862;10241.539130738985;10252.487375631337;6548.279689234276;6726;7445.81385465346;7555.357794587521;7563.697452102075;7995.080565735015;8136.552489613128;8225.177482251966;8365.916340836513;8390.958045209734;7449.776506704808;7768.728094516665;7921.801954950942;7932.206779322021;8145;7298.160711518243;7745.806354841174;7756.68973241064;7789.143194248742;7851.332636725942;6683.665816709243;6799.082123913208;6812.284710105368;6816.386525212754;6822.11312529368;4993.201087825931;5017.7566737161205;5057.974710126426;5123.769430375568;5319.335083114611;5056.721880296619;5065.974670126626;5108.540231379194;5174.818881339135;5179.274901513716 10:17:59 INFO - PROCESS | 3396 | |4;prototype.html;323.5858101629913;331.577239020249;332.0933850587895;332.8419000974539;341.3343979240482;5483.533899618532;5558.861028474285;5565.554755619551;5577.69322687252;5593.916091258624;5479.698616576096;5503.725283456337;5505;5508;5558.749856256468;4112.732672376301;4181.205570941526;4235.110626768383;4237.8516751913685;4268.338407546819;4285.871423857274;4286.678499112579;4287.1425714857;4302.763348015857;4309.771715061208;4268.807903644328;4277.8288868445225;4283.400323954649;4308.707387783668;4310.762908040057;3994.640482356587;4190.91618167638;4215.367694845798;4247.469066366704;4276.615104640582;3729.5710993235853;3741.3639681254253;3743.494628225182;3749.2314075614436;3753.8873833784755;5342.237061769607;5366.141417373241;5372.221027950925;5399.541039011689;5402.162664786964;4603.378543896564;4828.227483602606;4854.101991131652;4903.2645103234445;4905.2887331337115;5659.377468478464;5687.857803554903;5691.755699251428;5699.202111704365;5706.4864162225595;4098.549159592472;4105.548389677133;4105.774182419966;4113.424120623115;4115.73247738896;5792.507636850831;5879.617824841372;5889.4993925515955;5926.881462370771;5948.345681974979;4170.186813571325;4190.8533201337805;4191.7275377100395;4192.329227323614;4198.39123327122;4235.9364609530885;4237.618614324726;4241.27898257297;4254.936175957363;4282.100758840616;4630.328602352707;4833.540813622701;4847.224444088929;4902.965269413154;4907.214845624754;5696.572757043155;5706.3722990471015;5706.600537962303;5710.3433105193435;5725.484706376363;1421.964450888736;1430.8195738515767;1443.4947768281227;1445.3640398224748;1446.5804916574286;900.827903740101;941.7975135345933;958.4728399380313;984.4003494321727;1020.3163880200284;5530.281063461724;5542.528885044816;5543.695096769717;5581.553475721932;5605.719714014364;5752.338481074647;5792.391798861143;5802.564807639444;5803.651780893076;5908.970455147697;5298.761555730001;5474.178873169057;5483.835484935458;5621.072523033736;5668.489835914787;3121.562981182636;3153.038323311412;3162.968370316313;3190.5373720810353;3192.2817366092445;5827.621204621686;6188.44304012641;6210.658413787195;6230.501559875199;6259.280182779039;6034.456898879122;6045.8488537786025;6093.324335807688;6106.847328816726;6158.846028849314;6135.754569817246;6170.413810687887;6196.442320191024;6200.596961197508;6205.596636218722;5563.693996830213;5808.186853840381;5846.444587764156;5849.64902105875;5993.250843644544;5890.941090589211;5896.410358964241;5906.379830117776;5952.226210592596;5961.254843144607;5835.241418615553;6117.724702388492;6125.407394077482;6135.202423685071;6148;4216.494020717533;4231.597998190167;4236.279832428556;4275.486941567032;4286.95713042878;5968.55289331372;5984.281886173513;6001.549883758648;6008.43780617034;6012.188354572252;5622.887542249214;5743.013632910779;5766.481016708516;5783.710814459176;5821.85619765322;5741.5406767459335;5752.913706294493;5760.567957403127;5771.422857714195;5802.709864506842;5373.596980226421;5699.373068962494;5750.597458178055;5764.337101233412;5785.27684039495;5684.8294551163535;5742.511886489695;5775.682337471311;5779.035128056481;5793.3337666167245;5650.180723795109;5651.915221271766;5681.062624667049;5711.372258906192;5751.884962300647 10:17:59 INFO - PROCESS | 3396 | |5;yui.html;655.6557807151246;664.9394216225122;690.2990633783928;743.3718507860859;766.3486036868662;13801.378937947791;14651.267436628179;14684.118952862837;14715.852841471595;14774.113553186817;12572.497100115985;12642;12657.493700252002;13319.467221311135;13633.250171240577;794.5590197440418;813.8616435206;817.3992115794915;819.4673462249526;819.8811172380001;785.4737325991599;811.9147489513605;812.2608426332039;816.3061397811842;826.5082276045773;851.9105493923141;857.6269322844552;859.4628357276702;861.7759382560516;861.9569021548929;852.8976522817239;854.5599016506504;857.9270761985208;857.983289801584;858.1804376820153;624.0296339192554;627;627.9434850863398;628.4815027602247;630.7319389259592;13967;14057.71884562303;14085.788713169311;14129.505467308698;14146.151230926178;15031.173285469295;15126.924365378212;15145.318460669296;15159.545213643609;15325.386984520606;10735.194860385423;10861.750898646678;11579.826302605468;11666.416679166092;11802.350870702108;3803.4294855771577;3812.1232116613055;3841.5006049213703;3844.7693138411505;3862.208247309323;79159;79362.60318698427;80961;81061.59469202675;81433.59283203605;11132.220744547965;11288.887111128784;11380.317180969168;11394.829077563843;11627.825582616268;21539.461513461974;21597.784022159576;21729.565408692055;21756.238531651317;21813.23653672114;8058.556779377191;8081.353491720648;8088;8282.213189747084;8321.625526851307;4501.48232953208;4505.617022553054;4547.226971414867;4580.587747102777;4583.152116858325;3300.6369299377047;3428.1086917401653;3432.1248081739495;3436.6563343665434;3445.9483107753404;587.4125874125874;593.7239183779477;620.3021600699213;662.1888186971019;674.7537148940602;630.2342653675806;671.8958561422987;685.2736099734298;685.6092027544352;698.7868700046535;8386.454880432751;8681.479111253218;8813.735587932373;9002.954985225031;9421.293402994803;569.7948738454153;648.2804087462912;665.1751827733672;670.3798985937988;676.1851968378093;4031.9395209071886;4481.5070342262325;4503.144402563568;4561.361409402686;4641.930371044437;70546.64726676334;85331.14668853232;124231;129473;129814;107453.46273268583;108880.4555977215;111176;111531;113367.43316283531;94295.52852235695;97133.5143324293;98360.50819745855;98986.99999999856;101531.40045896993;8402.579871006548;8858.247049000649;8902.688405905763;9041.412308199946;9161.31290153228;52995;54543;55350;55970.720146399006;55976.720116399156;74145.25854741599;76570;81774.18225817903;81843.5907820457;82752;11100.389478578432;11274.943625281821;11282.94358528202;11337.376444295644;11439.42802859837;10910;11015.449227538751;11040.503177356877;12593.433295501542;12678.112532122663;14106.576802695936;14241.572752817432;14560.781588275973;14578.271086445848;14662.34019469105;13477.123986940818;13790.655233618838;13906.860931390556;14019.158850469004;15338.15640139803;14306.141631502143;14325.498607549103;14371.353289101806;14432.278386080445;15017.774733379227;11037.227394082658;11632.592859249886;11742.530298787953;12201.572944946884;12310.199837010565;10748;11984.520619175135;11996.940780101018;12026.338551379758;12331.383430828244 10:17:59 INFO - PROCESS | 3396 | __end_tp_report 10:17:59 INFO - PROCESS | 3396 | __start_cc_report 10:17:59 INFO - PROCESS | 3396 | _x_x_mozilla_cycle_collect,303 10:17:59 INFO - PROCESS | 3396 | __end_cc_report 10:17:59 INFO - PROCESS | 3396 | __startTimestamp1474564679347__endTimestamp 10:17:59 INFO - PROCESS | 3396 | 10:17:59 INFO - PROCESS | 3396 | ------- Summary: start ------- 10:17:59 INFO - PROCESS | 3396 | Number of tests: 6 10:17:59 INFO - PROCESS | 3396 | 10:17:59 INFO - PROCESS | 3396 | [#0] dojo.html Cycles:165 Average:5363.90 Median:5562.94 stddev:595.32 (10.7%) stddev-sans-first:567.98 10:17:59 INFO - PROCESS | 3396 | Values: 3017.7 3047.8 3065.9 3066.8 3105.7 5302.4 5367.8 5418.6 5429.1 5471.3 5404.2 5421.5 5442.9 5451.9 5503.8 4880.2 5009.6 5012.4 5029.4 5046.4 4985.4 4987.5 4988.8 5054.0 5062.8 4854.2 4888.1 4915.2 4931.7 4996.1 4887.4 4914.4 4935.2 4938.5 5009.2 4797.1 4822.1 4865.6 4891.1 4919.0 5264.6 5299.9 5337.5 5347.6 5347.6 5661.0 5662.9 5677.8 5751.7 5763.3 5784.5 5848.7 5851.3 5851.8 5856.6 5355.9 5389.1 5407.0 5422.5 5435.3 5876.4 5911.6 5929.9 5930.9 5931.7 5599.7 5635.2 5677.1 5693.8 5705.3 5657.3 5687.8 5705.6 5714.1 5715.5 5748.8 5765.8 5769.3 5769.8 5775.3 5784.4 5788.7 5793.6 5793.9 5802.8 4440.4 4456.8 4484.6 4484.7 4486.3 3986.7 4040.7 4051.1 4078.0 4134.4 5579.8 5591.7 5592.6 5596.8 5605.6 5562.6 5895.6 5904.3 5904.7 5905.8 5356.4 5405.7 5413.2 5523.1 5559.7 5066.1 5083.5 5087.5 5107.0 5120.6 5976.5 5984.9 5985.1 5993.3 6008.3 5704.4 5775.8 5792.3 5804.9 5823.7 5859.3 5898.4 5930.9 5933.5 6003.5 5647.4 5648.7 5652.1 5653.7 5664.5 5686.9 5689.7 5737.2 5748.6 5759.5 5589.8 5647.5 5654.2 5670.8 5701.1 5627.2 5627.3 5636.0 5636.3 5643.2 5556.6 5562.9 5580.4 5580.8 5585.1 5454.5 5476.9 5479.3 5480.5 5538.6 5352.3 5354.3 5359.0 5360.3 5399.7 10:17:59 INFO - PROCESS | 3396 | 10:17:59 INFO - PROCESS | 3396 | [#1] ext.html Cycles:180 Average:51850.72 Median:39497.51 stddev:98030.26 (248.2%) stddev-sans-first:98229.64 10:17:59 INFO - PROCESS | 3396 | Values: 566.4 572.5 581.1 595.8 596.1 42843.8 44956.8 44986.1 48085.5 48117.0 45047.3 45671.3 45839.5 45864.8 46042.0 8937.9 9056.5 9063.2 9072.5 9093.5 8891.1 8929.2 8949.0 8963.2 8979.9 9001.6 9037.8 9041.2 9047.8 9054.9 8861.5 8944.5 8948.1 8964.2 8982.7 8820.3 8849.5 8860.3 8884.5 8925.2 42383.0 42670.6 42763.4 42774.0 42788.8 3220.7 3227.8 3234.0 3297.6 3376.7 31784.2 32046.8 32071.4 32138.7 32380.0 4316.7 4381.8 4531.4 4652.9 4668.0 330176.1 330716.3 330841.0 331794.0 332770.0 34819.5 35477.5 35530.6 57795.4 58291.0 37134.6 37342.8 37488.3 37523.2 37777.2 13693.0 13811.1 13861.4 13894.4 13988.4 11259.8 11342.7 11366.8 11372.2 11381.5 8491.2 8567.6 8581.6 8599.4 8645.8 3294.0 3298.8 3330.0 3339.5 3389.9 926.9 942.3 1018.5 1106.4 1154.6 29830.9 30820.5 30841.8 30928.0 31076.5 1060.4 1079.6 1086.4 1101.9 1124.5 15974.9 16175.2 16416.3 16431.4 16463.6 125566.0 460946.0 461397.0 461850.0 463665.0 56763.1 57234.0 57553.0 57593.7 57681.7 1214.0 1240.4 1253.5 1270.0 1273.6 29342.1 29878.9 30617.7 30845.8 30951.5 47098.8 47462.5 47467.3 47525.0 47603.3 353711.0 357532.0 359882.0 359939.0 360124.0 28132.4 28171.3 28285.7 28517.3 28706.0 45227.3 45284.1 45435.3 45969.8 47034.5 38984.0 39270.6 40150.8 40877.2 41399.8 39011.8 39790.4 40230.8 41118.8 41312.2 39462.2 39532.8 39760.6 39881.4 40548.4 35031.0 35997.8 36236.8 36621.5 36679.4 27760.6 27853.2 28083.9 28108.4 28397.9 10:17:59 INFO - PROCESS | 3396 | 10:17:59 INFO - PROCESS | 3396 | [#2] jquery.html Cycles:180 Average:27028.58 Median:41475.29 stddev:71581.91 (172.6%) stddev-sans-first:71754.77 10:17:59 INFO - PROCESS | 3396 | Values: 388.5 393.2 393.2 396.9 421.8 17862.0 18984.1 19435.8 19443.8 20185.9 18744.6 18978.2 19082.2 19149.2 19182.8 5638.2 5746.5 5911.6 5933.2 5963.9 5935.1 5965.9 5980.0 5980.7 5995.6 5788.9 5985.4 6009.7 6012.0 6021.7 5542.2 5951.4 5979.0 6005.0 6044.8 5587.2 5677.2 5682.3 5682.8 5704.9 22721.0 23013.5 23037.5 23081.9 23179.4 2136.4 2173.4 2198.8 2263.3 2288.8 9675.2 9811.4 9847.6 10114.2 10165.0 1888.8 1919.4 1964.2 1970.7 2061.6 75275.5 77519.2 77870.6 82380.6 82982.0 11079.2 11167.6 11209.4 11388.6 11475.7 15835.2 15856.4 15924.8 15936.0 15977.0 7649.9 7700.5 7916.7 7959.0 7968.8 7234.2 7290.9 7402.5 7578.3 7643.8 4757.6 4850.9 4863.2 4868.9 4915.6 1849.7 1937.2 1969.4 1974.7 1996.6 783.0 866.0 928.4 998.3 1012.3 17495.1 18906.0 19162.0 19499.0 19552.4 890.8 896.7 946.6 984.2 991.8 9954.3 10936.0 10947.2 10979.4 10981.9 387215.0 412891.0 450060.0 453182.0 453562.0 89187.0 90320.5 90432.5 90926.0 92426.0 940.1 945.0 982.7 985.6 993.3 16694.2 16861.7 17051.7 17091.5 17361.1 40114.4 40855.2 41033.6 41457.6 41493.0 54781.7 55899.0 56127.0 57375.0 57911.4 8442.5 8511.1 8564.4 8655.6 8668.3 10961.3 12764.1 12882.2 13054.5 13214.7 10251.5 10274.7 10383.7 10454.4 10552.6 10156.5 10477.2 10737.5 10805.8 10908.3 10630.6 10633.1 10721.8 10754.9 10892.5 7041.9 7155.7 7226.6 8132.5 8226.6 9979.6 10002.1 10091.8 10257.0 10322.7 10:17:59 INFO - PROCESS | 3396 | 10:17:59 INFO - PROCESS | 3396 | [#3] mootools.html Cycles:180 Average:5734.03 Median:5095.23 stddev:3334.53 (65.4%) stddev-sans-first:3328.21 10:17:59 INFO - PROCESS | 3396 | Values: 1432.0 1480.0 1619.5 1755.3 1758.9 8492.9 8723.3 9019.1 9200.1 9250.0 9030.7 9165.8 9207.1 9283.4 9295.2 2206.5 2236.7 2237.0 2239.8 2241.8 2229.0 2235.4 2251.7 2269.8 2278.2 2228.3 2232.8 2258.3 2260.9 2270.5 2153.7 2180.8 2189.0 2195.4 2204.1 2075.2 2086.4 2097.3 2104.9 2108.2 9073.9 9146.6 9163.1 9226.5 9254.2 5081.9 5174.1 5177.4 5178.4 5180.4 3179.4 3219.8 3347.9 3374.0 3374.8 1081.4 1087.6 1093.7 1104.9 1111.2 12232.1 12341.4 12385.6 12400.6 12444.9 4348.6 4420.5 4502.5 4548.6 4567.2 9677.8 9729.3 9743.4 9764.2 9835.0 5150.7 5192.2 5193.8 5203.8 5204.3 4309.2 4394.6 4832.6 4833.8 4909.8 3600.8 3711.7 3725.8 3785.5 3807.7 1087.2 1094.2 1102.6 1123.3 1125.1 839.6 852.7 883.9 929.0 964.1 5578.8 5699.6 5700.2 5741.4 5835.6 934.6 937.0 983.2 985.6 1012.0 3841.0 3970.9 3986.4 4042.6 4078.2 10494.4 11144.7 11171.6 11217.1 11227.4 11017.2 11088.3 11161.0 11161.6 11167.0 8080.9 8188.1 8232.4 8253.0 8258.5 5699.6 5738.1 5748.0 5854.6 5892.0 9727.5 9847.8 9893.4 9930.7 9953.4 9845.6 10216.3 10235.6 10241.5 10252.5 6548.3 6726.0 7445.8 7555.4 7563.7 7995.1 8136.6 8225.2 8365.9 8391.0 7449.8 7768.7 7921.8 7932.2 8145.0 7298.2 7745.8 7756.7 7789.1 7851.3 6683.7 6799.1 6812.3 6816.4 6822.1 4993.2 5017.8 5058.0 5123.8 5319.3 5056.7 5066.0 5108.5 5174.8 5179.3 10:17:59 INFO - PROCESS | 3396 | 10:17:59 INFO - PROCESS | 3396 | [#4] prototype.html Cycles:180 Average:4847.54 Median:5564.62 stddev:1436.68 (25.8%) stddev-sans-first:1400.01 10:17:59 INFO - PROCESS | 3396 | Values: 323.6 331.6 332.1 332.8 341.3 5483.5 5558.9 5565.6 5577.7 5593.9 5479.7 5503.7 5505.0 5508.0 5558.7 4112.7 4181.2 4235.1 4237.9 4268.3 4285.9 4286.7 4287.1 4302.8 4309.8 4268.8 4277.8 4283.4 4308.7 4310.8 3994.6 4190.9 4215.4 4247.5 4276.6 3729.6 3741.4 3743.5 3749.2 3753.9 5342.2 5366.1 5372.2 5399.5 5402.2 4603.4 4828.2 4854.1 4903.3 4905.3 5659.4 5687.9 5691.8 5699.2 5706.5 4098.5 4105.5 4105.8 4113.4 4115.7 5792.5 5879.6 5889.5 5926.9 5948.3 4170.2 4190.9 4191.7 4192.3 4198.4 4235.9 4237.6 4241.3 4254.9 4282.1 4630.3 4833.5 4847.2 4903.0 4907.2 5696.6 5706.4 5706.6 5710.3 5725.5 1422.0 1430.8 1443.5 1445.4 1446.6 900.8 941.8 958.5 984.4 1020.3 5530.3 5542.5 5543.7 5581.6 5605.7 5752.3 5792.4 5802.6 5803.7 5909.0 5298.8 5474.2 5483.8 5621.1 5668.5 3121.6 3153.0 3163.0 3190.5 3192.3 5827.6 6188.4 6210.7 6230.5 6259.3 6034.5 6045.8 6093.3 6106.8 6158.8 6135.8 6170.4 6196.4 6200.6 6205.6 5563.7 5808.2 5846.4 5849.6 5993.3 5890.9 5896.4 5906.4 5952.2 5961.3 5835.2 6117.7 6125.4 6135.2 6148.0 4216.5 4231.6 4236.3 4275.5 4287.0 5968.6 5984.3 6001.5 6008.4 6012.2 5622.9 5743.0 5766.5 5783.7 5821.9 5741.5 5752.9 5760.6 5771.4 5802.7 5373.6 5699.4 5750.6 5764.3 5785.3 5684.8 5742.5 5775.7 5779.0 5793.3 5650.2 5651.9 5681.1 5711.4 5751.9 10:17:59 INFO - PROCESS | 3396 | 10:17:59 INFO - PROCESS | 3396 | [#5] yui.html Cycles:180 Average:21406.12 Median:4491.49 stddev:31884.47 (709.9%) stddev-sans-first:31935.85 10:17:59 INFO - PROCESS | 3396 | Values: 655.7 664.9 690.3 743.4 766.3 13801.4 14651.3 14684.1 14715.9 14774.1 12572.5 12642.0 12657.5 13319.5 13633.3 794.6 813.9 817.4 819.5 819.9 785.5 811.9 812.3 816.3 826.5 851.9 857.6 859.5 861.8 862.0 852.9 854.6 857.9 858.0 858.2 624.0 627.0 627.9 628.5 630.7 13967.0 14057.7 14085.8 14129.5 14146.2 15031.2 15126.9 15145.3 15159.5 15325.4 10735.2 10861.8 11579.8 11666.4 11802.4 3803.4 3812.1 3841.5 3844.8 3862.2 79159.0 79362.6 80961.0 81061.6 81433.6 11132.2 11288.9 11380.3 11394.8 11627.8 21539.5 21597.8 21729.6 21756.2 21813.2 8058.6 8081.4 8088.0 8282.2 8321.6 4501.5 4505.6 4547.2 4580.6 4583.2 3300.6 3428.1 3432.1 3436.7 3445.9 587.4 593.7 620.3 662.2 674.8 630.2 671.9 685.3 685.6 698.8 8386.5 8681.5 8813.7 9003.0 9421.3 569.8 648.3 665.2 670.4 676.2 4031.9 4481.5 4503.1 4561.4 4641.9 70546.6 85331.1 124231.0 129473.0 129814.0 107453.5 108880.5 111176.0 111531.0 113367.4 94295.5 97133.5 98360.5 98987.0 101531.4 8402.6 8858.2 8902.7 9041.4 9161.3 52995.0 54543.0 55350.0 55970.7 55976.7 74145.3 76570.0 81774.2 81843.6 82752.0 11100.4 11274.9 11282.9 11337.4 11439.4 10910.0 11015.4 11040.5 12593.4 12678.1 14106.6 14241.6 14560.8 14578.3 14662.3 13477.1 13790.7 13906.9 14019.2 15338.2 14306.1 14325.5 14371.4 14432.3 15017.8 11037.2 11632.6 11742.5 12201.6 12310.2 10748.0 11984.5 11996.9 12026.3 12331.4 10:17:59 INFO - PROCESS | 3396 | -------- Summary: end -------- 10:17:59 INFO - PROCESS | 3396 | 10:18:00 INFO - TEST-INFO | 3396: exit 0 10:18:00 INFO - TEST-OK | dromaeo_css | took 1114304ms 10:18:00 INFO - TEST-START | kraken 10:18:00 INFO - operating with platform_type : linux_ 10:18:00 INFO - Initialising browser for kraken test... 10:18:00 INFO - TEST-INFO | started process 3757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaLDKya/profile http://localhost:53601/getInfo.html) 10:18:04 INFO - PROCESS | 3757 | __metrics Screen width/height:1600/1200 10:18:04 INFO - PROCESS | 3757 | colorDepth:24 10:18:04 INFO - PROCESS | 3757 | Browser inner width/height: 1024/697 10:18:04 INFO - PROCESS | 3757 | __metrics 10:18:05 ERROR - PROCESS | 3757 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 10:18:05 INFO - TEST-INFO | 3757: exit 0 10:18:05 INFO - Browser initialized. 10:18:05 INFO - Running cycle 1/1 for kraken test... 10:18:05 INFO - TEST-INFO | started process 3878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaLDKya/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:18 INFO - PROCESS | 3878 | RSS: Main: 185004032 10:18:18 INFO - PROCESS | 3878 | 10:18:20 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53601/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:21 INFO - PROCESS | 3878 | RSS: Main: 199774208 10:18:21 INFO - PROCESS | 3878 | 10:18:24 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53601/tests/kraken/driver.html?testName=audio-dft) 10:18:25 INFO - PROCESS | 3878 | RSS: Main: 197214208 10:18:25 INFO - PROCESS | 3878 | 10:18:27 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53601/tests/kraken/driver.html?testName=audio-fft) 10:18:28 INFO - PROCESS | 3878 | RSS: Main: 193007616 10:18:28 INFO - PROCESS | 3878 | 10:18:30 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53601/tests/kraken/driver.html?testName=audio-oscillator) 10:18:31 INFO - PROCESS | 3878 | RSS: Main: 193683456 10:18:31 INFO - PROCESS | 3878 | 10:18:33 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53601/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:34 INFO - PROCESS | 3878 | RSS: Main: 194142208 10:18:34 INFO - PROCESS | 3878 | 10:18:37 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53601/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:37 INFO - PROCESS | 3878 | RSS: Main: 194117632 10:18:37 INFO - PROCESS | 3878 | 10:18:41 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53601/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:41 INFO - PROCESS | 3878 | RSS: Main: 191877120 10:18:41 INFO - PROCESS | 3878 | 10:18:44 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53601/tests/kraken/driver.html?testName=json-parse-financial) 10:18:45 INFO - PROCESS | 3878 | RSS: Main: 192942080 10:18:45 INFO - PROCESS | 3878 | 10:18:46 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53601/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:47 INFO - PROCESS | 3878 | RSS: Main: 193765376 10:18:47 INFO - PROCESS | 3878 | 10:18:49 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53601/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:49 INFO - PROCESS | 3878 | RSS: Main: 194404352 10:18:50 INFO - PROCESS | 3878 | 10:18:52 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53601/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:52 INFO - PROCESS | 3878 | RSS: Main: 193617920 10:18:52 INFO - PROCESS | 3878 | 10:18:55 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53601/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:56 INFO - PROCESS | 3878 | RSS: Main: 193908736 10:18:56 INFO - PROCESS | 3878 | 10:18:58 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53601/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:59 INFO - PROCESS | 3878 | RSS: Main: 194379776 10:18:59 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:53601/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53601/tests/kraken/driver.html?testName=ai-astar) 10:19:01 INFO - PROCESS | 3878 | RSS: Main: 195604480 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | __start_tp_report 10:19:01 INFO - PROCESS | 3878 | _x_x_mozilla_page_load 10:19:01 INFO - PROCESS | 3878 | _x_x_mozilla_page_load_details 10:19:01 INFO - PROCESS | 3878 | |i|pagename|runs| 10:19:01 INFO - PROCESS | 3878 | |0;ai-astar;105;115;115;116;116;114;113;114;114;115 10:19:01 INFO - PROCESS | 3878 | |1;audio-beat-detection;149;120;123;168;122;125;128;124;153;122 10:19:01 INFO - PROCESS | 3878 | |2;audio-dft;164;164;163;165;167;162;164;161;163;166 10:19:01 INFO - PROCESS | 3878 | |3;audio-fft;76;77;76;117;76;77;76;76;103;75 10:19:01 INFO - PROCESS | 3878 | |4;audio-oscillator;83;83;113;85;83;83;105;83;82;112 10:19:01 INFO - PROCESS | 3878 | |5;imaging-gaussian-blur;119;117;117;117;118;118;117;117;118;117 10:19:01 INFO - PROCESS | 3878 | |6;imaging-darkroom;147;147;146;146;147;148;147;146;147;147 10:19:01 INFO - PROCESS | 3878 | |7;imaging-desaturate;95;95;96;95;95;95;95;97;97;96 10:19:01 INFO - PROCESS | 3878 | |8;json-parse-financial;52;52;55;54;53;53;60;52;53;53 10:19:01 INFO - PROCESS | 3878 | |9;json-stringify-tinderbox;61;62;60;61;61;61;63;61;62;61 10:19:01 INFO - PROCESS | 3878 | |10;stanford-crypto-aes;81;79;81;81;80;81;80;79;79;79 10:19:01 INFO - PROCESS | 3878 | |11;stanford-crypto-ccm;125;133;133;125;137;128;128;128;168;143 10:19:01 INFO - PROCESS | 3878 | |12;stanford-crypto-pbkdf2;169;171;170;166;164;174;175;171;179;166 10:19:01 INFO - PROCESS | 3878 | |13;stanford-crypto-sha256-iterative;67;70;67;66;67;67;67;70;66;68 10:19:01 INFO - PROCESS | 3878 | __end_tp_report 10:19:01 INFO - PROCESS | 3878 | __start_cc_report 10:19:01 INFO - PROCESS | 3878 | _x_x_mozilla_cycle_collect,815 10:19:01 INFO - PROCESS | 3878 | __end_cc_report 10:19:01 INFO - PROCESS | 3878 | __startTimestamp1474564741527__endTimestamp 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | ------- Summary: start ------- 10:19:01 INFO - PROCESS | 3878 | Number of tests: 14 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:3.20 (2.8%) stddev-sans-first:1.00 10:19:01 INFO - PROCESS | 3878 | Values: 105.0 115.0 115.0 116.0 116.0 114.0 113.0 114.0 114.0 115.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:126.50 stddev:16.87 (13.3%) stddev-sans-first:16.92 10:19:01 INFO - PROCESS | 3878 | Values: 149.0 120.0 123.0 168.0 122.0 125.0 128.0 124.0 153.0 122.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:1.79 (1.1%) stddev-sans-first:1.90 10:19:01 INFO - PROCESS | 3878 | Values: 164.0 164.0 163.0 165.0 167.0 162.0 164.0 161.0 163.0 166.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:14.67 (19.3%) stddev-sans-first:15.35 10:19:01 INFO - PROCESS | 3878 | Values: 76.0 77.0 76.0 117.0 76.0 77.0 76.0 76.0 103.0 75.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:83.00 stddev:13.16 (15.8%) stddev-sans-first:13.61 10:19:01 INFO - PROCESS | 3878 | Values: 83.0 83.0 113.0 85.0 83.0 83.0 105.0 83.0 82.0 112.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.50 10:19:01 INFO - PROCESS | 3878 | Values: 119.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 117.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 10:19:01 INFO - PROCESS | 3878 | Values: 147.0 147.0 146.0 146.0 147.0 148.0 147.0 146.0 147.0 147.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 10:19:01 INFO - PROCESS | 3878 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 97.0 97.0 96.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:2.41 (4.5%) stddev-sans-first:2.47 10:19:01 INFO - PROCESS | 3878 | Values: 52.0 52.0 55.0 54.0 53.0 53.0 60.0 52.0 53.0 53.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 10:19:01 INFO - PROCESS | 3878 | Values: 61.0 62.0 60.0 61.0 61.0 61.0 63.0 61.0 62.0 61.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.50 stddev:0.94 (1.2%) stddev-sans-first:0.93 10:19:01 INFO - PROCESS | 3878 | Values: 81.0 79.0 81.0 81.0 80.0 81.0 80.0 79.0 79.0 79.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:133.00 stddev:12.96 (9.7%) stddev-sans-first:13.25 10:19:01 INFO - PROCESS | 3878 | Values: 125.0 133.0 133.0 125.0 137.0 128.0 128.0 128.0 168.0 143.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.00 stddev:4.60 (2.7%) stddev-sans-first:4.85 10:19:01 INFO - PROCESS | 3878 | Values: 169.0 171.0 170.0 166.0 164.0 174.0 175.0 171.0 179.0 166.0 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 10:19:01 INFO - PROCESS | 3878 | Values: 67.0 70.0 67.0 66.0 67.0 67.0 67.0 70.0 66.0 68.0 10:19:01 INFO - PROCESS | 3878 | -------- Summary: end -------- 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | 10:19:01 INFO - PROCESS | 3878 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 10:19:01 INFO - PROCESS | 3878 | 10:19:02 INFO - TEST-INFO | 3878: exit 0 10:19:02 INFO - TEST-OK | kraken | took 62367ms 10:19:02 INFO - SUITE-END | took 1176s 10:19:03 INFO - Completed test suite (00:19:37) 10:19:03 INFO - javascript benchmark 10:19:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7110.114060599148, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3017.6831432699564, 3047.801892876962, 3065.9080227593167, 3066.7699922505817, 3105.673904240053, 5302.3902251241025, 5367.785288588457, 5418.647787893784, 5429.077056900326, 5471.316085489314, 5404.162354835007, 5421.512063914247, 5442.91835622466, 5451.863703407417, 5503.752331145098, 4880.219164933603, 5009.574186194178, 5012.448630650625, 5029.4216165141115, 5046.44489106198, 4985.40175178979, 4987.501249875002, 4988.800447982077, 5053.974730126362, 5062.797488100471, 4854.199057155565, 4888.095702295087, 4915.213565829486, 4931.65478416511, 4996.075725990667, 4887.36464259644, 4914.385701787277, 4935.185694360426, 4938.4814594467425, 5009.198528235502, 4797.136515427222, 4822.107910036654, 4865.635077369176, 4891.070696567641, 4918.9754051229875, 5264.631475796696, 5299.867503312409, 5337.519623233928, 5347.572194224453, 5347.6256662033675, 5661.037623603997, 5662.943370566283, 5677.801276955287, 5751.683657398841, 5763.250777398953, 5784.508316793078, 5848.7075646217945, 5851.297844258674, 5851.76592936282, 5856.648601083949, 5355.919661205046, 5389.110796718537, 5406.972965135149, 5422.484863937999, 5435.293411856473, 5876.44173803488, 5911.645301281937, 5929.881402372014, 5930.851728706731, 5931.703414829241, 5599.692016939108, 5635.154726791015, 5677.148427735872, 5693.829185124453, 5705.258316418839, 5657.32112146545, 5687.800926967537, 5705.600607957404, 5714.05718056516, 5715.514181294553, 5748.798792042258, 5765.769369225268, 5769.278840144982, 5769.826905192851, 5775.33583637887, 5784.421557844266, 5788.652680839163, 5793.594448388572, 5793.884122317614, 5802.767889284466, 4440.35614835847, 4456.7548784817145, 4484.57396547334, 4484.686071974996, 4486.259767138451, 3986.720929534905, 4040.7171497995446, 4051.1290072634524, 4078.0, 4134.4005119258145, 5579.77245006098, 5591.7483713233005, 5592.608517403824, 5596.804111856066, 5605.607607467438, 5562.554995600342, 5895.587308888336, 5904.261967254093, 5904.704764761745, 5905.822825315247, 5356.437574054746, 5405.729713514309, 5413.242146099549, 5523.061079616475, 5559.6664200148125, 5066.06277838601, 5083.466236045236, 5087.491250874957, 5107.00413419387, 5120.641555091108, 5976.491998180203, 5984.940150598525, 5985.102234664835, 5993.250843644544, 6008.309044459943, 5704.401037890962, 5775.826725198251, 5792.275965504312, 5804.94195058044, 5823.7379317931645, 5859.296884373903, 5898.439648233411, 5930.940690593211, 5933.465988061095, 6003.519718422603, 5647.407022262603, 5648.745806438638, 5652.095664693629, 5653.660780353192, 5664.518515926027, 5686.943130568641, 5689.687067211343, 5737.168110623853, 5748.568857335633, 5759.539236860957, 5589.776408943597, 5647.491725744702, 5654.208410822571, 5670.773169073191, 5701.116326969326, 5627.184058311604, 5627.324721033338, 5636.0, 5636.2954630671165, 5643.181738647791, 5556.638818476786, 5562.9443705564045, 5580.35825880029, 5580.832575022756, 5585.078462053716, 5454.536364409069, 5476.890462190654, 5479.260299859628, 5480.479354461319, 5538.584606154635, 5352.277442545363, 5354.330708661418, 5359.0, 5360.3299587551555, 5399.676019438689], "value": 5323.986289564215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.4024454200818, 572.499063319595, 581.0876923230529, 595.8242318516038, 596.1236981636993, 42843.78578107109, 44956.77521612391, 44986.10027799442, 48085.519144808626, 48117.0, 45047.32429013559, 45671.31493027607, 45839.541604583945, 45864.770676146654, 46042.0, 8937.910620893805, 9056.501892395916, 9063.184313411792, 9072.501012444312, 9093.454392736425, 8891.11088891109, 8929.196372326489, 8948.955255223715, 8963.193312601865, 8979.865302020475, 9001.639934402616, 9037.774055648595, 9041.186293233608, 9047.819043619123, 9054.909450905472, 8861.512616806072, 8944.5080520572, 8948.06045365237, 8964.19322260993, 8982.730518084469, 8820.250278726317, 8849.51327676984, 8860.291176705849, 8884.466931984038, 8925.19673229406, 42383.0, 42670.57329426697, 42763.35854962178, 42774.0, 42788.78605606983, 3220.7262382697263, 3227.8386080695873, 3234.0, 3297.604287485493, 3376.7129793967542, 31784.205394865312, 32046.839765801255, 32071.358572828412, 32138.678613213804, 32380.0, 4316.740995540277, 4381.824727010916, 4531.388262584542, 4652.883677908046, 4668.043051174501, 330176.0947171589, 330716.3464182688, 330841.0, 331794.0, 332770.0, 34819.477707834405, 35477.467837982455, 35530.64469355325, 57795.422045779844, 58291.0, 37134.628653713655, 37342.8132859334, 37488.25023499515, 37523.249535009694, 37777.24445511075, 13693.041487096007, 13811.102278351875, 13861.445542178402, 13894.374753136133, 13988.370523326272, 11259.774804503864, 11342.659720208407, 11366.772664546663, 11372.203945723886, 11381.487833047533, 8491.19333663301, 8567.614457349435, 8581.613827377658, 8599.39804213699, 8645.827083458296, 3293.983530082382, 3298.835058247078, 3329.9500507492407, 3339.482380231068, 3389.881354152593, 926.9026752190923, 942.3121121581147, 1018.495844556949, 1106.363840791548, 1154.6074334726234, 29830.850845745634, 30820.468654324162, 30841.8457907709, 30928.0, 31076.533851992237, 1060.3796778884284, 1079.643717573199, 1086.4241951765578, 1101.8512500812449, 1124.5108377855659, 15974.920125399298, 16175.19124043793, 16416.343346266254, 16431.424900128677, 16463.588410289598, 125566.0, 460946.0, 461397.0, 461850.0, 463665.0, 56763.148552771745, 57234.0, 57553.0, 57593.71203144041, 57681.71159144177, 1213.9635810925686, 1240.3984067727145, 1253.5111306590436, 1269.9873001270055, 1273.6370134511806, 29342.11973640794, 29878.850605746833, 30617.693823062375, 30845.845770771004, 30951.535726963662, 47098.76450617725, 47462.52537474581, 47467.28799067948, 47525.0, 47603.28595071146, 353711.0, 357532.0, 359882.0, 359939.0, 360124.0, 28132.43735125327, 28171.295717607223, 28285.717142828307, 28517.28706782264, 28706.0, 45227.321590176834, 45284.094318112795, 45435.318470222315, 45969.77015114903, 47034.529654703016, 38984.0, 39270.607293926696, 40150.79924600358, 40877.1824563513, 41399.7930010348, 39011.80494097511, 39790.403143953445, 40230.798846005586, 41118.79440602778, 41312.1737565241, 39462.210755785294, 39532.80233598813, 39760.60239397569, 39881.40177897276, 40548.391774124, 35031.0, 35997.82001089978, 36236.81881590681, 36621.450678239315, 36679.449808252364, 27760.583591245744, 27853.227906700657, 28083.86056320556, 28108.43783124367, 28397.858010709813], "value": 18232.86814829994, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.50659662228986, 393.20768651167884, 393.23908237560323, 396.90275882408815, 421.75748944357, 17862.0, 18984.145713442893, 19435.805641943578, 19443.805561944395, 20185.899070504664, 18744.625107497843, 18978.240870365167, 19082.23671053156, 19149.234030638792, 19182.808171918277, 5638.210650508932, 5746.454086861752, 5911.586188966774, 5933.169356290123, 5963.940360596382, 5935.10973353996, 5965.910511342333, 5980.043193089106, 5980.700964951757, 5995.580309378345, 5788.913166302509, 5985.401459854023, 6009.669468179249, 6011.969940150293, 6021.668808215546, 5542.224088627595, 5951.375105613892, 5978.970105149447, 6005.039193729004, 6044.788432404866, 5587.245721827542, 5677.205191273225, 5682.346530149044, 5682.801101961411, 5704.942950570483, 22721.0, 23013.53972920549, 23037.53924921509, 23081.88459057711, 23179.420514487272, 2136.4124865662066, 2173.369722780392, 2198.769129241439, 2263.2531264682616, 2288.78256565626, 9675.225981921429, 9811.411315321104, 9847.556859941249, 10114.190864730805, 10165.034321739497, 1888.8111188881003, 1919.376301638899, 1964.2437661500283, 1970.7240986261934, 2061.5567652954687, 75275.49449011043, 77519.22480775233, 77870.61064694697, 82380.58809705974, 82982.0, 11079.169062320358, 11167.553297867995, 11209.439528023566, 11388.601398950997, 11475.655730328104, 15835.208239587975, 15856.365745370287, 15924.840751592568, 15936.0, 15977.0, 7649.923500765032, 7700.460967732205, 7916.722914697958, 7958.960205199052, 7968.84062318762, 7234.168070671835, 7290.890636640454, 7402.481826272217, 7578.3179513842915, 7643.827811458294, 4757.619390448755, 4850.902981940341, 4863.173260545645, 4868.9269660955115, 4915.582175515121, 1849.6763066463316, 1937.1960636336044, 1969.3796454116907, 1974.6544354737864, 1996.6106609211354, 782.9608519574113, 865.974020779365, 928.3640706116197, 998.3460833154296, 1012.3116280929039, 17495.125243738017, 18906.0, 19162.04189790505, 19499.0, 19552.360431341873, 890.7594949363765, 896.6727144592177, 946.6308139825474, 984.2470510059667, 991.7818080022383, 9954.253430992705, 10936.0, 10947.178961577914, 10979.396133212591, 10981.945090274497, 387215.0, 412891.0, 450060.0, 453182.0, 453562.0, 89187.0, 90320.54839725759, 90432.5478372617, 90926.0, 92426.0, 940.0881145289195, 944.9858252126223, 982.6953644370268, 985.5515740338129, 993.2749093162032, 16694.165291735608, 16861.747073793656, 17051.658966820843, 17091.48725538236, 17361.131943402528, 40114.39828402635, 40855.1828963425, 41033.589664102976, 41457.58542414537, 41493.0, 54781.72609136929, 55899.0, 56127.0, 57375.0, 57911.420885790605, 8442.451240669337, 8511.148885111439, 8564.443311184754, 8655.610497527501, 8668.30653547702, 10961.287516311415, 12764.106512544033, 12882.162659427107, 13054.54309099177, 13214.669633259246, 10251.48742562854, 10274.691759247235, 10383.688489345332, 10454.372737635766, 10552.630657926935, 10156.542955567165, 10477.16182705397, 10737.516811743646, 10805.837912431478, 10908.345499269752, 10630.574777008833, 10633.149348051982, 10721.802030583867, 10754.946225268823, 10892.455377231265, 7041.894371584533, 7155.677994490365, 7226.566406015656, 8132.471389359673, 8226.588670566329, 9979.550920208463, 10002.099811017044, 10091.848622270525, 10257.0, 10322.741931451774], "value": 8972.054738968745, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.9570412887613, 1480.0231846980992, 1619.5060506545499, 1755.3329734700828, 1758.8680848936333, 8492.915070849289, 8723.258523025535, 9019.143181397756, 9200.079992000796, 9249.953750231249, 9030.729078127666, 9165.77085572861, 9207.125323094295, 9283.396579222346, 9295.163435290822, 2206.5255969966493, 2236.6980457638256, 2237.026893301419, 2239.7984181423667, 2241.7982381585653, 2228.9888550557307, 2235.418791114314, 2251.684764133023, 2269.795718385345, 2278.202629079817, 2228.253535065755, 2232.821374290061, 2258.322503249027, 2260.886955652211, 2270.5231901300745, 2153.7092492513466, 2180.8473406861526, 2188.9781102188936, 2195.4401627585025, 2204.0853045985896, 2075.242536474191, 2086.415803574986, 2097.28692244636, 2104.9052792624216, 2108.219958615322, 9073.909260907438, 9146.588403521791, 9163.083691630784, 9226.492542910137, 9254.2133918617, 5081.923771143436, 5174.146265866128, 5177.378714554277, 5178.352705911761, 5180.43015268324, 3179.3641271745514, 3219.8390080496115, 3347.8995630131135, 3373.9831300843584, 3374.797512149279, 1081.4106312059946, 1087.6030248959073, 1093.6718984304678, 1104.9447527623668, 1111.2332490581555, 12232.082593805411, 12341.382930853422, 12385.566505172366, 12400.56598019065, 12444.937775311066, 4348.565143485626, 4420.535843736426, 4502.482214545304, 4548.636109111263, 4567.223571992769, 9677.758056048655, 9729.318947673595, 9743.415395076318, 9764.218862490983, 9835.0, 5150.665206761549, 5192.24712416705, 5193.76628051731, 5203.8178663746585, 5204.34945631796, 4309.202797482413, 4394.626456751148, 4832.637552183601, 4833.830815921426, 4909.803607855717, 3600.837962291703, 3711.721620878445, 3725.795081270502, 3785.488958990556, 3807.676347510437, 1087.1737479515466, 1094.1684319916922, 1102.6251074634663, 1123.2586492914636, 1125.133647091751, 839.5508403004485, 852.7058164933088, 883.8630012348096, 928.9860652090224, 964.0841200859212, 5578.832635020955, 5699.601027928005, 5700.201971723962, 5741.397153298927, 5835.649861008353, 934.63082082577, 936.990630093704, 983.2183414185597, 985.5614251658087, 1011.9797604047877, 3840.9615903840604, 3970.861019864291, 3986.421968814506, 4042.615951484663, 4078.2455245779624, 10494.42280674555, 11144.721381965515, 11171.553137874394, 11217.102631789438, 11227.38249396291, 11017.228793984345, 11088.279261847954, 11161.0, 11161.609343673095, 11167.0, 8080.878786818203, 8188.099309075997, 8232.382571307176, 8253.0, 8258.545779982158, 5699.601027928005, 5738.139279108167, 5748.0, 5854.619449735754, 5891.970540147272, 9727.464989425649, 9847.803043938939, 9893.406395615999, 9930.702078937644, 9953.402795832273, 9845.60617575289, 10216.335938163995, 10235.590576376862, 10241.539130738985, 10252.487375631337, 6548.279689234276, 6726.0, 7445.81385465346, 7555.357794587521, 7563.697452102075, 7995.080565735015, 8136.552489613128, 8225.177482251966, 8365.916340836513, 8390.958045209734, 7449.776506704808, 7768.728094516665, 7921.801954950942, 7932.206779322021, 8145.0, 7298.160711518243, 7745.806354841174, 7756.68973241064, 7789.143194248742, 7851.332636725942, 6683.665816709243, 6799.082123913208, 6812.284710105368, 6816.386525212754, 6822.11312529368, 4993.201087825931, 5017.7566737161205, 5057.974710126426, 5123.769430375568, 5319.335083114611, 5056.721880296619, 5065.974670126626, 5108.540231379194, 5174.818881339135, 5179.274901513716], "value": 4542.28055879548, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.5858101629913, 331.577239020249, 332.0933850587895, 332.8419000974539, 341.3343979240482, 5483.533899618532, 5558.861028474285, 5565.554755619551, 5577.69322687252, 5593.916091258624, 5479.698616576096, 5503.725283456337, 5505.0, 5508.0, 5558.749856256468, 4112.732672376301, 4181.205570941526, 4235.110626768383, 4237.8516751913685, 4268.338407546819, 4285.871423857274, 4286.678499112579, 4287.1425714857, 4302.763348015857, 4309.771715061208, 4268.807903644328, 4277.8288868445225, 4283.400323954649, 4308.707387783668, 4310.762908040057, 3994.640482356587, 4190.91618167638, 4215.367694845798, 4247.469066366704, 4276.615104640582, 3729.5710993235853, 3741.3639681254253, 3743.494628225182, 3749.2314075614436, 3753.8873833784755, 5342.237061769607, 5366.141417373241, 5372.221027950925, 5399.541039011689, 5402.162664786964, 4603.378543896564, 4828.227483602606, 4854.101991131652, 4903.2645103234445, 4905.2887331337115, 5659.377468478464, 5687.857803554903, 5691.755699251428, 5699.202111704365, 5706.4864162225595, 4098.549159592472, 4105.548389677133, 4105.774182419966, 4113.424120623115, 4115.73247738896, 5792.507636850831, 5879.617824841372, 5889.4993925515955, 5926.881462370771, 5948.345681974979, 4170.186813571325, 4190.8533201337805, 4191.7275377100395, 4192.329227323614, 4198.39123327122, 4235.9364609530885, 4237.618614324726, 4241.27898257297, 4254.936175957363, 4282.100758840616, 4630.328602352707, 4833.540813622701, 4847.224444088929, 4902.965269413154, 4907.214845624754, 5696.572757043155, 5706.3722990471015, 5706.600537962303, 5710.3433105193435, 5725.484706376363, 1421.964450888736, 1430.8195738515767, 1443.4947768281227, 1445.3640398224748, 1446.5804916574286, 900.827903740101, 941.7975135345933, 958.4728399380313, 984.4003494321727, 1020.3163880200284, 5530.281063461724, 5542.528885044816, 5543.695096769717, 5581.553475721932, 5605.719714014364, 5752.338481074647, 5792.391798861143, 5802.564807639444, 5803.651780893076, 5908.970455147697, 5298.761555730001, 5474.178873169057, 5483.835484935458, 5621.072523033736, 5668.489835914787, 3121.562981182636, 3153.038323311412, 3162.968370316313, 3190.5373720810353, 3192.2817366092445, 5827.621204621686, 6188.44304012641, 6210.658413787195, 6230.501559875199, 6259.280182779039, 6034.456898879122, 6045.8488537786025, 6093.324335807688, 6106.847328816726, 6158.846028849314, 6135.754569817246, 6170.413810687887, 6196.442320191024, 6200.596961197508, 6205.596636218722, 5563.693996830213, 5808.186853840381, 5846.444587764156, 5849.64902105875, 5993.250843644544, 5890.941090589211, 5896.410358964241, 5906.379830117776, 5952.226210592596, 5961.254843144607, 5835.241418615553, 6117.724702388492, 6125.407394077482, 6135.202423685071, 6148.0, 4216.494020717533, 4231.597998190167, 4236.279832428556, 4275.486941567032, 4286.95713042878, 5968.55289331372, 5984.281886173513, 6001.549883758648, 6008.43780617034, 6012.188354572252, 5622.887542249214, 5743.013632910779, 5766.481016708516, 5783.710814459176, 5821.85619765322, 5741.5406767459335, 5752.913706294493, 5760.567957403127, 5771.422857714195, 5802.709864506842, 5373.596980226421, 5699.373068962494, 5750.597458178055, 5764.337101233412, 5785.27684039495, 5684.8294551163535, 5742.511886489695, 5775.682337471311, 5779.035128056481, 5793.3337666167245, 5650.180723795109, 5651.915221271766, 5681.062624667049, 5711.372258906192, 5751.884962300647], "value": 4383.764677453392, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.6557807151246, 664.9394216225122, 690.2990633783928, 743.3718507860859, 766.3486036868662, 13801.378937947791, 14651.267436628179, 14684.118952862837, 14715.852841471595, 14774.113553186817, 12572.497100115985, 12642.0, 12657.493700252002, 13319.467221311135, 13633.250171240577, 794.5590197440418, 813.8616435206, 817.3992115794915, 819.4673462249526, 819.8811172380001, 785.4737325991599, 811.9147489513605, 812.2608426332039, 816.3061397811842, 826.5082276045773, 851.9105493923141, 857.6269322844552, 859.4628357276702, 861.7759382560516, 861.9569021548929, 852.8976522817239, 854.5599016506504, 857.9270761985208, 857.983289801584, 858.1804376820153, 624.0296339192554, 627.0, 627.9434850863398, 628.4815027602247, 630.7319389259592, 13967.0, 14057.71884562303, 14085.788713169311, 14129.505467308698, 14146.151230926178, 15031.173285469295, 15126.924365378212, 15145.318460669296, 15159.545213643609, 15325.386984520606, 10735.194860385423, 10861.750898646678, 11579.826302605468, 11666.416679166092, 11802.350870702108, 3803.4294855771577, 3812.1232116613055, 3841.5006049213703, 3844.7693138411505, 3862.208247309323, 79159.0, 79362.60318698427, 80961.0, 81061.59469202675, 81433.59283203605, 11132.220744547965, 11288.887111128784, 11380.317180969168, 11394.829077563843, 11627.825582616268, 21539.461513461974, 21597.784022159576, 21729.565408692055, 21756.238531651317, 21813.23653672114, 8058.556779377191, 8081.353491720648, 8088.0, 8282.213189747084, 8321.625526851307, 4501.48232953208, 4505.617022553054, 4547.226971414867, 4580.587747102777, 4583.152116858325, 3300.6369299377047, 3428.1086917401653, 3432.1248081739495, 3436.6563343665434, 3445.9483107753404, 587.4125874125874, 593.7239183779477, 620.3021600699213, 662.1888186971019, 674.7537148940602, 630.2342653675806, 671.8958561422987, 685.2736099734298, 685.6092027544352, 698.7868700046535, 8386.454880432751, 8681.479111253218, 8813.735587932373, 9002.954985225031, 9421.293402994803, 569.7948738454153, 648.2804087462912, 665.1751827733672, 670.3798985937988, 676.1851968378093, 4031.9395209071886, 4481.5070342262325, 4503.144402563568, 4561.361409402686, 4641.930371044437, 70546.64726676334, 85331.14668853232, 124231.0, 129473.0, 129814.0, 107453.46273268583, 108880.4555977215, 111176.0, 111531.0, 113367.43316283531, 94295.52852235695, 97133.5143324293, 98360.50819745855, 98986.99999999856, 101531.40045896993, 8402.579871006548, 8858.247049000649, 8902.688405905763, 9041.412308199946, 9161.31290153228, 52995.0, 54543.0, 55350.0, 55970.720146399006, 55976.720116399156, 74145.25854741599, 76570.0, 81774.18225817903, 81843.5907820457, 82752.0, 11100.389478578432, 11274.943625281821, 11282.94358528202, 11337.376444295644, 11439.42802859837, 10910.0, 11015.449227538751, 11040.503177356877, 12593.433295501542, 12678.112532122663, 14106.576802695936, 14241.572752817432, 14560.781588275973, 14578.271086445848, 14662.34019469105, 13477.123986940818, 13790.655233618838, 13906.860931390556, 14019.158850469004, 15338.15640139803, 14306.141631502143, 14325.498607549103, 14371.353289101806, 14432.278386080445, 15017.774733379227, 11037.227394082658, 11632.592859249886, 11742.530298787953, 12201.572944946884, 12310.199837010565, 10748.0, 11984.520619175135, 11996.940780101018, 12026.338551379758, 12331.383430828244], "value": 7449.276657708699, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 115.0, 116.0, 116.0, 114.0, 113.0, 114.0, 114.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 120.0, 123.0, 168.0, 122.0, 125.0, 128.0, 124.0, 153.0, 122.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 165.0, 167.0, 162.0, 164.0, 161.0, 163.0, 166.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 117.0, 76.0, 77.0, 76.0, 76.0, 103.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 113.0, 85.0, 83.0, 83.0, 105.0, 83.0, 82.0, 112.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 97.0, 97.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 55.0, 54.0, 53.0, 53.0, 60.0, 52.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 61.0, 61.0, 61.0, 63.0, 61.0, 62.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 81.0, 81.0, 80.0, 81.0, 80.0, 79.0, 79.0, 79.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 133.0, 133.0, 125.0, 137.0, 128.0, 128.0, 128.0, 168.0, 143.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 170.0, 166.0, 164.0, 174.0, 175.0, 171.0, 179.0, 166.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 66.0, 67.0, 67.0, 67.0, 70.0, 66.0, 68.0], "value": 67.5, "unit": "score"}]}]} 10:19:03 INFO - Return code: 0 10:19:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:19:03 ERROR - # TBPL SUCCESS # 10:19:03 INFO - Running post-action listener: _resource_record_post_action 10:19:03 INFO - [mozharness: 2016-09-22 17:19:03.309392Z] Finished run-tests step (success) 10:19:03 INFO - Running post-run listener: _resource_record_post_run 10:19:03 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394293248; Read time: 12; Write time: 266324 10:19:03 INFO - TinderboxPrint: CPU usage
13.3% 10:19:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:19:03 INFO - TinderboxPrint: I/O write bytes / time
394,293,248 / 266,324 10:19:03 INFO - TinderboxPrint: CPU idle
8,252.0 (86.7%) 10:19:03 INFO - TinderboxPrint: CPU user
1,208.8 (12.7%) 10:19:03 INFO - TinderboxPrint: Swap in / out
0 / 0 10:19:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105750528; Read time: 0; Write time: 60960 10:19:03 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 287514624; Read time: 0; Write time: 205324 10:19:03 INFO - Running post-run listener: _upload_blobber_files 10:19:03 INFO - Blob upload gear active. 10:19:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:19:03 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 10:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:19:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:19:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:19:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:19:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:05 INFO - (blobuploader) - INFO - Done attempting. 10:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:19:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:05 INFO - (blobuploader) - INFO - Done attempting. 10:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:19:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:09 INFO - (blobuploader) - INFO - Done attempting. 10:19:09 INFO - (blobuploader) - INFO - Iteration through files over. 10:19:09 INFO - Return code: 0 10:19:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:19:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:19:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8ea3243e0fe13dad3ce51b0f9c745eaff15fc23b88a58fbb406d49b1d8828c395e83348bd2525bbce2c07bd98737ab540ff6e69b01791d74c40355eec14c772", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6da0d553caacd002cef19f0f7966fe75b78f0cf1e2ab903e70b679731c975e2e9b53db94a46a7e60822f07c27e6c9e06d82e36b643cbea2a576f2f994fb06db1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/430b7c1bf3eb6897cf6bfac6cc0cdd2a13c037394aedd8a2df1d3563cda7d0e4a15a7613c9c1db78af14d650ef58c73ffa783d12f713c9387f956d36f85c4941"} 10:19:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:19:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:19:09 INFO - Contents: 10:19:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8ea3243e0fe13dad3ce51b0f9c745eaff15fc23b88a58fbb406d49b1d8828c395e83348bd2525bbce2c07bd98737ab540ff6e69b01791d74c40355eec14c772", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6da0d553caacd002cef19f0f7966fe75b78f0cf1e2ab903e70b679731c975e2e9b53db94a46a7e60822f07c27e6c9e06d82e36b643cbea2a576f2f994fb06db1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/430b7c1bf3eb6897cf6bfac6cc0cdd2a13c037394aedd8a2df1d3563cda7d0e4a15a7613c9c1db78af14d650ef58c73ffa783d12f713c9387f956d36f85c4941"} 10:19:09 INFO - Running post-run listener: copy_logs_to_upload_dir 10:19:09 INFO - Copying logs to upload dir... 10:19:09 INFO - mkdir: /builds/slave/test/build/upload/logs 10:19:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.034719 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-09-22 10:19:08.562727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 10:19:08.566119) ========= 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=0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8ea3243e0fe13dad3ce51b0f9c745eaff15fc23b88a58fbb406d49b1d8828c395e83348bd2525bbce2c07bd98737ab540ff6e69b01791d74c40355eec14c772", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6da0d553caacd002cef19f0f7966fe75b78f0cf1e2ab903e70b679731c975e2e9b53db94a46a7e60822f07c27e6c9e06d82e36b643cbea2a576f2f994fb06db1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/430b7c1bf3eb6897cf6bfac6cc0cdd2a13c037394aedd8a2df1d3563cda7d0e4a15a7613c9c1db78af14d650ef58c73ffa783d12f713c9387f956d36f85c4941"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011481 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8ea3243e0fe13dad3ce51b0f9c745eaff15fc23b88a58fbb406d49b1d8828c395e83348bd2525bbce2c07bd98737ab540ff6e69b01791d74c40355eec14c772", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6da0d553caacd002cef19f0f7966fe75b78f0cf1e2ab903e70b679731c975e2e9b53db94a46a7e60822f07c27e6c9e06d82e36b643cbea2a576f2f994fb06db1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/430b7c1bf3eb6897cf6bfac6cc0cdd2a13c037394aedd8a2df1d3563cda7d0e4a15a7613c9c1db78af14d650ef58c73ffa783d12f713c9387f956d36f85c4941"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 10:19:08.591894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 10:19:08.592227) ========= 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=0333a256a5e4f052382dd180000001b1-1474563511.770730-1423056120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 10:19:08.675564) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 10:19:08.675927) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 10:19:08.676253) ========= ========= Total master_lag: 0.17 =========