builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1470140949.43 results: success (0) buildid: 20160802052906 builduid: c13f73b2f595430382018a6c62b245e6 revision: 46045ec8a4aa09a341b7209170089ade3c27c1a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 05:29:09.428762) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 05:29:09.429125) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 05:29:09.429416) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 05:29:09.453071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:29:09.456375) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-02 05:29:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.8M=0s 2016-08-02 05:29:09 (50.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:29:09.556061) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:29:09.559433) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020428 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:29:09.610425) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-02 05:29:09.610783) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 46045ec8a4aa09a341b7209170089ade3c27c1a5 --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 46045ec8a4aa09a341b7209170089ade3c27c1a5 --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=a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-02 05:29:09,817 truncating revision to first 12 chars 2016-08-02 05:29:09,818 Setting DEBUG logging. 2016-08-02 05:29:09,818 attempt 1/10 2016-08-02 05:29:09,818 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/46045ec8a4aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-02 05:29:10,643 unpacking tar archive at: fx-team-46045ec8a4aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.161211 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-02 05:29:10.788591) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 05:29:10.788922) ========= script_repo_revision: 46045ec8a4aa09a341b7209170089ade3c27c1a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 05:29:10.789328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 05:29:10.789615) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 05:29:10.800814) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-08-02 05:29:10.801151) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:29:11 INFO - MultiFileLogger online at 20160802 05:29:11 in /builds/slave/test 05:29:11 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 05:29:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:11 INFO - {'append_to_log': False, 05:29:11 INFO - 'base_work_dir': '/builds/slave/test', 05:29:11 INFO - 'blob_upload_branch': 'Fx-Team', 05:29:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:11 INFO - 'branch': 'Fx-Team', 05:29:11 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:11 INFO - 'config_files': ('talos/linux_config.py',), 05:29:11 INFO - 'default_actions': ('clobber', 05:29:11 INFO - 'read-buildbot-config', 05:29:11 INFO - 'download-and-extract', 05:29:11 INFO - 'populate-webroot', 05:29:11 INFO - 'create-virtualenv', 05:29:11 INFO - 'install', 05:29:11 INFO - 'run-tests'), 05:29:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:11 INFO - 'download_minidump_stackwalk': True, 05:29:11 INFO - 'download_symbols': 'ondemand', 05:29:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:11 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:11 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:11 INFO - 'installer_path': 'installer.exe', 05:29:11 INFO - 'log_level': 'info', 05:29:11 INFO - 'log_name': 'talos', 05:29:11 INFO - 'log_to_console': True, 05:29:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:29:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:29:11 INFO - 'opt_config_files': (), 05:29:11 INFO - 'pip_index': False, 05:29:11 INFO - 'sps_profile': False, 05:29:11 INFO - 'sps_profile_interval': 0, 05:29:11 INFO - 'suite': 'dromaeojs-e10s', 05:29:11 INFO - 'system_bits': '32', 05:29:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:11 INFO - 'title': 'talos-linux64-ix-062', 05:29:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:11 INFO - 'use_talos_json': True, 05:29:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:11 INFO - 'work_dir': 'build'} 05:29:11 INFO - [mozharness: 2016-08-02 12:29:11.101994Z] Running clobber step. 05:29:11 INFO - Running pre-action listener: _resource_record_pre_action 05:29:11 INFO - Running main action method: clobber 05:29:11 INFO - rmtree: /builds/slave/test/build 05:29:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:11 INFO - Running post-action listener: _resource_record_post_action 05:29:11 INFO - [mozharness: 2016-08-02 12:29:11.558399Z] Finished clobber step (success) 05:29:11 INFO - [mozharness: 2016-08-02 12:29:11.558500Z] Running read-buildbot-config step. 05:29:11 INFO - Running pre-action listener: _resource_record_pre_action 05:29:11 INFO - Running main action method: read_buildbot_config 05:29:11 INFO - Using buildbot properties: 05:29:11 INFO - { 05:29:11 INFO - "project": "", 05:29:11 INFO - "product": "firefox", 05:29:11 INFO - "script_repo_revision": "production", 05:29:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:29:11 INFO - "repository": "", 05:29:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:29:11 INFO - "buildid": "20160802052906", 05:29:11 INFO - "stage_platform": "linux64-pgo", 05:29:11 INFO - "basedir": "/builds/slave/test", 05:29:11 INFO - "buildnumber": 1002, 05:29:11 INFO - "platform": "ubuntu64_hw", 05:29:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:29:11 INFO - "slavebuilddir": "test", 05:29:11 INFO - "branch": "fx-team", 05:29:11 INFO - "revision": "46045ec8a4aa09a341b7209170089ade3c27c1a5", 05:29:11 INFO - "slavename": "talos-linux64-ix-062", 05:29:11 INFO - "builduid": "c13f73b2f595430382018a6c62b245e6", 05:29:11 INFO - "repo_path": "integration/fx-team" 05:29:11 INFO - } 05:29:11 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:29:11 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 05:29:11 INFO - Running post-action listener: _resource_record_post_action 05:29:11 INFO - [mozharness: 2016-08-02 12:29:11.560886Z] Finished read-buildbot-config step (success) 05:29:11 INFO - [mozharness: 2016-08-02 12:29:11.560976Z] Running download-and-extract step. 05:29:11 INFO - Running pre-action listener: _resource_record_pre_action 05:29:11 INFO - Running main action method: download_and_extract 05:29:11 INFO - mkdir: /builds/slave/test/build/tests 05:29:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:11 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:29:11 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:29:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:29:12 INFO - Downloaded 1361 bytes. 05:29:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:29:12 INFO - Using the following test package requirements: 05:29:12 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:12 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:29:12 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:29:12 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:12 INFO - u'jsshell-linux-x86_64.zip'], 05:29:12 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:29:12 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:12 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:29:12 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:29:12 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:29:12 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:29:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:29:12 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:12 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:29:12 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:29:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:29:20 INFO - Downloaded 21809159 bytes. 05:29:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:29:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:29:21 INFO - Return code: 0 05:29:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:29:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:29:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:29:22 INFO - Downloaded 21809159 bytes. 05:29:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:29:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:29:23 INFO - Return code: 0 05:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:29:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:29:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:29:30 INFO - Downloaded 14413723 bytes. 05:29:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:29:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:29:31 INFO - Return code: 0 05:29:31 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:31 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:29:31 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:29:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:29:51 INFO - Downloaded 59388049 bytes. 05:29:51 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:29:51 INFO - mkdir: /builds/slave/test/properties 05:29:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:29:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:29:51 INFO - Contents: 05:29:51 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:29:51 INFO - Running post-action listener: _resource_record_post_action 05:29:51 INFO - Running post-action listener: set_extra_try_arguments 05:29:51 INFO - [mozharness: 2016-08-02 12:29:51.626159Z] Finished download-and-extract step (success) 05:29:51 INFO - [mozharness: 2016-08-02 12:29:51.626439Z] Running populate-webroot step. 05:29:51 INFO - Running pre-action listener: _resource_record_pre_action 05:29:51 INFO - Running main action method: populate_webroot 05:29:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:29:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:29:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:29:51 INFO - '--tppagecycles', 05:29:51 INFO - '7'], 05:29:51 INFO - 'tests': ['tsvgm']}}, 05:29:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:29:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:29:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:29:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:29:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:29:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:29:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:51 INFO - 'talos_options': ['--disable-e10s'], 05:29:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:51 INFO - 'talos_options': ['--disable-e10s'], 05:29:51 INFO - 'tests': ['damp', 'tps']}, 05:29:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:51 INFO - 'tests': ['damp', 'tps']}, 05:29:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:29:51 INFO - 'tests': ['dromaeo_dom']}, 05:29:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:29:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:29:51 INFO - 'tests': ['basic_compositor_video']}, 05:29:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:29:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:29:51 INFO - 'tests': ['a11yr', 05:29:51 INFO - 'ts_paint', 05:29:51 INFO - 'tpaint', 05:29:51 INFO - 'sessionrestore', 05:29:51 INFO - 'sessionrestore_no_auto_restore', 05:29:51 INFO - 'tabpaint']}, 05:29:51 INFO - 'other-e10s': {'tests': ['a11yr', 05:29:51 INFO - 'ts_paint', 05:29:51 INFO - 'tpaint', 05:29:51 INFO - 'sessionrestore', 05:29:51 INFO - 'sessionrestore_no_auto_restore', 05:29:51 INFO - 'tabpaint']}, 05:29:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:29:51 INFO - 'ts_paint', 05:29:51 INFO - 'tpaint', 05:29:51 INFO - 'sessionrestore', 05:29:51 INFO - 'sessionrestore_no_auto_restore', 05:29:51 INFO - 'tabpaint']}, 05:29:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:29:51 INFO - 'ts_paint', 05:29:51 INFO - 'tpaint', 05:29:51 INFO - 'sessionrestore', 05:29:51 INFO - 'sessionrestore_no_auto_restore', 05:29:51 INFO - 'tabpaint']}, 05:29:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:29:51 INFO - 'tests': ['a11yr', 05:29:51 INFO - 'ts_paint', 05:29:51 INFO - 'tpaint', 05:29:51 INFO - 'sessionrestore', 05:29:51 INFO - 'sessionrestore_no_auto_restore', 05:29:51 INFO - 'tabpaint']}, 05:29:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:29:51 INFO - 'tests': ['a11yr', 05:29:51 INFO - 'ts_paint', 05:29:51 INFO - 'tpaint', 05:29:51 INFO - 'sessionrestore', 05:29:51 INFO - 'sessionrestore_no_auto_restore', 05:29:51 INFO - 'tabpaint']}, 05:29:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:29:51 INFO - 'tests': ['tsvgx', 05:29:51 INFO - 'tsvgr_opacity', 05:29:51 INFO - 'tart', 05:29:51 INFO - 'tscrollx', 05:29:51 INFO - 'cart']}, 05:29:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:29:51 INFO - 'tsvgr_opacity', 05:29:51 INFO - 'tart', 05:29:51 INFO - 'tscrollx', 05:29:51 INFO - 'cart']}, 05:29:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:51 INFO - 'talos_options': ['--disable-e10s'], 05:29:51 INFO - 'tests': ['tp5o']}, 05:29:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:51 INFO - 'tests': ['tp5o']}, 05:29:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:51 INFO - 'talos_options': ['--disable-e10s', 05:29:51 INFO - '--xperf_path', 05:29:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:51 INFO - 'tests': ['tp5n']}, 05:29:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:51 INFO - 'talos_options': ['--xperf_path', 05:29:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:51 INFO - 'tests': ['tp5n']}}, 05:29:51 INFO - 'talos.zip': {'path': '', 05:29:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:29:51 INFO - Running post-action listener: _resource_record_post_action 05:29:51 INFO - [mozharness: 2016-08-02 12:29:51.647147Z] Finished populate-webroot step (success) 05:29:51 INFO - [mozharness: 2016-08-02 12:29:51.647237Z] Running create-virtualenv step. 05:29:51 INFO - Running pre-action listener: _resource_record_pre_action 05:29:51 INFO - Running main action method: create_virtualenv 05:29:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:29:51 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 05:29:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:29:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:29:51 INFO - Using real prefix '/usr' 05:29:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:29:52 INFO - Installing distribute.............................................................................................................................................................................................done. 05:29:54 INFO - Installing pip.................done. 05:29:54 INFO - Return code: 0 05:29:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f153b0>, '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 0x1f162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f16740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', '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 05:29: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', 'pip>=1.5'] in /builds/slave/test/build 05:29: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 pip>=1.5 05:29:54 INFO - Using env: {'DISPLAY': ':0', 05:29:54 INFO - 'HOME': '/home/cltbld', 05:29:54 INFO - 'LANG': 'en_US.UTF-8', 05:29:54 INFO - 'LANGUAGE': 'en_US:en', 05:29:54 INFO - 'LOGNAME': 'cltbld', 05:29:54 INFO - 'MAIL': '/var/mail/cltbld', 05:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:54 INFO - 'MOZ_NO_REMOTE': '1', 05:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:54 INFO - 'NO_EM_RESTART': '1', 05:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:54 INFO - 'PWD': '/builds/slave/test', 05:29:54 INFO - 'SHELL': '/bin/bash', 05:29:54 INFO - 'SHLVL': '1', 05:29:54 INFO - 'TERM': 'linux', 05:29:54 INFO - 'TMOUT': '86400', 05:29:54 INFO - 'USER': 'cltbld', 05:29:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', 05:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:54 INFO - '_': '/tools/buildbot/bin/python'} 05:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:54 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 05:29:54 INFO - Cleaning up... 05:29:54 INFO - Return code: 0 05:29:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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', '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 0x1c56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f153b0>, '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 0x1f162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f16740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', '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 05:29: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:29: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 psutil>=3.1.1 05:29:54 INFO - Using env: {'DISPLAY': ':0', 05:29:54 INFO - 'HOME': '/home/cltbld', 05:29:54 INFO - 'LANG': 'en_US.UTF-8', 05:29:54 INFO - 'LANGUAGE': 'en_US:en', 05:29:54 INFO - 'LOGNAME': 'cltbld', 05:29:54 INFO - 'MAIL': '/var/mail/cltbld', 05:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:54 INFO - 'MOZ_NO_REMOTE': '1', 05:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:54 INFO - 'NO_EM_RESTART': '1', 05:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:54 INFO - 'PWD': '/builds/slave/test', 05:29:54 INFO - 'SHELL': '/bin/bash', 05:29:54 INFO - 'SHLVL': '1', 05:29:54 INFO - 'TERM': 'linux', 05:29:54 INFO - 'TMOUT': '86400', 05:29:54 INFO - 'USER': 'cltbld', 05:29:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', 05:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:54 INFO - '_': '/tools/buildbot/bin/python'} 05:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:54 INFO - Downloading/unpacking psutil>=3.1.1 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:29:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:56 INFO - Installing collected packages: psutil 05:29:56 INFO - Running setup.py install for psutil 05:29:56 INFO - building 'psutil._psutil_linux' extension 05:29:56 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 05:29:56 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 05:29:56 INFO - building 'psutil._psutil_posix' extension 05:29:56 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 05:29:57 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 05:29:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:57 INFO - Successfully installed psutil 05:29:57 INFO - Cleaning up... 05:29:57 INFO - Return code: 0 05:29:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f153b0>, '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 0x1f162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f16740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', '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 05:29: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:29: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 mozsystemmonitor==0.3 05:29:57 INFO - Using env: {'DISPLAY': ':0', 05:29:57 INFO - 'HOME': '/home/cltbld', 05:29:57 INFO - 'LANG': 'en_US.UTF-8', 05:29:57 INFO - 'LANGUAGE': 'en_US:en', 05:29:57 INFO - 'LOGNAME': 'cltbld', 05:29:57 INFO - 'MAIL': '/var/mail/cltbld', 05:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:57 INFO - 'MOZ_NO_REMOTE': '1', 05:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:57 INFO - 'NO_EM_RESTART': '1', 05:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:57 INFO - 'PWD': '/builds/slave/test', 05:29:57 INFO - 'SHELL': '/bin/bash', 05:29:57 INFO - 'SHLVL': '1', 05:29:57 INFO - 'TERM': 'linux', 05:29:57 INFO - 'TMOUT': '86400', 05:29:57 INFO - 'USER': 'cltbld', 05:29:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', 05:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:57 INFO - '_': '/tools/buildbot/bin/python'} 05:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:29:59 INFO - Installing collected packages: mozsystemmonitor 05:29:59 INFO - Running setup.py install for mozsystemmonitor 05:29:59 INFO - Successfully installed mozsystemmonitor 05:29:59 INFO - Cleaning up... 05:29:59 INFO - Return code: 0 05:29:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:29:59 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:59 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:59 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 0x1c56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f153b0>, '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 0x1f162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f16740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', '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 05:29:59 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 05:29:59 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 05:29:59 INFO - Using env: {'DISPLAY': ':0', 05:29:59 INFO - 'HOME': '/home/cltbld', 05:29:59 INFO - 'LANG': 'en_US.UTF-8', 05:29:59 INFO - 'LANGUAGE': 'en_US:en', 05:29:59 INFO - 'LOGNAME': 'cltbld', 05:29:59 INFO - 'MAIL': '/var/mail/cltbld', 05:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:59 INFO - 'MOZ_NO_REMOTE': '1', 05:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:59 INFO - 'NO_EM_RESTART': '1', 05:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:59 INFO - 'PWD': '/builds/slave/test', 05:29:59 INFO - 'SHELL': '/bin/bash', 05:29:59 INFO - 'SHLVL': '1', 05:29:59 INFO - 'TERM': 'linux', 05:29:59 INFO - 'TMOUT': '86400', 05:29:59 INFO - 'USER': 'cltbld', 05:29:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', 05:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:59 INFO - '_': '/tools/buildbot/bin/python'} 05:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:59 INFO - Downloading/unpacking jsonschema==2.5.1 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:30:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:30:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:30:01 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 05:30:01 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 05:30:01 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 05:30:01 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 05:30:01 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 05:30:01 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 05:30:01 INFO - Downloading functools32-3.2.3-2.tar.gz 05:30:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:30:01 INFO - warning: no files found matching '*.txt' 05:30:01 INFO - no previously-included directories found matching 'build' 05:30:01 INFO - no previously-included directories found matching 'dist' 05:30:01 INFO - no previously-included directories found matching '.git*' 05:30:01 INFO - Installing collected packages: jsonschema, functools32 05:30:02 INFO - Running setup.py install for functools32 05:30:02 INFO - warning: no files found matching '*.txt' 05:30:02 INFO - no previously-included directories found matching 'build' 05:30:02 INFO - no previously-included directories found matching 'dist' 05:30:02 INFO - no previously-included directories found matching '.git*' 05:30:02 INFO - Successfully installed jsonschema functools32 05:30:02 INFO - Cleaning up... 05:30:02 INFO - Return code: 0 05:30:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:30:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:02 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 0x1c56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f153b0>, '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 0x1f162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f16740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', '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 05:30:02 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 05:30:02 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 05:30:02 INFO - Using env: {'DISPLAY': ':0', 05:30:02 INFO - 'HOME': '/home/cltbld', 05:30:02 INFO - 'LANG': 'en_US.UTF-8', 05:30:02 INFO - 'LANGUAGE': 'en_US:en', 05:30:02 INFO - 'LOGNAME': 'cltbld', 05:30:02 INFO - 'MAIL': '/var/mail/cltbld', 05:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:02 INFO - 'MOZ_NO_REMOTE': '1', 05:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:02 INFO - 'NO_EM_RESTART': '1', 05:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:02 INFO - 'PWD': '/builds/slave/test', 05:30:02 INFO - 'SHELL': '/bin/bash', 05:30:02 INFO - 'SHLVL': '1', 05:30:02 INFO - 'TERM': 'linux', 05:30:02 INFO - 'TMOUT': '86400', 05:30:02 INFO - 'USER': 'cltbld', 05:30:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', 05:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:02 INFO - '_': '/tools/buildbot/bin/python'} 05:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:30:02 INFO - Cleaning up... 05:30:02 INFO - Return code: 0 05:30:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:30:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:02 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 0x1c56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f153b0>, '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 0x1f162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f16740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', '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 05:30:02 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 05:30:02 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 05:30:02 INFO - Using env: {'DISPLAY': ':0', 05:30:02 INFO - 'HOME': '/home/cltbld', 05:30:02 INFO - 'LANG': 'en_US.UTF-8', 05:30:02 INFO - 'LANGUAGE': 'en_US:en', 05:30:02 INFO - 'LOGNAME': 'cltbld', 05:30:02 INFO - 'MAIL': '/var/mail/cltbld', 05:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:02 INFO - 'MOZ_NO_REMOTE': '1', 05:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:02 INFO - 'NO_EM_RESTART': '1', 05:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:02 INFO - 'PWD': '/builds/slave/test', 05:30:02 INFO - 'SHELL': '/bin/bash', 05:30:02 INFO - 'SHLVL': '1', 05:30:02 INFO - 'TERM': 'linux', 05:30:02 INFO - 'TMOUT': '86400', 05:30:02 INFO - 'USER': 'cltbld', 05:30:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', 05:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:02 INFO - '_': '/tools/buildbot/bin/python'} 05:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:02 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:04 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 05:30:04 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 05:30:04 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 05:30:04 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 05:30:04 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 05:30:04 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 05:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:30:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:04 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 05:30:04 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 05:30:04 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 05:30:04 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 05:30:04 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 05:30:04 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 05:30:05 INFO - Downloading docopt-0.6.1.tar.gz 05:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:05 INFO - Running setup.py install for blobuploader 05:30:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:30:05 INFO - Running setup.py install for requests 05:30:05 INFO - Running setup.py install for docopt 05:30:05 INFO - Successfully installed blobuploader requests docopt 05:30:05 INFO - Cleaning up... 05:30:06 INFO - Return code: 0 05:30:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:06 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:06 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:06 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 0x1c56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f153b0>, '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 0x1f162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f16740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', '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 05:30:06 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 05:30:06 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 05:30:06 INFO - Using env: {'DISPLAY': ':0', 05:30:06 INFO - 'HOME': '/home/cltbld', 05:30:06 INFO - 'LANG': 'en_US.UTF-8', 05:30:06 INFO - 'LANGUAGE': 'en_US:en', 05:30:06 INFO - 'LOGNAME': 'cltbld', 05:30:06 INFO - 'MAIL': '/var/mail/cltbld', 05:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:06 INFO - 'MOZ_NO_REMOTE': '1', 05:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:06 INFO - 'NO_EM_RESTART': '1', 05:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:06 INFO - 'PWD': '/builds/slave/test', 05:30:06 INFO - 'SHELL': '/bin/bash', 05:30:06 INFO - 'SHLVL': '1', 05:30:06 INFO - 'TERM': 'linux', 05:30:06 INFO - 'TMOUT': '86400', 05:30:06 INFO - 'USER': 'cltbld', 05:30:06 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', 05:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:06 INFO - '_': '/tools/buildbot/bin/python'} 05:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:06 INFO - Running setup.py (path:/tmp/pip-_TfpTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:06 INFO - Running setup.py (path:/tmp/pip-6oyLlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:06 INFO - Running setup.py (path:/tmp/pip-SyOXQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:06 INFO - Running setup.py (path:/tmp/pip-ZCeXVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:06 INFO - Running setup.py (path:/tmp/pip-o_fvtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:06 INFO - Running setup.py (path:/tmp/pip-cs_JdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:06 INFO - Running setup.py (path:/tmp/pip-IGNqqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:06 INFO - Running setup.py (path:/tmp/pip-x1e0YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:07 INFO - Running setup.py (path:/tmp/pip-_EZJ2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:07 INFO - Running setup.py (path:/tmp/pip-vyEB5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:07 INFO - Running setup.py (path:/tmp/pip-q9woeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:07 INFO - Running setup.py (path:/tmp/pip-iDqn7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:07 INFO - Running setup.py (path:/tmp/pip-J3mCqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:07 INFO - Running setup.py (path:/tmp/pip-oe8uNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:07 INFO - Running setup.py (path:/tmp/pip-rgeEsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:07 INFO - Running setup.py (path:/tmp/pip-TDUtUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:07 INFO - Running setup.py (path:/tmp/pip-8DhS43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:07 INFO - Running setup.py install for manifestparser 05:30:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:30:07 INFO - Running setup.py install for mozcrash 05:30:07 INFO - Running setup.py install for mozdebug 05:30:07 INFO - Running setup.py install for mozdevice 05:30:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:30:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:30:08 INFO - Running setup.py install for mozfile 05:30:08 INFO - Running setup.py install for mozhttpd 05:30:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:30:08 INFO - Running setup.py install for mozinfo 05:30:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:08 INFO - Running setup.py install for mozInstall 05:30:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:08 INFO - Running setup.py install for mozleak 05:30:08 INFO - Running setup.py install for mozlog 05:30:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:08 INFO - Running setup.py install for moznetwork 05:30:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:08 INFO - Running setup.py install for mozprocess 05:30:08 INFO - Running setup.py install for mozprofile 05:30:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:09 INFO - Running setup.py install for mozrunner 05:30:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:09 INFO - Running setup.py install for mozscreenshot 05:30:09 INFO - Running setup.py install for moztest 05:30:09 INFO - Running setup.py install for mozversion 05:30:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:09 INFO - Cleaning up... 05:30:09 INFO - Return code: 0 05:30:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:09 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 0x1c56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f153b0>, '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 0x1f162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f16740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', '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 05:30:09 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 05:30:09 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 05:30:09 INFO - Using env: {'DISPLAY': ':0', 05:30:09 INFO - 'HOME': '/home/cltbld', 05:30:09 INFO - 'LANG': 'en_US.UTF-8', 05:30:09 INFO - 'LANGUAGE': 'en_US:en', 05:30:09 INFO - 'LOGNAME': 'cltbld', 05:30:09 INFO - 'MAIL': '/var/mail/cltbld', 05:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:09 INFO - 'MOZ_NO_REMOTE': '1', 05:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:09 INFO - 'NO_EM_RESTART': '1', 05:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:09 INFO - 'PWD': '/builds/slave/test', 05:30:09 INFO - 'SHELL': '/bin/bash', 05:30:09 INFO - 'SHLVL': '1', 05:30:09 INFO - 'TERM': 'linux', 05:30:09 INFO - 'TMOUT': '86400', 05:30:09 INFO - 'USER': 'cltbld', 05:30:09 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', 05:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:09 INFO - '_': '/tools/buildbot/bin/python'} 05:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:09 INFO - Running setup.py (path:/tmp/pip-smPiCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:09 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)) 05:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:09 INFO - Running setup.py (path:/tmp/pip-0a1UNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:09 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)) 05:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:09 INFO - Running setup.py (path:/tmp/pip-E7nQKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:09 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)) 05:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:09 INFO - Running setup.py (path:/tmp/pip-I3DWhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:10 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)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:10 INFO - Running setup.py (path:/tmp/pip-r8Tkj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:10 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)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:10 INFO - Running setup.py (path:/tmp/pip-MC9Js_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:10 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)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:10 INFO - Running setup.py (path:/tmp/pip-KEm9Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:10 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)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:10 INFO - Running setup.py (path:/tmp/pip-TsIgYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:10 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)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:10 INFO - Running setup.py (path:/tmp/pip-Ywdu5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:10 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)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:10 INFO - Running setup.py (path:/tmp/pip-_bxF_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:10 INFO - Running setup.py (path:/tmp/pip-loJs9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:10 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)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:10 INFO - Running setup.py (path:/tmp/pip-Vb_MeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:10 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)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:10 INFO - Running setup.py (path:/tmp/pip-ZKSOUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:10 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)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:10 INFO - Running setup.py (path:/tmp/pip-DFJmub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:10 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)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:10 INFO - Running setup.py (path:/tmp/pip-yev0By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:10 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)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:10 INFO - Running setup.py (path:/tmp/pip-XW2YVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:10 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)) 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:10 INFO - Running setup.py (path:/tmp/pip-lrKwCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:10 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)) 05:30:10 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)) 05:30:10 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)) 05:30:10 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)) 05:30:10 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)) 05:30:10 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)) 05:30:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:10 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 05:30:10 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 05:30:10 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 05:30:10 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 05:30:10 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 05:30:10 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 05:30:12 INFO - Downloading blessings-1.6.tar.gz 05:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:12 INFO - Installing collected packages: blessings 05:30:12 INFO - Running setup.py install for blessings 05:30:13 INFO - Successfully installed blessings 05:30:13 INFO - Cleaning up... 05:30:13 INFO - Return code: 0 05:30:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:13 INFO - Reading from file tmpfile_stdout 05:30:13 INFO - Current package versions: 05:30:13 INFO - argparse == 1.2.1 05:30:13 INFO - blessings == 1.6 05:30:13 INFO - blobuploader == 1.2.4 05:30:13 INFO - docopt == 0.6.1 05:30:13 INFO - functools32 == 3.2.3-2 05:30:13 INFO - jsonschema == 2.5.1 05:30:13 INFO - manifestparser == 1.1 05:30:13 INFO - mozInstall == 1.12 05:30:13 INFO - mozcrash == 0.17 05:30:13 INFO - mozdebug == 0.1 05:30:13 INFO - mozdevice == 0.48 05:30:13 INFO - mozfile == 1.2 05:30:13 INFO - mozhttpd == 0.7 05:30:13 INFO - mozinfo == 0.9 05:30:13 INFO - mozleak == 0.1 05:30:13 INFO - mozlog == 3.3 05:30:13 INFO - moznetwork == 0.27 05:30:13 INFO - mozprocess == 0.23 05:30:13 INFO - mozprofile == 0.28 05:30:13 INFO - mozrunner == 6.12 05:30:13 INFO - mozscreenshot == 0.1 05:30:13 INFO - mozsystemmonitor == 0.3 05:30:13 INFO - moztest == 0.7 05:30:13 INFO - mozversion == 1.4 05:30:13 INFO - psutil == 3.1.1 05:30:13 INFO - requests == 1.2.3 05:30:13 INFO - wsgiref == 0.1.2 05:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:13 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 0x1c56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f153b0>, '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 0x1f162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f16740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', '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 05:30:13 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 05:30:13 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 05:30:13 INFO - Using env: {'DISPLAY': ':0', 05:30:13 INFO - 'HOME': '/home/cltbld', 05:30:13 INFO - 'LANG': 'en_US.UTF-8', 05:30:13 INFO - 'LANGUAGE': 'en_US:en', 05:30:13 INFO - 'LOGNAME': 'cltbld', 05:30:13 INFO - 'MAIL': '/var/mail/cltbld', 05:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:13 INFO - 'MOZ_NO_REMOTE': '1', 05:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:13 INFO - 'NO_EM_RESTART': '1', 05:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:13 INFO - 'PWD': '/builds/slave/test', 05:30:13 INFO - 'SHELL': '/bin/bash', 05:30:13 INFO - 'SHLVL': '1', 05:30:13 INFO - 'TERM': 'linux', 05:30:13 INFO - 'TMOUT': '86400', 05:30:13 INFO - 'USER': 'cltbld', 05:30:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', 05:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:13 INFO - '_': '/tools/buildbot/bin/python'} 05:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:13 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)) 05:30:13 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)) 05:30:13 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)) 05:30:13 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)) 05:30:13 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)) 05:30:13 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)) 05:30:13 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)) 05:30:13 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)) 05:30:13 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)) 05:30:13 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)) 05:30:13 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)) 05:30:13 INFO - Cleaning up... 05:30:13 INFO - Return code: 0 05:30:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:30:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:13 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 0x1c56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f153b0>, '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 0x1f162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f16740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', '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 05:30:13 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 05:30:13 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 05:30:13 INFO - Using env: {'DISPLAY': ':0', 05:30:13 INFO - 'HOME': '/home/cltbld', 05:30:13 INFO - 'LANG': 'en_US.UTF-8', 05:30:13 INFO - 'LANGUAGE': 'en_US:en', 05:30:13 INFO - 'LOGNAME': 'cltbld', 05:30:13 INFO - 'MAIL': '/var/mail/cltbld', 05:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:13 INFO - 'MOZ_NO_REMOTE': '1', 05:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:13 INFO - 'NO_EM_RESTART': '1', 05:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:13 INFO - 'PWD': '/builds/slave/test', 05:30:13 INFO - 'SHELL': '/bin/bash', 05:30:13 INFO - 'SHLVL': '1', 05:30:13 INFO - 'TERM': 'linux', 05:30:13 INFO - 'TMOUT': '86400', 05:30:13 INFO - 'USER': 'cltbld', 05:30:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', 05:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:13 INFO - '_': '/tools/buildbot/bin/python'} 05:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:30:13 INFO - Cleaning up... 05:30:13 INFO - Return code: 0 05:30:13 INFO - Running post-action listener: _resource_record_post_action 05:30:13 INFO - Running post-action listener: _start_resource_monitoring 05:30:13 INFO - Starting resource monitoring. 05:30:13 INFO - [mozharness: 2016-08-02 12:30:13.829819Z] Finished create-virtualenv step (success) 05:30:13 INFO - [mozharness: 2016-08-02 12:30:13.830256Z] Running install step. 05:30:13 INFO - Running pre-action listener: _resource_record_pre_action 05:30:13 INFO - Running main action method: install 05:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:14 INFO - Reading from file tmpfile_stdout 05:30:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:14 INFO - Reading from file tmpfile_stdout 05:30:14 INFO - Output received: 05:30:14 INFO - Usage: mozinstall [options] installer 05:30:14 INFO - Options: 05:30:14 INFO - -h, --help show this help message and exit 05:30:14 INFO - -d DEST, --destination=DEST 05:30:14 INFO - Directory to install application into. [default: 05:30:14 INFO - "/builds/slave/test"] 05:30:14 INFO - --app=APP Application being installed. [default: firefox] 05:30:14 INFO - mkdir: /builds/slave/test/build/application 05:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:30:31 INFO - Reading from file tmpfile_stdout 05:30:31 INFO - Output received: 05:30:31 INFO - /builds/slave/test/build/application/firefox/firefox 05:30:31 INFO - Running post-action listener: _resource_record_post_action 05:30:31 INFO - [mozharness: 2016-08-02 12:30:31.015371Z] Finished install step (success) 05:30:31 INFO - [mozharness: 2016-08-02 12:30:31.015649Z] Running run-tests step. 05:30:31 INFO - Running pre-action listener: _resource_record_pre_action 05:30:31 INFO - Running main action method: run_tests 05:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:30:31 INFO - Python 2.7.3 05:30:31 INFO - Return code: 0 05:30:31 INFO - grabbing minidump binary from tooltool 05:30:31 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:31 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 0x1f153b0>, '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 0x1f162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f16740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:30:31 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 05:30:31 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 05:30:31 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 05:30:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:30:31 INFO - Return code: 0 05:30:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:30:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:30:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:30:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:30:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:30:31 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 05:30:31 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 http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 05:30:31 INFO - Using env: {'DISPLAY': ':0', 05:30:31 INFO - 'HOME': '/home/cltbld', 05:30:31 INFO - 'LANG': 'en_US.UTF-8', 05:30:31 INFO - 'LANGUAGE': 'en_US:en', 05:30:31 INFO - 'LOGNAME': 'cltbld', 05:30:31 INFO - 'MAIL': '/var/mail/cltbld', 05:30:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:30:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:31 INFO - 'MOZ_NO_REMOTE': '1', 05:30:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:31 INFO - 'NO_EM_RESTART': '1', 05:30:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:31 INFO - 'PWD': '/builds/slave/test', 05:30:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:30:31 INFO - 'SHELL': '/bin/bash', 05:30:31 INFO - 'SHLVL': '1', 05:30:31 INFO - 'TERM': 'linux', 05:30:31 INFO - 'TMOUT': '86400', 05:30:31 INFO - 'USER': 'cltbld', 05:30:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385', 05:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:31 INFO - '_': '/tools/buildbot/bin/python'} 05:30:31 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 05:30:31 INFO - mozversion application_buildid: 20160802023001 05:30:31 INFO - mozversion application_changeset: 46045ec8a4aa09a341b7209170089ade3c27c1a5 05:30:31 INFO - mozversion application_display_name: Nightly 05:30:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:31 INFO - mozversion application_name: Firefox 05:30:31 INFO - mozversion application_remotingname: firefox 05:30:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:30:31 INFO - mozversion application_vendor: Mozilla 05:30:31 INFO - mozversion application_version: 51.0a1 05:30:31 INFO - mozversion platform_buildid: 20160802023001 05:30:31 INFO - mozversion platform_changeset: 46045ec8a4aa09a341b7209170089ade3c27c1a5 05:30:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:30:31 INFO - mozversion platform_version: 51.0a1 05:30:31 INFO - using testdate: 1470141031 05:30:31 INFO - actual date: 1470141031 05:30:31 INFO - starting webserver on 'localhost:58725' 05:30:31 INFO - SUITE-START | Running 2 tests 05:30:31 INFO - TEST-START | dromaeo_css 05:30:31 INFO - operating with platform_type : linux_ 05:30:31 INFO - Initialising browser for dromaeo_css test... 05:30:31 INFO - TEST-INFO | started process 19664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxrvVk5/profile http://localhost:58725/getInfo.html) 05:30:35 INFO - PROCESS | 19664 | __metrics Screen width/height:1600/1200 05:30:35 INFO - PROCESS | 19664 | colorDepth:24 05:30:35 INFO - PROCESS | 19664 | Browser inner width/height: 1024/697 05:30:35 INFO - PROCESS | 19664 | __metrics 05:30:36 ERROR - PROCESS | 19664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:30:36 INFO - TEST-INFO | 19664: exit 0 05:30:36 INFO - Browser initialized. 05:30:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:30:36 INFO - TEST-INFO | started process 19784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxrvVk5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:48 INFO - PROCESS | 19784 | RSS: Main: 163590144 05:30:48 INFO - PROCESS | 19784 | 05:31:38 INFO - PROCESS | 19784 | 1470141098178 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] 05:33:46 INFO - PROCESS | 19784 | Cycle 1(1): loaded http://localhost:58725/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58725/tests/dromaeo/cssquery-ext.html) 05:33:48 INFO - PROCESS | 19784 | RSS: Main: 169320448 05:33:48 INFO - PROCESS | 19784 | 05:36:50 INFO - PROCESS | 19784 | Cycle 1(1): loaded http://localhost:58725/tests/dromaeo/cssquery-ext.html (next: http://localhost:58725/tests/dromaeo/cssquery-jquery.html) 05:36:50 INFO - PROCESS | 19784 | RSS: Main: 166686720 05:36:50 INFO - PROCESS | 19784 | 05:39:52 INFO - PROCESS | 19784 | Cycle 1(1): loaded http://localhost:58725/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58725/tests/dromaeo/cssquery-mootools.html) 05:39:53 INFO - PROCESS | 19784 | RSS: Main: 169902080 05:39:53 INFO - PROCESS | 19784 | 05:42:55 INFO - PROCESS | 19784 | Cycle 1(1): loaded http://localhost:58725/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58725/tests/dromaeo/cssquery-prototype.html) 05:42:55 INFO - PROCESS | 19784 | RSS: Main: 164331520 05:42:55 INFO - PROCESS | 19784 | 05:45:58 INFO - PROCESS | 19784 | Cycle 1(1): loaded http://localhost:58725/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58725/tests/dromaeo/cssquery-yui.html) 05:45:58 INFO - PROCESS | 19784 | RSS: Main: 166055936 05:45:58 INFO - PROCESS | 19784 | 05:49:01 INFO - PROCESS | 19784 | Cycle 1(1): loaded http://localhost:58725/tests/dromaeo/cssquery-yui.html (next: http://localhost:58725/tests/dromaeo/cssquery-dojo.html) 05:49:01 INFO - PROCESS | 19784 | RSS: Main: 169734144 05:49:01 INFO - PROCESS | 19784 | 05:49:01 INFO - PROCESS | 19784 | __start_tp_report 05:49:01 INFO - PROCESS | 19784 | _x_x_mozilla_page_load 05:49:01 INFO - PROCESS | 19784 | _x_x_mozilla_page_load_details 05:49:01 INFO - PROCESS | 19784 | |i|pagename|runs| 05:49:01 INFO - PROCESS | 19784 | |0;dojo.html;3101.565780790689;3101.8138911665314;3122.4847900096493;3142.685731426859;3147.4491963906326;5314.654547454413;5428.348598168221;5494.285742853428;5514.80698175564;5536.723163841812;5447.12845944649;5488.396276409591;5492.258545096411;5496.148097044965;5501.752421141048;4757.815698295582;4898.06936682031;4989.101961646902;5082.059818933509;5152.92270615941;5092.719900405476;5108.157154069574;5126.615503837227;5161.096808058574;5171.818986335479;4939.061578300111;4972.651914365996;4994.650374473788;5021.422536408323;5043.016611760708;5017.573506251973;5031.698098114125;5048.29323894655;5049.040682270357;5059.696418214919;4976.825811096594;4997.90004199914;5004.224345226459;5013.348264725599;5036.647434679574;5333.679979201261;5393.541548968343;5442.673439593637;5443.265159203496;5517.779288828442;5853.736581853785;5862.882742345172;5870.823875283749;5871.001929671966;5886.558508111909;5907.616004959664;5912.260967379078;5916.792912248094;5918.496927761145;5919.2009078774245;5354.544863686591;5393.1370980643305;5411.756470958816;5416.8104116355735;5493.670379777186;5933.584649074523;5970.731317090741;5982.4316689914385;5986.4013598639785;6031.065184896348;5712.485876271156;5746.856328591735;5747.252857128547;5759.712014399263;5764.827055188351;5696.914546281809;5701.4013528579735;5777.422257774273;5819.592628515963;5852.356240813507;5845.123231515222;5848.239728835224;5849.444302791228;5866.061430171152;5882.705864706748;5790.739416726257;5800.9129863052085;5838.12428135783;5856.443637854397;5862.912056319158;4369.563043695605;4450.287953927356;4464.129494748558;4478.2386994211065;4516.932246016312;3938.783366914847;3997.380406037069;4035.1929614076716;4036.656884164879;4061.735987160884;5565.888682226333;5585;5599.580031497654;5601.775928962796;5610.438956104357;5721.8569535761935;5820.3888591698105;5902.409759024149;5907.527397808165;5938.317093534212;5623.6906970116215;5689.601727879091;5703.62926409782;5718.628289161191;5729.197912292282;5159.948400515947;5162.819301324435;5163.199704045879;5180.611454140954;5206.193040078794;5915.024021036566;6013.939860601426;6141.631093688469;6190.350013248634;6196.783112591128;5848.561357898089;5910.936031514369;5923.022701254245;5924;5945;6015.39846015395;6066.666333351708;6070.2108725865355;6082.817515474543;6126.326104128631;5582.3859375467855;5732.16883551891;5764.884702306014;5774.422557744192;5776.335721391925;5946.464818166386;5954.434328738763;5978;5984.551158663205;6025.457708806053;5785.9132113017495;5829.417058294137;5837.67892765885;5842.678652674143;5860.589758716849;5559.610827242054;5684.317881854204;5726.455986681259;5831.067029275465;5841.824745257649;5708.086706127;5710.3433105193435;5720.799772007959;5725.19847221381;5771.567132465166;5784.479396854304;5792.536597072309;5830.76676932918;5832.270966129234;5846.503047240862;5506.174073888948;5563.554915606661;5631.8592035199445;5664.122061080539;5695.515881150149 05:49:01 INFO - PROCESS | 19784 | |1;ext.html;550.276315975445;578.7482445136363;584.880099579586;598.3836648252301;629.28261781569;39151.80424097879;43504.56495435045;43524.56475435245;43526.782366088206;43649.345259821086;41055.794721026425;41602.79198604003;41646;41986.16027679452;42876.35685464713;8836.734897953073;8944.060873608276;8985.37102402832;9010.09899010097;9018.503982280972;8778.122187781235;8957.462552246854;8975.820483590323;9015.413998090104;9037.59330830111;8940.910590894106;8974.237189838872;9046.638134474613;9068.093190680946;9085.863712044325;8999.23506501948;9001.459912405244;9050.637974481013;9066.184043436122;9094.545272736403;8833.072527384596;8851.247643950272;8901.109889011112;8926.285897128215;8945.284377249804;41476.79261603673;41679.1664166715;41774.1645167098;41804.372934406005;41856.162876742295;3510;3588.784672919633;3672.559292884871;3721.218544105741;3787.091098136455;32557.51163732546;33593.32813343744;33647.15882102943;33654.66345336564;33753.831230843934;4404.2512772828695;4551.795169217393;4574;4668.976655116737;4703.905921881543;257099;257194;257880;258382.83234335209;260759;33386.165345866546;57870.710646446496;58331;58436.4156358431;58610;35165.64834351624;35199.648003520146;35263.64736352603;35308.29383412317;35358.823205883804;15265.313060912285;15271.312790924436;15288.082715037133;15347.309371078329;15424.845751542565;11395.088392928546;11408.942955285336;11414.201005929504;11430.485628146753;11436.656900293005;8209.876851847228;8271.95864020676;8325.916740832514;8361.122082181406;8389;3193.1059303395086;3198.98400507996;3206.599175103112;3251.6748325167296;3282.474804031391;987.5013118375318;1074.5272080284649;1122.3199259089615;1139.145640769423;1146.3465824479965;31944;32638.347233055207;32920.176995575304;33023.66976330254;33352.83323583415;1092.1481244629201;1133.6882357351794;1150.7871043856912;1157.265136638224;1199.7540504196618;16986.575335616708;17079.829201707824;17192.22634981404;17268.913655431894;17425.215865286093;592528;909479;927987;931620;936906;61429.69285153546;61476.463088423145;61533;61955.380446195864;62172;1379.9310034498235;1393.4078016842802;1395.3581352577928;1397.2734178227468;1418.3333833098427;31937;32862.507062394565;33507;33885.66114338825;34132;54194.45805541894;54428;54494;54628.453715463926;54630;535452;542163;543734;543842;544242;28685.856570717013;29075.56386654244;29146.27134321574;29224.853875730485;29619.703802961696;48007.519924800305;49106.26340604965;50150.24774628456;50239.74880125576;50393;41271;42491;42524.880409083264;43401.782991084845;43869.341959871264;42922.570774293104;42982.78508607437;43173.78413107914;43630.78184609057;43909.341359878985;40131.39802903017;41315.7934210327;41587;41679.16641667089;45127;35480.46779298261;37976;39336.40995385014;39532;39580.80209598933;29250.41499169962;29477.410451791275;29531.772075629233;29559.26101847471;29964.850175748983 05:49:01 INFO - PROCESS | 19784 | |2;jquery.html;343.2979556806332;354.97486837591543;387.74215146927287;389.8323720800056;402.5250204758386;18164.455066348015;18796.812031879675;18863.62272754546;19384.32154874578;19572.510687232825;11307.773844523104;11623.767524649502;11685.883141168586;11690.590829320976;11706.882931170707;4774.522547745215;5032.698038117706;5043.067032598962;5083.898322033557;5088.23676448532;3760.3419401604747;4990.201567749161;5371.248025276464;5603.355614104389;5667.433256674341;5665.23519324892;5686.658800471964;5697.287839020122;5743.368229494752;5779.190913272145;5520.530754885819;5666.235058267122;5720.656760594377;5724.169995350671;5726.885462290752;5350.652207606493;5469.671819690831;5517.337919449692;5517.724113794335;5521.309836270466;12862.678433039155;12913.806292905614;12949.870501294961;13023.28371939543;13115;2311.4914718761847;2359.2922123362923;2468.666729991446;2509.1970569417795;2810.5081610718044;9477.90522094777;9664.95167524165;9829.55766990487;9883.8517422238;10036.548355324028;1840.2271046160645;1883.3973128598855;1919.9040047997685;1996.045570096987;2008.3874418302412;82302.58848705779;83157.16842831616;83330.16669833285;84603.5769821147;84880.57559712161;10685.83971240432;10991.120710343153;11035.889641103648;11069.889301106887;11104.944475277573;15152.01511901723;15254.618634534225;15341;15360.846391536164;15420.768688469681;8263.421560490708;8370.832583348421;8423.326133909395;8453.746387608382;8576.142385761374;8050.5572193529915;8063.153368896299;8124.106348301682;8156.306713929383;8331;4635.860924172281;4696.671233013656;4706.552877476634;4803.207470767285;4883.438404583448;1603.2945503978447;1701.2004357951744;1720.6386658801541;1845.612421391496;1916.3963351544219;921.9032001639865;1025.8820235672845;1035.5961175141701;1061.4957894999814;1074.5285842562075;18361.17374718141;18449.815501845078;18711.251549938122;19618.196790856742;19669.803301967084;1003.1423133220991;1031.9226058045676;1047.9580816767243;1075.2903083964702;1115.130198445214;10466.895331046744;10802.72993175177;10852.077573406192;10897.67306980792;10940.507677154546;533605;538284;540273;543506;544312;89529;89925.55037224902;90179.54910225538;90953;92046.71579557873;971.6599190283486;1021.3871676993745;1034.6844212515255;1043.9269251152346;1048.1248157788332;16699.833001669827;16798.66402671964;17078.316867325666;17609.383671571435;17798.822011780234;41997.79001104975;42184.36723449212;42280.365794512494;42749.57250427456;42969.785151074044;52476.47523524868;58537.4146258532;59888;59890;60683.39316606778;7055.753048643272;7221.241769614115;7307.2327405621645;7378.631068446663;7702.114256860309;11851.348175850411;12977.35113244353;13325.267110308638;13459.3943272551;13809.723805523632;11406.315621062762;11745.354005529778;11762.882371176522;11961.880381196077;12174.634760957186;10358.274920755775;11632.243904146204;11696.766064678828;11727.530898763955;11779.05767538612;12055.81916271239;12176.269423834598;12291.139620226855;12382.628521144019;12553.309567973849;8077.717279895175;8129.878051829109;8205.384596155192;8346.666133354598;8695.956520217358;8776.385653004229;10943.671689849318;11758.529658813552;11911.821322679993;11983.04135669127 05:49:01 INFO - PROCESS | 19784 | |3;mootools.html;1471.5879553724953;1473.4327283995663;1602.2469439363501;1763.5502946748577;1769.5841477252836;7768.06783186017;8594.183552562497;8665.956670216648;9449.858252126223;9491.335606507539;8726.127387261271;9127.178553930145;9151.588178531965;9174.357794954356;9178.173964343208;2349.3891588187066;2393.497365553236;2394.3415560720855;2396.532676128147;2399.928002159938;2322.7328857181474;2340.3681006128336;2368.5854975379325;2371.8221133415063;2374.382660508272;2327.487952650414;2346.049849810821;2356.363781778927;2356.9292921212304;2361.0319768894756;2264.1962103453284;2266.8299877509253;2273.6930514380597;2281.840271181018;2354.0348457132495;2288.2448791898632;2290.725112986452;2299.7930186283147;2310.4223944013997;2314.3866875278063;8867.068957759408;8912.688055918012;8948.910510894873;8997;9020.323475739346;4978.452370239271;5098.643094983353;5139.17773156297;5184.662996905189;5185.948140518584;3310.7351411886993;3363.7140843028374;3375.4599264117624;3408.454647256452;3443.5351227584456;1059.5973530058604;1060.5386656804237;1078.9082927951133;1101.2786624760795;1111.6831702964698;12730.681732956658;12855;12873.29196894161;12989.480420783157;13005.609831705064;4441.422615060022;4565.794539245742;4700.670953033323;4770.976145119253;4776.498467660915;10594;10768.515416806105;10821.863704310934;10858.34849909008;10863.07663848566;5331.466853314638;5335.493128152819;5351.892962140735;5368.32895888014;5371.328583927009;4228.429162063082;4717.339572459859;4908.509149085135;4933.827316043921;4936.308916751657;3882.883513494543;4000.2199571083943;4089.6932730045364;4096.160287141189;4104.938425923614;1257.251935098615;1260.7541529401863;1281.8141369501557;1294.7022184897526;1308.8560258371572;935.3639525122845;1000.1298869983161;1041.2450973044633;1048.3762161513887;1057.1120258982337;6050.757969681164;6159.84600384994;6194.566380353423;6223.1287619733275;6325.177726895474;447.36920941473016;454.21420941770924;456.67347846289397;464.5609898645747;1034.591336422109;4091.8977025574004;4113.9794301028305;4218;4302.612764851178;4375.387445757597;11170.720731981766;11696.298222106701;11734.589289374831;11746.471408786625;11773.587924422603;11492.597759078391;11565.074794016458;11568.768624627628;11575;11635.53457861676;8224.62989165501;8292.917070829215;8304.211099945496;8367.079621241659;8379.455335403301;6114.144019837316;6222;6234.937650623436;6320.873582528416;6329.715162817776;10278.691639250834;10282.897171028493;10622.787544249226;10640.04239618438;10665;10094.343867648578;10193.439360835226;10357.326773759682;10402.947985260025;10490.423026733602;6800.761973330909;7494.775156745306;7637.770866874002;7638.923610763822;7825.608719563885;9041.23149532297;9064.18422341966;9092.363534552518;9099;9117.997020327892;7565.167831538636;7620.69517219305;7675.846483070419;7813.843723125619;7922.524648521107;7419.332260096618;7539.849203016019;7596.126445458622;7668.424868134801;7674.117476490052;6936.132983377078;7101.857962840818;7137.607431591105;7139.892901606376;7143.357097861218;5496.532794712494;5568.582356323373;5594.832155035356;5627.943720562906;5691.800786972436;5490.121580547093;5575;5594.104943209067;5655.406182350794;5676.34722006958 05:49:01 INFO - PROCESS | 19784 | |4;prototype.html;306.63510422597096;312.3160278989014;322.3536808698559;322.70472517646357;322.8321272938072;5104.183330667094;5444.646098003627;5495.862603434916;5512.912768849447;5548.278723765915;5374.145919657712;5378.3058336623935;5398.190271459283;5406.189071639256;5412.484504338791;4227.217964676537;4250.574942505756;4251.744895306276;4287.1425714857;4289.185054839586;4098.4876890388705;4239.40648309237;4253.936190957138;4277.1873344064525;4311.590398912114;4182.2890108681595;4194.119234960646;4216.388623649569;4216.388623649569;4219.556946520617;4190;4219.704620676569;4233.618974292298;4254.170436764832;4274.316109422478;3666.944995825065;3742.7754334740002;3744.6817020553285;3755.5728823047066;3764.6611804937415;5253.553447956928;5294.735263236823;5296.390915044781;5309.707966061865;5344.412114667383;4814.518548145193;4829.782659780283;4832.371791667096;4839.104765618372;4866.367372241586;5556.444355564452;5631.8592035199445;5704.828855134353;5728.25532680753;5736.569757268222;4057.9188416231805;4069.3895915612893;4073.5111786585503;4078.938815917764;4085.4076158956786;5934.910976335358;5936.456521304492;5961.284645842483;5964.194833697438;5978.521718262528;4012.4181993611346;4137.91724165515;4169.854055108057;4170.70708080496;4191.476065491814;4231.196072746168;4265.445492086009;4290.742555446684;4299.441072660534;4301.376300436419;4877.268409738567;4921.8523444296725;4923.532264434873;4941.45643979162;4949.579285760678;5467.425920278393;5786.739596718157;5867.501262392744;5868.794592189253;5888.646681199141;1430.342042660367;1449.5506393018197;1456.3300881594585;1456.4028748213182;1460.233377476812;868.6221493650156;893.6372032650261;909.0500427053745;910.9590068446803;917.4632839788665;4941.407031156285;4959.603231741452;4991.803606413167;5002.124628190052;5004.324416203839;5173.628988318099;5188.558972487305;5240.554552863049;5267.578593712494;5273.91884663643;4788.0498588664495;4996.3504744383;4999.175136102575;4999.400071991385;5029.245613158056;2761.9447611047667;2765.4883846488465;2791;2793.231861238176;2796.860156992142;5384.434634363335;5387.380451248078;5436.945630543723;5463.235147079412;5469.835904922858;5133.845984620468;5242.580593552507;5273.681579605099;5282.81510147143;5349.7962958334065;5319.388270348882;5372.489613486712;5417.59368047398;5431.402545719968;5463.224452053019;5196.714180719945;5229.947700522946;5328.920066199088;5338.733063346895;5381.596380271417;4899.681520701143;5110.66780659256;5138.8972220556125;5149.639525233198;5173.586113110867;5355.919661205163;5357.357117145967;5369.221462887781;5381;5435.755391007493;3778.0554861284677;4068.2066996935314;4076.8369265229057;4172.603602657743;4192.853250136231;5814.30228372581;5837;5841.153032810304;5848.210491583582;5893;5577.386487486455;5719.970405327081;5746.16680581305;5797.4782269595935;5804.593678442468;5697.353693636159;5717.113847353667;5749.1663708762835;5757.96356655806;5772.7690892363835;5628.74670639814;5632.915506267327;5639.971800140973;5689.487946084872;5694.117411801178;5533.837894042296;5684.914726279192;5720.856978575569;5775.306963164448;5809.215755872903;5579.74891129892;5642.379338272704;5643.661380317194;5665.943340566707;5671.801486947937 05:49:01 INFO - PROCESS | 19784 | |5;yui.html;723.4790950515627;734.7501849371209;774.9070111586609;792.2750683124939;803.9758807235781;15034.473793417232;15956.601084972881;15985.520434386986;16002.279897404616;16003.519894403173;14366.640833979156;14577;14649.707005859904;14716.484923027696;14723.852761472383;663.8473151175233;772.9884051739215;795.3676826922582;802.1336956087441;818.5007145641155;809.9433039687224;812.8780682897553;813.7029984055836;814.0434988888062;815.9877601835977;837.9790505237357;839.7648658375665;842.3682238321259;844.543946269017;850.0606829453458;845.7547311279721;845.8815765792793;846.0397448895486;846.0989046665281;847.1740053447901;617.1329282358294;618.5113760129492;620.9099680546295;621.2513920725515;621.6860485454862;14685.486007989775;14752.926235368861;14772.26138693061;14791.260436978107;14802.481913132988;14400.927995360062;14437.711245775026;14752.114873107648;14759.852401475955;14927.477538286108;12357.505699771998;12459.12786104973;12520.937395312965;12743.92194497761;12754.426050827642;3973.940390894139;4046.190761847642;4080.6939479539155;4122.34042553193;4167.708260421772;83207;84553.57723211344;85304.57347713222;87548;87632.80917977038;12092.455839487244;12138.211016283913;12262.693432664077;12446.31545265001;12480.937595311965;22903.312900612676;22937.426564335692;22983.655245171336;23159.305220843402;23315.650265246033;8543.487390756574;8748.650053997897;8754.387192896564;8990;9003.504807235666;4895.755212239445;4962.851114466572;5007.949920500749;5036.269740887624;5064.240363945364;3818.3127037133027;3905.4922860028582;3910.1006768443417;3960.603939606074;3962.5641179470813;644.3234603666132;659.8086554899121;660.8777376185325;667.956582822115;672.8990651402231;672.3847679373416;685.2256949646867;710.4848984486309;770.2451597434433;774.9767506974799;10304.845427318596;10379.636712715019;10383.428911409794;10446.843297350546;10719.19606029551;654.5418207254941;690.1580072311772;732.5018987088724;737.0602481835703;759.3393747439762;4736.8578942631775;4855.514448555116;4907.5828554572545;4910.582600478928;4976.651634385558;74412.62793686106;75736.24263757402;75890;113154;130573;113300.43349783363;117017;117208;117352;117973.41013294879;97748;99213.50393247987;99376;99736.50131749295;103794;9102.817943640957;9398.53007349616;9426.434413935185;9511.619535218513;9548.665796697082;55682.16476752771;56049;56997.43002570087;57170.42829571817;57316.71341643265;78143.21856781587;81102.59448702719;82433.58783206045;84292.57853710938;86283;12242.571509997464;12486.375681216085;12660.556880509139;12729.872701272869;12971.935140324238;13443;13685.726285474433;13760.17438953666;13779.346478422653;13912.234827084607;12660.620181394574;12852.357382130669;12864.356782160667;13001.609951701465;13129.868701312864;12561.120721549403;12677.87322126767;12694.682632934251;12846.357682116044;13033.283169425773;12818.67953301175;12842.81798490206;12936.935315323739;12958.602658508205;13144.474221031434;10675.519601618102;10900.127989760958;11262;11387.487563059516;11694.122940779305;9939.701808945743;11202.607908723481;11232.157588181082;11246.718832029264;11509.884901150881 05:49:01 INFO - PROCESS | 19784 | __end_tp_report 05:49:01 INFO - PROCESS | 19784 | __start_cc_report 05:49:01 INFO - PROCESS | 19784 | _x_x_mozilla_cycle_collect,352 05:49:01 INFO - PROCESS | 19784 | __end_cc_report 05:49:01 INFO - PROCESS | 19784 | __startTimestamp1470142141381__endTimestamp 05:49:01 INFO - PROCESS | 19784 | 05:49:01 INFO - PROCESS | 19784 | ------- Summary: start ------- 05:49:01 INFO - PROCESS | 19784 | Number of tests: 6 05:49:01 INFO - PROCESS | 19784 | 05:49:01 INFO - PROCESS | 19784 | [#0] dojo.html Cycles:165 Average:5463.84 Median:5703.63 stddev:624.05 (10.9%) stddev-sans-first:597.82 05:49:01 INFO - PROCESS | 19784 | Values: 3101.6 3101.8 3122.5 3142.7 3147.4 5314.7 5428.3 5494.3 5514.8 5536.7 5447.1 5488.4 5492.3 5496.1 5501.8 4757.8 4898.1 4989.1 5082.1 5152.9 5092.7 5108.2 5126.6 5161.1 5171.8 4939.1 4972.7 4994.7 5021.4 5043.0 5017.6 5031.7 5048.3 5049.0 5059.7 4976.8 4997.9 5004.2 5013.3 5036.6 5333.7 5393.5 5442.7 5443.3 5517.8 5853.7 5862.9 5870.8 5871.0 5886.6 5907.6 5912.3 5916.8 5918.5 5919.2 5354.5 5393.1 5411.8 5416.8 5493.7 5933.6 5970.7 5982.4 5986.4 6031.1 5712.5 5746.9 5747.3 5759.7 5764.8 5696.9 5701.4 5777.4 5819.6 5852.4 5845.1 5848.2 5849.4 5866.1 5882.7 5790.7 5800.9 5838.1 5856.4 5862.9 4369.6 4450.3 4464.1 4478.2 4516.9 3938.8 3997.4 4035.2 4036.7 4061.7 5565.9 5585.0 5599.6 5601.8 5610.4 5721.9 5820.4 5902.4 5907.5 5938.3 5623.7 5689.6 5703.6 5718.6 5729.2 5159.9 5162.8 5163.2 5180.6 5206.2 5915.0 6013.9 6141.6 6190.4 6196.8 5848.6 5910.9 5923.0 5924.0 5945.0 6015.4 6066.7 6070.2 6082.8 6126.3 5582.4 5732.2 5764.9 5774.4 5776.3 5946.5 5954.4 5978.0 5984.6 6025.5 5785.9 5829.4 5837.7 5842.7 5860.6 5559.6 5684.3 5726.5 5831.1 5841.8 5708.1 5710.3 5720.8 5725.2 5771.6 5784.5 5792.5 5830.8 5832.3 5846.5 5506.2 5563.6 5631.9 5664.1 5695.5 05:49:01 INFO - PROCESS | 19784 | 05:49:01 INFO - PROCESS | 19784 | [#1] ext.html Cycles:180 Average:68827.79 Median:41726.67 stddev:165343.53 (396.3%) stddev-sans-first:165727.89 05:49:01 INFO - PROCESS | 19784 | Values: 550.3 578.7 584.9 598.4 629.3 39151.8 43504.6 43524.6 43526.8 43649.3 41055.8 41602.8 41646.0 41986.2 42876.4 8836.7 8944.1 8985.4 9010.1 9018.5 8778.1 8957.5 8975.8 9015.4 9037.6 8940.9 8974.2 9046.6 9068.1 9085.9 8999.2 9001.5 9050.6 9066.2 9094.5 8833.1 8851.2 8901.1 8926.3 8945.3 41476.8 41679.2 41774.2 41804.4 41856.2 3510.0 3588.8 3672.6 3721.2 3787.1 32557.5 33593.3 33647.2 33654.7 33753.8 4404.3 4551.8 4574.0 4669.0 4703.9 257099.0 257194.0 257880.0 258382.8 260759.0 33386.2 57870.7 58331.0 58436.4 58610.0 35165.6 35199.6 35263.6 35308.3 35358.8 15265.3 15271.3 15288.1 15347.3 15424.8 11395.1 11408.9 11414.2 11430.5 11436.7 8209.9 8272.0 8325.9 8361.1 8389.0 3193.1 3199.0 3206.6 3251.7 3282.5 987.5 1074.5 1122.3 1139.1 1146.3 31944.0 32638.3 32920.2 33023.7 33352.8 1092.1 1133.7 1150.8 1157.3 1199.8 16986.6 17079.8 17192.2 17268.9 17425.2 592528.0 909479.0 927987.0 931620.0 936906.0 61429.7 61476.5 61533.0 61955.4 62172.0 1379.9 1393.4 1395.4 1397.3 1418.3 31937.0 32862.5 33507.0 33885.7 34132.0 54194.5 54428.0 54494.0 54628.5 54630.0 535452.0 542163.0 543734.0 543842.0 544242.0 28685.9 29075.6 29146.3 29224.9 29619.7 48007.5 49106.3 50150.2 50239.7 50393.0 41271.0 42491.0 42524.9 43401.8 43869.3 42922.6 42982.8 43173.8 43630.8 43909.3 40131.4 41315.8 41587.0 41679.2 45127.0 35480.5 37976.0 39336.4 39532.0 39580.8 29250.4 29477.4 29531.8 29559.3 29964.9 05:49:01 INFO - PROCESS | 19784 | 05:49:01 INFO - PROCESS | 19784 | [#2] jquery.html Cycles:180 Average:29852.43 Median:2488.93 stddev:88907.02 (3572.1%) stddev-sans-first:89128.81 05:49:01 INFO - PROCESS | 19784 | Values: 343.3 355.0 387.7 389.8 402.5 18164.5 18796.8 18863.6 19384.3 19572.5 11307.8 11623.8 11685.9 11690.6 11706.9 4774.5 5032.7 5043.1 5083.9 5088.2 3760.3 4990.2 5371.2 5603.4 5667.4 5665.2 5686.7 5697.3 5743.4 5779.2 5520.5 5666.2 5720.7 5724.2 5726.9 5350.7 5469.7 5517.3 5517.7 5521.3 12862.7 12913.8 12949.9 13023.3 13115.0 2311.5 2359.3 2468.7 2509.2 2810.5 9477.9 9665.0 9829.6 9883.9 10036.5 1840.2 1883.4 1919.9 1996.0 2008.4 82302.6 83157.2 83330.2 84603.6 84880.6 10685.8 10991.1 11035.9 11069.9 11104.9 15152.0 15254.6 15341.0 15360.8 15420.8 8263.4 8370.8 8423.3 8453.7 8576.1 8050.6 8063.2 8124.1 8156.3 8331.0 4635.9 4696.7 4706.6 4803.2 4883.4 1603.3 1701.2 1720.6 1845.6 1916.4 921.9 1025.9 1035.6 1061.5 1074.5 18361.2 18449.8 18711.3 19618.2 19669.8 1003.1 1031.9 1048.0 1075.3 1115.1 10466.9 10802.7 10852.1 10897.7 10940.5 533605.0 538284.0 540273.0 543506.0 544312.0 89529.0 89925.6 90179.5 90953.0 92046.7 971.7 1021.4 1034.7 1043.9 1048.1 16699.8 16798.7 17078.3 17609.4 17798.8 41997.8 42184.4 42280.4 42749.6 42969.8 52476.5 58537.4 59888.0 59890.0 60683.4 7055.8 7221.2 7307.2 7378.6 7702.1 11851.3 12977.4 13325.3 13459.4 13809.7 11406.3 11745.4 11762.9 11961.9 12174.6 10358.3 11632.2 11696.8 11727.5 11779.1 12055.8 12176.3 12291.1 12382.6 12553.3 8077.7 8129.9 8205.4 8346.7 8696.0 8776.4 10943.7 11758.5 11911.8 11983.0 05:49:01 INFO - PROCESS | 19784 | 05:49:01 INFO - PROCESS | 19784 | [#3] mootools.html Cycles:180 Average:5948.01 Median:4408.41 stddev:3458.63 (78.5%) stddev-sans-first:3451.97 05:49:01 INFO - PROCESS | 19784 | Values: 1471.6 1473.4 1602.2 1763.6 1769.6 7768.1 8594.2 8666.0 9449.9 9491.3 8726.1 9127.2 9151.6 9174.4 9178.2 2349.4 2393.5 2394.3 2396.5 2399.9 2322.7 2340.4 2368.6 2371.8 2374.4 2327.5 2346.0 2356.4 2356.9 2361.0 2264.2 2266.8 2273.7 2281.8 2354.0 2288.2 2290.7 2299.8 2310.4 2314.4 8867.1 8912.7 8948.9 8997.0 9020.3 4978.5 5098.6 5139.2 5184.7 5185.9 3310.7 3363.7 3375.5 3408.5 3443.5 1059.6 1060.5 1078.9 1101.3 1111.7 12730.7 12855.0 12873.3 12989.5 13005.6 4441.4 4565.8 4700.7 4771.0 4776.5 10594.0 10768.5 10821.9 10858.3 10863.1 5331.5 5335.5 5351.9 5368.3 5371.3 4228.4 4717.3 4908.5 4933.8 4936.3 3882.9 4000.2 4089.7 4096.2 4104.9 1257.3 1260.8 1281.8 1294.7 1308.9 935.4 1000.1 1041.2 1048.4 1057.1 6050.8 6159.8 6194.6 6223.1 6325.2 447.4 454.2 456.7 464.6 1034.6 4091.9 4114.0 4218.0 4302.6 4375.4 11170.7 11696.3 11734.6 11746.5 11773.6 11492.6 11565.1 11568.8 11575.0 11635.5 8224.6 8292.9 8304.2 8367.1 8379.5 6114.1 6222.0 6234.9 6320.9 6329.7 10278.7 10282.9 10622.8 10640.0 10665.0 10094.3 10193.4 10357.3 10402.9 10490.4 6800.8 7494.8 7637.8 7638.9 7825.6 9041.2 9064.2 9092.4 9099.0 9118.0 7565.2 7620.7 7675.8 7813.8 7922.5 7419.3 7539.8 7596.1 7668.4 7674.1 6936.1 7101.9 7137.6 7139.9 7143.4 5496.5 5568.6 5594.8 5627.9 5691.8 5490.1 5575.0 5594.1 5655.4 5676.3 05:49:01 INFO - PROCESS | 19784 | 05:49:01 INFO - PROCESS | 19784 | [#4] prototype.html Cycles:180 Average:4646.86 Median:5235.25 stddev:1348.85 (25.8%) stddev-sans-first:1312.71 05:49:01 INFO - PROCESS | 19784 | Values: 306.6 312.3 322.4 322.7 322.8 5104.2 5444.6 5495.9 5512.9 5548.3 5374.1 5378.3 5398.2 5406.2 5412.5 4227.2 4250.6 4251.7 4287.1 4289.2 4098.5 4239.4 4253.9 4277.2 4311.6 4182.3 4194.1 4216.4 4216.4 4219.6 4190.0 4219.7 4233.6 4254.2 4274.3 3666.9 3742.8 3744.7 3755.6 3764.7 5253.6 5294.7 5296.4 5309.7 5344.4 4814.5 4829.8 4832.4 4839.1 4866.4 5556.4 5631.9 5704.8 5728.3 5736.6 4057.9 4069.4 4073.5 4078.9 4085.4 5934.9 5936.5 5961.3 5964.2 5978.5 4012.4 4137.9 4169.9 4170.7 4191.5 4231.2 4265.4 4290.7 4299.4 4301.4 4877.3 4921.9 4923.5 4941.5 4949.6 5467.4 5786.7 5867.5 5868.8 5888.6 1430.3 1449.6 1456.3 1456.4 1460.2 868.6 893.6 909.1 911.0 917.5 4941.4 4959.6 4991.8 5002.1 5004.3 5173.6 5188.6 5240.6 5267.6 5273.9 4788.0 4996.4 4999.2 4999.4 5029.2 2761.9 2765.5 2791.0 2793.2 2796.9 5384.4 5387.4 5436.9 5463.2 5469.8 5133.8 5242.6 5273.7 5282.8 5349.8 5319.4 5372.5 5417.6 5431.4 5463.2 5196.7 5229.9 5328.9 5338.7 5381.6 4899.7 5110.7 5138.9 5149.6 5173.6 5355.9 5357.4 5369.2 5381.0 5435.8 3778.1 4068.2 4076.8 4172.6 4192.9 5814.3 5837.0 5841.2 5848.2 5893.0 5577.4 5720.0 5746.2 5797.5 5804.6 5697.4 5717.1 5749.2 5758.0 5772.8 5628.7 5632.9 5640.0 5689.5 5694.1 5533.8 5684.9 5720.9 5775.3 5809.2 5579.7 5642.4 5643.7 5665.9 5671.8 05:49:01 INFO - PROCESS | 19784 | 05:49:01 INFO - PROCESS | 19784 | [#5] yui.html Cycles:180 Average:21760.85 Median:4145.02 stddev:31913.94 (769.9%) stddev-sans-first:31964.38 05:49:01 INFO - PROCESS | 19784 | Values: 723.5 734.8 774.9 792.3 804.0 15034.5 15956.6 15985.5 16002.3 16003.5 14366.6 14577.0 14649.7 14716.5 14723.9 663.8 773.0 795.4 802.1 818.5 809.9 812.9 813.7 814.0 816.0 838.0 839.8 842.4 844.5 850.1 845.8 845.9 846.0 846.1 847.2 617.1 618.5 620.9 621.3 621.7 14685.5 14752.9 14772.3 14791.3 14802.5 14400.9 14437.7 14752.1 14759.9 14927.5 12357.5 12459.1 12520.9 12743.9 12754.4 3973.9 4046.2 4080.7 4122.3 4167.7 83207.0 84553.6 85304.6 87548.0 87632.8 12092.5 12138.2 12262.7 12446.3 12480.9 22903.3 22937.4 22983.7 23159.3 23315.7 8543.5 8748.7 8754.4 8990.0 9003.5 4895.8 4962.9 5007.9 5036.3 5064.2 3818.3 3905.5 3910.1 3960.6 3962.6 644.3 659.8 660.9 668.0 672.9 672.4 685.2 710.5 770.2 775.0 10304.8 10379.6 10383.4 10446.8 10719.2 654.5 690.2 732.5 737.1 759.3 4736.9 4855.5 4907.6 4910.6 4976.7 74412.6 75736.2 75890.0 113154.0 130573.0 113300.4 117017.0 117208.0 117352.0 117973.4 97748.0 99213.5 99376.0 99736.5 103794.0 9102.8 9398.5 9426.4 9511.6 9548.7 55682.2 56049.0 56997.4 57170.4 57316.7 78143.2 81102.6 82433.6 84292.6 86283.0 12242.6 12486.4 12660.6 12729.9 12971.9 13443.0 13685.7 13760.2 13779.3 13912.2 12660.6 12852.4 12864.4 13001.6 13129.9 12561.1 12677.9 12694.7 12846.4 13033.3 12818.7 12842.8 12936.9 12958.6 13144.5 10675.5 10900.1 11262.0 11387.5 11694.1 9939.7 11202.6 11232.2 11246.7 11509.9 05:49:01 INFO - PROCESS | 19784 | -------- Summary: end -------- 05:49:01 INFO - PROCESS | 19784 | 05:49:02 INFO - TEST-INFO | 19784: exit 0 05:49:02 INFO - TEST-OK | dromaeo_css | took 1110833ms 05:49:02 INFO - TEST-START | kraken 05:49:02 INFO - operating with platform_type : linux_ 05:49:02 INFO - Initialising browser for kraken test... 05:49:02 INFO - TEST-INFO | started process 20028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmf8Y2D/profile http://localhost:58725/getInfo.html) 05:49:06 INFO - PROCESS | 20028 | __metrics Screen width/height:1600/1200 05:49:06 INFO - PROCESS | 20028 | colorDepth:24 05:49:06 INFO - PROCESS | 20028 | Browser inner width/height: 1024/697 05:49:06 INFO - PROCESS | 20028 | __metrics 05:49:06 ERROR - PROCESS | 20028 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:49:07 INFO - TEST-INFO | 20028: exit 0 05:49:07 INFO - Browser initialized. 05:49:07 INFO - Running cycle 1/1 for kraken test... 05:49:07 INFO - TEST-INFO | started process 20146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmf8Y2D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:19 INFO - PROCESS | 20146 | RSS: Main: 163356672 05:49:19 INFO - PROCESS | 20146 | 05:49:22 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58725/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:22 INFO - PROCESS | 20146 | RSS: Main: 168751104 05:49:22 INFO - PROCESS | 20146 | 05:49:25 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58725/tests/kraken/driver.html?testName=audio-dft) 05:49:26 INFO - PROCESS | 20146 | RSS: Main: 167444480 05:49:26 INFO - PROCESS | 20146 | 05:49:29 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58725/tests/kraken/driver.html?testName=audio-fft) 05:49:29 INFO - PROCESS | 20146 | RSS: Main: 163602432 05:49:29 INFO - PROCESS | 20146 | 05:49:31 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58725/tests/kraken/driver.html?testName=audio-oscillator) 05:49:32 INFO - PROCESS | 20146 | RSS: Main: 164978688 05:49:32 INFO - PROCESS | 20146 | 05:49:34 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58725/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:49:35 INFO - PROCESS | 20146 | RSS: Main: 165326848 05:49:35 INFO - PROCESS | 20146 | 05:49:38 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58725/tests/kraken/driver.html?testName=imaging-darkroom) 05:49:39 INFO - PROCESS | 20146 | RSS: Main: 165421056 05:49:39 INFO - PROCESS | 20146 | 05:49:42 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58725/tests/kraken/driver.html?testName=imaging-desaturate) 05:49:43 INFO - PROCESS | 20146 | RSS: Main: 162717696 05:49:43 INFO - PROCESS | 20146 | 05:49:46 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58725/tests/kraken/driver.html?testName=json-parse-financial) 05:49:46 INFO - PROCESS | 20146 | RSS: Main: 165289984 05:49:46 INFO - PROCESS | 20146 | 05:49:48 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58725/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:49:48 INFO - PROCESS | 20146 | RSS: Main: 165371904 05:49:48 INFO - PROCESS | 20146 | 05:49:50 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58725/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:49:51 INFO - PROCESS | 20146 | RSS: Main: 165273600 05:49:51 INFO - PROCESS | 20146 | 05:49:53 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58725/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:49:54 INFO - PROCESS | 20146 | RSS: Main: 166055936 05:49:54 INFO - PROCESS | 20146 | 05:49:56 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58725/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:49:57 INFO - PROCESS | 20146 | RSS: Main: 166002688 05:49:57 INFO - PROCESS | 20146 | 05:49:59 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58725/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:00 INFO - PROCESS | 20146 | RSS: Main: 166244352 05:50:00 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | Cycle 1(1): loaded http://localhost:58725/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58725/tests/kraken/driver.html?testName=ai-astar) 05:50:02 INFO - PROCESS | 20146 | RSS: Main: 166686720 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | __start_tp_report 05:50:02 INFO - PROCESS | 20146 | _x_x_mozilla_page_load 05:50:02 INFO - PROCESS | 20146 | _x_x_mozilla_page_load_details 05:50:02 INFO - PROCESS | 20146 | |i|pagename|runs| 05:50:02 INFO - PROCESS | 20146 | |0;ai-astar;105;113;108;114;114;113;116;114;114;113 05:50:02 INFO - PROCESS | 20146 | |1;audio-beat-detection;149;123;155;186;126;154;151;122;183;120 05:50:02 INFO - PROCESS | 20146 | |2;audio-dft;163;164;164;163;165;177;164;162;164;163 05:50:02 INFO - PROCESS | 20146 | |3;audio-fft;75;76;76;175;76;75;85;77;166;79 05:50:02 INFO - PROCESS | 20146 | |4;audio-oscillator;85;83;144;87;86;84;140;88;85;150 05:50:02 INFO - PROCESS | 20146 | |5;imaging-gaussian-blur;118;118;118;118;118;119;118;120;118;119 05:50:02 INFO - PROCESS | 20146 | |6;imaging-darkroom;148;149;148;148;148;148;147;148;147;149 05:50:02 INFO - PROCESS | 20146 | |7;imaging-desaturate;97;96;96;96;97;96;97;96;97;96 05:50:02 INFO - PROCESS | 20146 | |8;json-parse-financial;54;52;58;53;55;54;53;51;52;52 05:50:02 INFO - PROCESS | 20146 | |9;json-stringify-tinderbox;63;64;64;64;64;68;65;64;63;64 05:50:02 INFO - PROCESS | 20146 | |10;stanford-crypto-aes;76;78;76;77;78;76;77;77;81;76 05:50:02 INFO - PROCESS | 20146 | |11;stanford-crypto-ccm;135;123;122;142;126;129;123;121;166;124 05:50:02 INFO - PROCESS | 20146 | |12;stanford-crypto-pbkdf2;168;163;163;159;167;162;162;158;159;162 05:50:02 INFO - PROCESS | 20146 | |13;stanford-crypto-sha256-iterative;64;64;63;72;65;63;65;64;67;68 05:50:02 INFO - PROCESS | 20146 | __end_tp_report 05:50:02 INFO - PROCESS | 20146 | __start_cc_report 05:50:02 INFO - PROCESS | 20146 | _x_x_mozilla_cycle_collect,886 05:50:02 INFO - PROCESS | 20146 | __end_cc_report 05:50:02 INFO - PROCESS | 20146 | __startTimestamp1470142202556__endTimestamp 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | ------- Summary: start ------- 05:50:02 INFO - PROCESS | 20146 | Number of tests: 14 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#0] ai-astar Cycles:10 Average:112.40 Median:114.00 stddev:3.31 (2.9%) stddev-sans-first:2.17 05:50:02 INFO - PROCESS | 20146 | Values: 105.0 113.0 108.0 114.0 114.0 113.0 116.0 114.0 114.0 113.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:152.50 stddev:24.31 (15.9%) stddev-sans-first:25.78 05:50:02 INFO - PROCESS | 20146 | Values: 149.0 123.0 155.0 186.0 126.0 154.0 151.0 122.0 183.0 120.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:4.33 (2.6%) stddev-sans-first:4.54 05:50:02 INFO - PROCESS | 20146 | Values: 163.0 164.0 164.0 163.0 165.0 177.0 164.0 162.0 164.0 163.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#3] audio-fft Cycles:10 Average:96.00 Median:76.00 stddev:39.43 (51.9%) stddev-sans-first:41.09 05:50:02 INFO - PROCESS | 20146 | Values: 75.0 76.0 76.0 175.0 76.0 75.0 85.0 77.0 166.0 79.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:85.00 stddev:28.75 (33.8%) stddev-sans-first:29.73 05:50:02 INFO - PROCESS | 20146 | Values: 85.0 83.0 144.0 87.0 86.0 84.0 140.0 88.0 85.0 150.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:50:02 INFO - PROCESS | 20146 | Values: 118.0 118.0 118.0 118.0 118.0 119.0 118.0 120.0 118.0 119.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:50:02 INFO - PROCESS | 20146 | Values: 148.0 149.0 148.0 148.0 148.0 148.0 147.0 148.0 147.0 149.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:50:02 INFO - PROCESS | 20146 | Values: 97.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 97.0 96.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:2.01 (3.8%) stddev-sans-first:2.12 05:50:02 INFO - PROCESS | 20146 | Values: 54.0 52.0 58.0 53.0 55.0 54.0 53.0 51.0 52.0 52.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:1.42 (2.2%) stddev-sans-first:1.42 05:50:02 INFO - PROCESS | 20146 | Values: 63.0 64.0 64.0 64.0 64.0 68.0 65.0 64.0 63.0 64.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:1.55 (2.0%) stddev-sans-first:1.58 05:50:02 INFO - PROCESS | 20146 | Values: 76.0 78.0 76.0 77.0 78.0 76.0 77.0 77.0 81.0 76.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:127.50 stddev:13.94 (10.9%) stddev-sans-first:14.71 05:50:02 INFO - PROCESS | 20146 | Values: 135.0 123.0 122.0 142.0 126.0 129.0 123.0 121.0 166.0 124.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.50 stddev:3.27 (2.0%) stddev-sans-first:2.74 05:50:02 INFO - PROCESS | 20146 | Values: 168.0 163.0 163.0 159.0 167.0 162.0 162.0 158.0 159.0 162.0 05:50:02 INFO - PROCESS | 20146 | 05:50:02 INFO - PROCESS | 20146 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.00 stddev:2.80 (4.3%) stddev-sans-first:2.92 05:50:02 INFO - PROCESS | 20146 | Values: 64.0 64.0 63.0 72.0 65.0 63.0 65.0 64.0 67.0 68.0 05:50:02 INFO - PROCESS | 20146 | -------- Summary: end -------- 05:50:02 INFO - PROCESS | 20146 | 05:50:03 INFO - TEST-INFO | 20146: exit 0 05:50:03 INFO - TEST-OK | kraken | took 61413ms 05:50:03 INFO - SUITE-END | took 1172s 05:50:03 INFO - Completed test suite (00:19:32) 05:50:03 INFO - javascript benchmark 05:50:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7215.285777816835, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.565780790689, 3101.8138911665314, 3122.4847900096493, 3142.685731426859, 3147.4491963906326, 5314.654547454413, 5428.348598168221, 5494.285742853428, 5514.80698175564, 5536.723163841812, 5447.12845944649, 5488.396276409591, 5492.258545096411, 5496.148097044965, 5501.752421141048, 4757.815698295582, 4898.06936682031, 4989.101961646902, 5082.059818933509, 5152.92270615941, 5092.719900405476, 5108.157154069574, 5126.615503837227, 5161.096808058574, 5171.818986335479, 4939.061578300111, 4972.651914365996, 4994.650374473788, 5021.422536408323, 5043.016611760708, 5017.573506251973, 5031.698098114125, 5048.29323894655, 5049.040682270357, 5059.696418214919, 4976.825811096594, 4997.90004199914, 5004.224345226459, 5013.348264725599, 5036.647434679574, 5333.679979201261, 5393.541548968343, 5442.673439593637, 5443.265159203496, 5517.779288828442, 5853.736581853785, 5862.882742345172, 5870.823875283749, 5871.001929671966, 5886.558508111909, 5907.616004959664, 5912.260967379078, 5916.792912248094, 5918.496927761145, 5919.2009078774245, 5354.544863686591, 5393.1370980643305, 5411.756470958816, 5416.8104116355735, 5493.670379777186, 5933.584649074523, 5970.731317090741, 5982.4316689914385, 5986.4013598639785, 6031.065184896348, 5712.485876271156, 5746.856328591735, 5747.252857128547, 5759.712014399263, 5764.827055188351, 5696.914546281809, 5701.4013528579735, 5777.422257774273, 5819.592628515963, 5852.356240813507, 5845.123231515222, 5848.239728835224, 5849.444302791228, 5866.061430171152, 5882.705864706748, 5790.739416726257, 5800.9129863052085, 5838.12428135783, 5856.443637854397, 5862.912056319158, 4369.563043695605, 4450.287953927356, 4464.129494748558, 4478.2386994211065, 4516.932246016312, 3938.783366914847, 3997.380406037069, 4035.1929614076716, 4036.656884164879, 4061.735987160884, 5565.888682226333, 5585.0, 5599.580031497654, 5601.775928962796, 5610.438956104357, 5721.8569535761935, 5820.3888591698105, 5902.409759024149, 5907.527397808165, 5938.317093534212, 5623.6906970116215, 5689.601727879091, 5703.62926409782, 5718.628289161191, 5729.197912292282, 5159.948400515947, 5162.819301324435, 5163.199704045879, 5180.611454140954, 5206.193040078794, 5915.024021036566, 6013.939860601426, 6141.631093688469, 6190.350013248634, 6196.783112591128, 5848.561357898089, 5910.936031514369, 5923.022701254245, 5924.0, 5945.0, 6015.39846015395, 6066.666333351708, 6070.2108725865355, 6082.817515474543, 6126.326104128631, 5582.3859375467855, 5732.16883551891, 5764.884702306014, 5774.422557744192, 5776.335721391925, 5946.464818166386, 5954.434328738763, 5978.0, 5984.551158663205, 6025.457708806053, 5785.9132113017495, 5829.417058294137, 5837.67892765885, 5842.678652674143, 5860.589758716849, 5559.610827242054, 5684.317881854204, 5726.455986681259, 5831.067029275465, 5841.824745257649, 5708.086706127, 5710.3433105193435, 5720.799772007959, 5725.19847221381, 5771.567132465166, 5784.479396854304, 5792.536597072309, 5830.76676932918, 5832.270966129234, 5846.503047240862, 5506.174073888948, 5563.554915606661, 5631.8592035199445, 5664.122061080539, 5695.515881150149], "value": 5420.949877596695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.276315975445, 578.7482445136363, 584.880099579586, 598.3836648252301, 629.28261781569, 39151.80424097879, 43504.56495435045, 43524.56475435245, 43526.782366088206, 43649.345259821086, 41055.794721026425, 41602.79198604003, 41646.0, 41986.16027679452, 42876.35685464713, 8836.734897953073, 8944.060873608276, 8985.37102402832, 9010.09899010097, 9018.503982280972, 8778.122187781235, 8957.462552246854, 8975.820483590323, 9015.413998090104, 9037.59330830111, 8940.910590894106, 8974.237189838872, 9046.638134474613, 9068.093190680946, 9085.863712044325, 8999.23506501948, 9001.459912405244, 9050.637974481013, 9066.184043436122, 9094.545272736403, 8833.072527384596, 8851.247643950272, 8901.109889011112, 8926.285897128215, 8945.284377249804, 41476.79261603673, 41679.1664166715, 41774.1645167098, 41804.372934406005, 41856.162876742295, 3510.0, 3588.784672919633, 3672.559292884871, 3721.218544105741, 3787.091098136455, 32557.51163732546, 33593.32813343744, 33647.15882102943, 33654.66345336564, 33753.831230843934, 4404.2512772828695, 4551.795169217393, 4574.0, 4668.976655116737, 4703.905921881543, 257099.0, 257194.0, 257880.0, 258382.83234335209, 260759.0, 33386.165345866546, 57870.710646446496, 58331.0, 58436.4156358431, 58610.0, 35165.64834351624, 35199.648003520146, 35263.64736352603, 35308.29383412317, 35358.823205883804, 15265.313060912285, 15271.312790924436, 15288.082715037133, 15347.309371078329, 15424.845751542565, 11395.088392928546, 11408.942955285336, 11414.201005929504, 11430.485628146753, 11436.656900293005, 8209.876851847228, 8271.95864020676, 8325.916740832514, 8361.122082181406, 8389.0, 3193.1059303395086, 3198.98400507996, 3206.599175103112, 3251.6748325167296, 3282.474804031391, 987.5013118375318, 1074.5272080284649, 1122.3199259089615, 1139.145640769423, 1146.3465824479965, 31944.0, 32638.347233055207, 32920.176995575304, 33023.66976330254, 33352.83323583415, 1092.1481244629201, 1133.6882357351794, 1150.7871043856912, 1157.265136638224, 1199.7540504196618, 16986.575335616708, 17079.829201707824, 17192.22634981404, 17268.913655431894, 17425.215865286093, 592528.0, 909479.0, 927987.0, 931620.0, 936906.0, 61429.69285153546, 61476.463088423145, 61533.0, 61955.380446195864, 62172.0, 1379.9310034498235, 1393.4078016842802, 1395.3581352577928, 1397.2734178227468, 1418.3333833098427, 31937.0, 32862.507062394565, 33507.0, 33885.66114338825, 34132.0, 54194.45805541894, 54428.0, 54494.0, 54628.453715463926, 54630.0, 535452.0, 542163.0, 543734.0, 543842.0, 544242.0, 28685.856570717013, 29075.56386654244, 29146.27134321574, 29224.853875730485, 29619.703802961696, 48007.519924800305, 49106.26340604965, 50150.24774628456, 50239.74880125576, 50393.0, 41271.0, 42491.0, 42524.880409083264, 43401.782991084845, 43869.341959871264, 42922.570774293104, 42982.78508607437, 43173.78413107914, 43630.78184609057, 43909.341359878985, 40131.39802903017, 41315.7934210327, 41587.0, 41679.16641667089, 45127.0, 35480.46779298261, 37976.0, 39336.40995385014, 39532.0, 39580.80209598933, 29250.41499169962, 29477.410451791275, 29531.772075629233, 29559.26101847471, 29964.850175748983], "value": 19362.06722961976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.2979556806332, 354.97486837591543, 387.74215146927287, 389.8323720800056, 402.5250204758386, 18164.455066348015, 18796.812031879675, 18863.62272754546, 19384.32154874578, 19572.510687232825, 11307.773844523104, 11623.767524649502, 11685.883141168586, 11690.590829320976, 11706.882931170707, 4774.522547745215, 5032.698038117706, 5043.067032598962, 5083.898322033557, 5088.23676448532, 3760.3419401604747, 4990.201567749161, 5371.248025276464, 5603.355614104389, 5667.433256674341, 5665.23519324892, 5686.658800471964, 5697.287839020122, 5743.368229494752, 5779.190913272145, 5520.530754885819, 5666.235058267122, 5720.656760594377, 5724.169995350671, 5726.885462290752, 5350.652207606493, 5469.671819690831, 5517.337919449692, 5517.724113794335, 5521.309836270466, 12862.678433039155, 12913.806292905614, 12949.870501294961, 13023.28371939543, 13115.0, 2311.4914718761847, 2359.2922123362923, 2468.666729991446, 2509.1970569417795, 2810.5081610718044, 9477.90522094777, 9664.95167524165, 9829.55766990487, 9883.8517422238, 10036.548355324028, 1840.2271046160645, 1883.3973128598855, 1919.9040047997685, 1996.045570096987, 2008.3874418302412, 82302.58848705779, 83157.16842831616, 83330.16669833285, 84603.5769821147, 84880.57559712161, 10685.83971240432, 10991.120710343153, 11035.889641103648, 11069.889301106887, 11104.944475277573, 15152.01511901723, 15254.618634534225, 15341.0, 15360.846391536164, 15420.768688469681, 8263.421560490708, 8370.832583348421, 8423.326133909395, 8453.746387608382, 8576.142385761374, 8050.5572193529915, 8063.153368896299, 8124.106348301682, 8156.306713929383, 8331.0, 4635.860924172281, 4696.671233013656, 4706.552877476634, 4803.207470767285, 4883.438404583448, 1603.2945503978447, 1701.2004357951744, 1720.6386658801541, 1845.612421391496, 1916.3963351544219, 921.9032001639865, 1025.8820235672845, 1035.5961175141701, 1061.4957894999814, 1074.5285842562075, 18361.17374718141, 18449.815501845078, 18711.251549938122, 19618.196790856742, 19669.803301967084, 1003.1423133220991, 1031.9226058045676, 1047.9580816767243, 1075.2903083964702, 1115.130198445214, 10466.895331046744, 10802.72993175177, 10852.077573406192, 10897.67306980792, 10940.507677154546, 533605.0, 538284.0, 540273.0, 543506.0, 544312.0, 89529.0, 89925.55037224902, 90179.54910225538, 90953.0, 92046.71579557873, 971.6599190283486, 1021.3871676993745, 1034.6844212515255, 1043.9269251152346, 1048.1248157788332, 16699.833001669827, 16798.66402671964, 17078.316867325666, 17609.383671571435, 17798.822011780234, 41997.79001104975, 42184.36723449212, 42280.365794512494, 42749.57250427456, 42969.785151074044, 52476.47523524868, 58537.4146258532, 59888.0, 59890.0, 60683.39316606778, 7055.753048643272, 7221.241769614115, 7307.2327405621645, 7378.631068446663, 7702.114256860309, 11851.348175850411, 12977.35113244353, 13325.267110308638, 13459.3943272551, 13809.723805523632, 11406.315621062762, 11745.354005529778, 11762.882371176522, 11961.880381196077, 12174.634760957186, 10358.274920755775, 11632.243904146204, 11696.766064678828, 11727.530898763955, 11779.05767538612, 12055.81916271239, 12176.269423834598, 12291.139620226855, 12382.628521144019, 12553.309567973849, 8077.717279895175, 8129.878051829109, 8205.384596155192, 8346.666133354598, 8695.956520217358, 8776.385653004229, 10943.671689849318, 11758.529658813552, 11911.821322679993, 11983.04135669127], "value": 8856.853998130351, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.5879553724953, 1473.4327283995663, 1602.2469439363501, 1763.5502946748577, 1769.5841477252836, 7768.06783186017, 8594.183552562497, 8665.956670216648, 9449.858252126223, 9491.335606507539, 8726.127387261271, 9127.178553930145, 9151.588178531965, 9174.357794954356, 9178.173964343208, 2349.3891588187066, 2393.497365553236, 2394.3415560720855, 2396.532676128147, 2399.928002159938, 2322.7328857181474, 2340.3681006128336, 2368.5854975379325, 2371.8221133415063, 2374.382660508272, 2327.487952650414, 2346.049849810821, 2356.363781778927, 2356.9292921212304, 2361.0319768894756, 2264.1962103453284, 2266.8299877509253, 2273.6930514380597, 2281.840271181018, 2354.0348457132495, 2288.2448791898632, 2290.725112986452, 2299.7930186283147, 2310.4223944013997, 2314.3866875278063, 8867.068957759408, 8912.688055918012, 8948.910510894873, 8997.0, 9020.323475739346, 4978.452370239271, 5098.643094983353, 5139.17773156297, 5184.662996905189, 5185.948140518584, 3310.7351411886993, 3363.7140843028374, 3375.4599264117624, 3408.454647256452, 3443.5351227584456, 1059.5973530058604, 1060.5386656804237, 1078.9082927951133, 1101.2786624760795, 1111.6831702964698, 12730.681732956658, 12855.0, 12873.29196894161, 12989.480420783157, 13005.609831705064, 4441.422615060022, 4565.794539245742, 4700.670953033323, 4770.976145119253, 4776.498467660915, 10594.0, 10768.515416806105, 10821.863704310934, 10858.34849909008, 10863.07663848566, 5331.466853314638, 5335.493128152819, 5351.892962140735, 5368.32895888014, 5371.328583927009, 4228.429162063082, 4717.339572459859, 4908.509149085135, 4933.827316043921, 4936.308916751657, 3882.883513494543, 4000.2199571083943, 4089.6932730045364, 4096.160287141189, 4104.938425923614, 1257.251935098615, 1260.7541529401863, 1281.8141369501557, 1294.7022184897526, 1308.8560258371572, 935.3639525122845, 1000.1298869983161, 1041.2450973044633, 1048.3762161513887, 1057.1120258982337, 6050.757969681164, 6159.84600384994, 6194.566380353423, 6223.1287619733275, 6325.177726895474, 447.36920941473016, 454.21420941770924, 456.67347846289397, 464.5609898645747, 1034.591336422109, 4091.8977025574004, 4113.9794301028305, 4218.0, 4302.612764851178, 4375.387445757597, 11170.720731981766, 11696.298222106701, 11734.589289374831, 11746.471408786625, 11773.587924422603, 11492.597759078391, 11565.074794016458, 11568.768624627628, 11575.0, 11635.53457861676, 8224.62989165501, 8292.917070829215, 8304.211099945496, 8367.079621241659, 8379.455335403301, 6114.144019837316, 6222.0, 6234.937650623436, 6320.873582528416, 6329.715162817776, 10278.691639250834, 10282.897171028493, 10622.787544249226, 10640.04239618438, 10665.0, 10094.343867648578, 10193.439360835226, 10357.326773759682, 10402.947985260025, 10490.423026733602, 6800.761973330909, 7494.775156745306, 7637.770866874002, 7638.923610763822, 7825.608719563885, 9041.23149532297, 9064.18422341966, 9092.363534552518, 9099.0, 9117.997020327892, 7565.167831538636, 7620.69517219305, 7675.846483070419, 7813.843723125619, 7922.524648521107, 7419.332260096618, 7539.849203016019, 7596.126445458622, 7668.424868134801, 7674.117476490052, 6936.132983377078, 7101.857962840818, 7137.607431591105, 7139.892901606376, 7143.357097861218, 5496.532794712494, 5568.582356323373, 5594.832155035356, 5627.943720562906, 5691.800786972436, 5490.121580547093, 5575.0, 5594.104943209067, 5655.406182350794, 5676.34722006958], "value": 4674.968618709707, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.63510422597096, 312.3160278989014, 322.3536808698559, 322.70472517646357, 322.8321272938072, 5104.183330667094, 5444.646098003627, 5495.862603434916, 5512.912768849447, 5548.278723765915, 5374.145919657712, 5378.3058336623935, 5398.190271459283, 5406.189071639256, 5412.484504338791, 4227.217964676537, 4250.574942505756, 4251.744895306276, 4287.1425714857, 4289.185054839586, 4098.4876890388705, 4239.40648309237, 4253.936190957138, 4277.1873344064525, 4311.590398912114, 4182.2890108681595, 4194.119234960646, 4216.388623649569, 4216.388623649569, 4219.556946520617, 4190.0, 4219.704620676569, 4233.618974292298, 4254.170436764832, 4274.316109422478, 3666.944995825065, 3742.7754334740002, 3744.6817020553285, 3755.5728823047066, 3764.6611804937415, 5253.553447956928, 5294.735263236823, 5296.390915044781, 5309.707966061865, 5344.412114667383, 4814.518548145193, 4829.782659780283, 4832.371791667096, 4839.104765618372, 4866.367372241586, 5556.444355564452, 5631.8592035199445, 5704.828855134353, 5728.25532680753, 5736.569757268222, 4057.9188416231805, 4069.3895915612893, 4073.5111786585503, 4078.938815917764, 4085.4076158956786, 5934.910976335358, 5936.456521304492, 5961.284645842483, 5964.194833697438, 5978.521718262528, 4012.4181993611346, 4137.91724165515, 4169.854055108057, 4170.70708080496, 4191.476065491814, 4231.196072746168, 4265.445492086009, 4290.742555446684, 4299.441072660534, 4301.376300436419, 4877.268409738567, 4921.8523444296725, 4923.532264434873, 4941.45643979162, 4949.579285760678, 5467.425920278393, 5786.739596718157, 5867.501262392744, 5868.794592189253, 5888.646681199141, 1430.342042660367, 1449.5506393018197, 1456.3300881594585, 1456.4028748213182, 1460.233377476812, 868.6221493650156, 893.6372032650261, 909.0500427053745, 910.9590068446803, 917.4632839788665, 4941.407031156285, 4959.603231741452, 4991.803606413167, 5002.124628190052, 5004.324416203839, 5173.628988318099, 5188.558972487305, 5240.554552863049, 5267.578593712494, 5273.91884663643, 4788.0498588664495, 4996.3504744383, 4999.175136102575, 4999.400071991385, 5029.245613158056, 2761.9447611047667, 2765.4883846488465, 2791.0, 2793.231861238176, 2796.860156992142, 5384.434634363335, 5387.380451248078, 5436.945630543723, 5463.235147079412, 5469.835904922858, 5133.845984620468, 5242.580593552507, 5273.681579605099, 5282.81510147143, 5349.7962958334065, 5319.388270348882, 5372.489613486712, 5417.59368047398, 5431.402545719968, 5463.224452053019, 5196.714180719945, 5229.947700522946, 5328.920066199088, 5338.733063346895, 5381.596380271417, 4899.681520701143, 5110.66780659256, 5138.8972220556125, 5149.639525233198, 5173.586113110867, 5355.919661205163, 5357.357117145967, 5369.221462887781, 5381.0, 5435.755391007493, 3778.0554861284677, 4068.2066996935314, 4076.8369265229057, 4172.603602657743, 4192.853250136231, 5814.30228372581, 5837.0, 5841.153032810304, 5848.210491583582, 5893.0, 5577.386487486455, 5719.970405327081, 5746.16680581305, 5797.4782269595935, 5804.593678442468, 5697.353693636159, 5717.113847353667, 5749.1663708762835, 5757.96356655806, 5772.7690892363835, 5628.74670639814, 5632.915506267327, 5639.971800140973, 5689.487946084872, 5694.117411801178, 5533.837894042296, 5684.914726279192, 5720.856978575569, 5775.306963164448, 5809.215755872903, 5579.74891129892, 5642.379338272704, 5643.661380317194, 5665.943340566707, 5671.801486947937], "value": 4209.026952871657, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.4790950515627, 734.7501849371209, 774.9070111586609, 792.2750683124939, 803.9758807235781, 15034.473793417232, 15956.601084972881, 15985.520434386986, 16002.279897404616, 16003.519894403173, 14366.640833979156, 14577.0, 14649.707005859904, 14716.484923027696, 14723.852761472383, 663.8473151175233, 772.9884051739215, 795.3676826922582, 802.1336956087441, 818.5007145641155, 809.9433039687224, 812.8780682897553, 813.7029984055836, 814.0434988888062, 815.9877601835977, 837.9790505237357, 839.7648658375665, 842.3682238321259, 844.543946269017, 850.0606829453458, 845.7547311279721, 845.8815765792793, 846.0397448895486, 846.0989046665281, 847.1740053447901, 617.1329282358294, 618.5113760129492, 620.9099680546295, 621.2513920725515, 621.6860485454862, 14685.486007989775, 14752.926235368861, 14772.26138693061, 14791.260436978107, 14802.481913132988, 14400.927995360062, 14437.711245775026, 14752.114873107648, 14759.852401475955, 14927.477538286108, 12357.505699771998, 12459.12786104973, 12520.937395312965, 12743.92194497761, 12754.426050827642, 3973.940390894139, 4046.190761847642, 4080.6939479539155, 4122.34042553193, 4167.708260421772, 83207.0, 84553.57723211344, 85304.57347713222, 87548.0, 87632.80917977038, 12092.455839487244, 12138.211016283913, 12262.693432664077, 12446.31545265001, 12480.937595311965, 22903.312900612676, 22937.426564335692, 22983.655245171336, 23159.305220843402, 23315.650265246033, 8543.487390756574, 8748.650053997897, 8754.387192896564, 8990.0, 9003.504807235666, 4895.755212239445, 4962.851114466572, 5007.949920500749, 5036.269740887624, 5064.240363945364, 3818.3127037133027, 3905.4922860028582, 3910.1006768443417, 3960.603939606074, 3962.5641179470813, 644.3234603666132, 659.8086554899121, 660.8777376185325, 667.956582822115, 672.8990651402231, 672.3847679373416, 685.2256949646867, 710.4848984486309, 770.2451597434433, 774.9767506974799, 10304.845427318596, 10379.636712715019, 10383.428911409794, 10446.843297350546, 10719.19606029551, 654.5418207254941, 690.1580072311772, 732.5018987088724, 737.0602481835703, 759.3393747439762, 4736.8578942631775, 4855.514448555116, 4907.5828554572545, 4910.582600478928, 4976.651634385558, 74412.62793686106, 75736.24263757402, 75890.0, 113154.0, 130573.0, 113300.43349783363, 117017.0, 117208.0, 117352.0, 117973.41013294879, 97748.0, 99213.50393247987, 99376.0, 99736.50131749295, 103794.0, 9102.817943640957, 9398.53007349616, 9426.434413935185, 9511.619535218513, 9548.665796697082, 55682.16476752771, 56049.0, 56997.43002570087, 57170.42829571817, 57316.71341643265, 78143.21856781587, 81102.59448702719, 82433.58783206045, 84292.57853710938, 86283.0, 12242.571509997464, 12486.375681216085, 12660.556880509139, 12729.872701272869, 12971.935140324238, 13443.0, 13685.726285474433, 13760.17438953666, 13779.346478422653, 13912.234827084607, 12660.620181394574, 12852.357382130669, 12864.356782160667, 13001.609951701465, 13129.868701312864, 12561.120721549403, 12677.87322126767, 12694.682632934251, 12846.357682116044, 13033.283169425773, 12818.67953301175, 12842.81798490206, 12936.935315323739, 12958.602658508205, 13144.474221031434, 10675.519601618102, 10900.127989760958, 11262.0, 11387.487563059516, 11694.122940779305, 9939.701808945743, 11202.607908723481, 11232.157588181082, 11246.718832029264, 11509.884901150881], "value": 7712.7881745359955, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 108.0, 114.0, 114.0, 113.0, 116.0, 114.0, 114.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 155.0, 186.0, 126.0, 154.0, 151.0, 122.0, 183.0, 120.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 163.0, 165.0, 177.0, 164.0, 162.0, 164.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 175.0, 76.0, 75.0, 85.0, 77.0, 166.0, 79.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 144.0, 87.0, 86.0, 84.0, 140.0, 88.0, 85.0, 150.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 120.0, 118.0, 119.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 149.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 58.0, 53.0, 55.0, 54.0, 53.0, 51.0, 52.0, 52.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 68.0, 65.0, 64.0, 63.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 77.0, 78.0, 76.0, 77.0, 77.0, 81.0, 76.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 123.0, 122.0, 142.0, 126.0, 129.0, 123.0, 121.0, 166.0, 124.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 163.0, 159.0, 167.0, 162.0, 162.0, 158.0, 159.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 72.0, 65.0, 63.0, 65.0, 64.0, 67.0, 68.0], "value": 65.5, "unit": "score"}]}]} 05:50:03 INFO - Return code: 0 05:50:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:50:03 ERROR - # TBPL SUCCESS # 05:50:03 INFO - Running post-action listener: _resource_record_post_action 05:50:03 INFO - [mozharness: 2016-08-02 12:50:03.869073Z] Finished run-tests step (success) 05:50:03 INFO - Running post-run listener: _resource_record_post_run 05:50:03 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 308797440; Read time: 0; Write time: 220536 05:50:03 INFO - TinderboxPrint: CPU usage
13.4% 05:50:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:50:03 INFO - TinderboxPrint: I/O write bytes / time
308,797,440 / 220,536 05:50:03 INFO - TinderboxPrint: CPU idle
8,214.1 (86.6%) 05:50:03 INFO - TinderboxPrint: CPU user
1,213.3 (12.8%) 05:50:03 INFO - TinderboxPrint: Swap in / out
0 / 0 05:50:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 19918848; Read time: 0; Write time: 5320 05:50:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 288481280; Read time: 0; Write time: 215136 05:50:04 INFO - Running post-run listener: _upload_blobber_files 05:50:04 INFO - Blob upload gear active. 05:50:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:50:04 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 05:50:04 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'] 05:50:04 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 05:50:04 INFO - (blobuploader) - INFO - Open directory for files ... 05:50:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:50:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:50:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:05 INFO - (blobuploader) - INFO - Done attempting. 05:50:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:50:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:50:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:10 INFO - (blobuploader) - INFO - Done attempting. 05:50:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:50:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:50:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:10 INFO - (blobuploader) - INFO - Done attempting. 05:50:10 INFO - (blobuploader) - INFO - Iteration through files over. 05:50:10 INFO - Return code: 0 05:50:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:50:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:50:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38bb0f5a7cc4a1c9e58fab1bc2e3e5f3a2c1e2401604e26a2d2e7976de6707c04c099137dc9736564f80295c55f3dd9fcf04e7ce1ea507efe19fa48c13e2c297", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99f6776e603b53b7699abda27c9a808a6801a6090355f446be8c7df40476b1b2ca64086c600a0145e113fbf1dfc3099fd8c5e3a83d925ba70d269851deed6009", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e32b511b86013cd350e09b7dd6316b62a83555791d7b61dffaaac4f242e6511abbe3273f4e52ef3b1e3f25e37f08164e2b7c6fa852ff6d006be115e1630af561"} 05:50:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:50:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:50:10 INFO - Contents: 05:50:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38bb0f5a7cc4a1c9e58fab1bc2e3e5f3a2c1e2401604e26a2d2e7976de6707c04c099137dc9736564f80295c55f3dd9fcf04e7ce1ea507efe19fa48c13e2c297", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99f6776e603b53b7699abda27c9a808a6801a6090355f446be8c7df40476b1b2ca64086c600a0145e113fbf1dfc3099fd8c5e3a83d925ba70d269851deed6009", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e32b511b86013cd350e09b7dd6316b62a83555791d7b61dffaaac4f242e6511abbe3273f4e52ef3b1e3f25e37f08164e2b7c6fa852ff6d006be115e1630af561"} 05:50:10 INFO - Running post-run listener: copy_logs_to_upload_dir 05:50:10 INFO - Copying logs to upload dir... 05:50:10 INFO - mkdir: /builds/slave/test/build/upload/logs 05:50:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.777170 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-08-02 05:50:10.596419) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 05:50:10.599826) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385 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/38bb0f5a7cc4a1c9e58fab1bc2e3e5f3a2c1e2401604e26a2d2e7976de6707c04c099137dc9736564f80295c55f3dd9fcf04e7ce1ea507efe19fa48c13e2c297", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99f6776e603b53b7699abda27c9a808a6801a6090355f446be8c7df40476b1b2ca64086c600a0145e113fbf1dfc3099fd8c5e3a83d925ba70d269851deed6009", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e32b511b86013cd350e09b7dd6316b62a83555791d7b61dffaaac4f242e6511abbe3273f4e52ef3b1e3f25e37f08164e2b7c6fa852ff6d006be115e1630af561"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1470130201/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38bb0f5a7cc4a1c9e58fab1bc2e3e5f3a2c1e2401604e26a2d2e7976de6707c04c099137dc9736564f80295c55f3dd9fcf04e7ce1ea507efe19fa48c13e2c297", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99f6776e603b53b7699abda27c9a808a6801a6090355f446be8c7df40476b1b2ca64086c600a0145e113fbf1dfc3099fd8c5e3a83d925ba70d269851deed6009", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e32b511b86013cd350e09b7dd6316b62a83555791d7b61dffaaac4f242e6511abbe3273f4e52ef3b1e3f25e37f08164e2b7c6fa852ff6d006be115e1630af561"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 05:50:10.625408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:50:10.625760) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470140560.161768-1916023385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:50:10.711247) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 05:50:10.711609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 05:50:10.711929) ========= ========= Total master_lag: 0.17 =========