builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1469542578.93 results: success (0) buildid: 20160726065649 builduid: 58e0d382e1c4473cac7a260233d57f9a revision: 39ebdb2e59f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 07:16:18.927173) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 07:16:18.927609) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 07:16:18.927878) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 07:16:18.942089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 07:16:18.942431) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 07:16:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-07-26 07:16:19 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135455 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 07:16:19.091850) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 07:16:19.092197) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019800 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 07:16:19.142087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 07:16:19.142474) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 39ebdb2e59f2 --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 39ebdb2e59f2 --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=97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 07:16:19,332 Setting DEBUG logging. 2016-07-26 07:16:19,333 attempt 1/10 2016-07-26 07:16:19,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/39ebdb2e59f2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 07:16:20,760 unpacking tar archive at: fx-team-39ebdb2e59f2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.774445 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 07:16:20.930804) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 07:16:20.931194) ========= script_repo_revision: 39ebdb2e59f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 07:16:20.931664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 07:16:20.931929) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 07:16:20.943600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-26 07:16:20.943983) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:16:21 INFO - MultiFileLogger online at 20160726 07:16:21 in /builds/slave/test 07:16:21 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 07:16:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:16:21 INFO - {'append_to_log': False, 07:16:21 INFO - 'base_work_dir': '/builds/slave/test', 07:16:21 INFO - 'blob_upload_branch': 'Fx-Team', 07:16:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:16:21 INFO - 'branch': 'Fx-Team', 07:16:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:16:21 INFO - 'config_files': ('talos/linux_config.py',), 07:16:21 INFO - 'default_actions': ('clobber', 07:16:21 INFO - 'read-buildbot-config', 07:16:21 INFO - 'download-and-extract', 07:16:21 INFO - 'populate-webroot', 07:16:21 INFO - 'create-virtualenv', 07:16:21 INFO - 'install', 07:16:21 INFO - 'run-tests'), 07:16:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:16:21 INFO - 'download_minidump_stackwalk': True, 07:16:21 INFO - 'download_symbols': 'ondemand', 07:16:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:16:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:16:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:16:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:16:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:16:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:16:21 INFO - 'installer_path': 'installer.exe', 07:16:21 INFO - 'log_level': 'info', 07:16:21 INFO - 'log_name': 'talos', 07:16:21 INFO - 'log_to_console': True, 07:16:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:16:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:16:21 INFO - 'opt_config_files': (), 07:16:21 INFO - 'pip_index': False, 07:16:21 INFO - 'sps_profile': False, 07:16:21 INFO - 'sps_profile_interval': 0, 07:16:21 INFO - 'suite': 'dromaeojs-e10s', 07:16:21 INFO - 'system_bits': '32', 07:16:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:16:21 INFO - 'title': 'talos-linux64-ix-068', 07:16:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:16:21 INFO - 'use_talos_json': True, 07:16:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:16:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:16:21 INFO - 'work_dir': 'build'} 07:16:21 INFO - [mozharness: 2016-07-26 14:16:21.221751Z] Running clobber step. 07:16:21 INFO - Running pre-action listener: _resource_record_pre_action 07:16:21 INFO - Running main action method: clobber 07:16:21 INFO - rmtree: /builds/slave/test/build 07:16:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:16:21 INFO - Running post-action listener: _resource_record_post_action 07:16:21 INFO - [mozharness: 2016-07-26 14:16:21.693936Z] Finished clobber step (success) 07:16:21 INFO - [mozharness: 2016-07-26 14:16:21.694039Z] Running read-buildbot-config step. 07:16:21 INFO - Running pre-action listener: _resource_record_pre_action 07:16:21 INFO - Running main action method: read_buildbot_config 07:16:21 INFO - Using buildbot properties: 07:16:21 INFO - { 07:16:21 INFO - "project": "", 07:16:21 INFO - "product": "firefox", 07:16:21 INFO - "script_repo_revision": "production", 07:16:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:16:21 INFO - "repository": "", 07:16:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 07:16:21 INFO - "buildid": "20160726065649", 07:16:21 INFO - "stage_platform": "linux64-pgo", 07:16:21 INFO - "basedir": "/builds/slave/test", 07:16:21 INFO - "buildnumber": 607, 07:16:21 INFO - "platform": "ubuntu64_hw", 07:16:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:16:21 INFO - "slavebuilddir": "test", 07:16:21 INFO - "branch": "fx-team", 07:16:21 INFO - "revision": "39ebdb2e59f2", 07:16:21 INFO - "slavename": "talos-linux64-ix-068", 07:16:21 INFO - "builduid": "58e0d382e1c4473cac7a260233d57f9a", 07:16:21 INFO - "repo_path": "integration/fx-team" 07:16:21 INFO - } 07:16:21 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:16:21 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.test_packages.json. 07:16:21 INFO - Running post-action listener: _resource_record_post_action 07:16:21 INFO - [mozharness: 2016-07-26 14:16:21.696419Z] Finished read-buildbot-config step (success) 07:16:21 INFO - [mozharness: 2016-07-26 14:16:21.696509Z] Running download-and-extract step. 07:16:21 INFO - Running pre-action listener: _resource_record_pre_action 07:16:21 INFO - Running main action method: download_and_extract 07:16:21 INFO - mkdir: /builds/slave/test/build/tests 07:16: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')]} 07:16:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:16:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:16:21 INFO - Downloaded 1361 bytes. 07:16:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:16:21 INFO - Using the following test package requirements: 07:16:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:16:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:16:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:16:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:21 INFO - u'jsshell-linux-x86_64.zip'], 07:16:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:16:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:16:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:16:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:16:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:16:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:16:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:16: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')]} 07:16:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:16:22 INFO - Downloaded 24312212 bytes. 07:16:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:16:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:16:23 INFO - Return code: 0 07:16:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:16: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')]} 07:16:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:16:23 INFO - Downloaded 24312212 bytes. 07:16:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:16:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:16:25 INFO - Return code: 0 07:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:16:25 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:16:25 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:16:25 INFO - Downloaded 14413725 bytes. 07:16:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:16:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:16:25 INFO - Return code: 0 07:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:16:25 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:25 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:16:26 INFO - Downloaded 60927272 bytes. 07:16:26 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:26 INFO - mkdir: /builds/slave/test/properties 07:16:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:16:26 INFO - Writing to file /builds/slave/test/properties/build_url 07:16:26 INFO - Contents: 07:16:26 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:26 INFO - Running post-action listener: _resource_record_post_action 07:16:26 INFO - Running post-action listener: set_extra_try_arguments 07:16:26 INFO - [mozharness: 2016-07-26 14:16:26.680310Z] Finished download-and-extract step (success) 07:16:26 INFO - [mozharness: 2016-07-26 14:16:26.680549Z] Running populate-webroot step. 07:16:26 INFO - Running pre-action listener: _resource_record_pre_action 07:16:26 INFO - Running main action method: populate_webroot 07:16:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:16:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:16:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:16:26 INFO - '--tppagecycles', 07:16:26 INFO - '7'], 07:16:26 INFO - 'tests': ['tsvgm']}}, 07:16:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:16:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:16:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:16:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:16:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:16:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:16:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['damp', 'tps']}, 07:16:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'tests': ['damp', 'tps']}, 07:16:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['dromaeo_dom']}, 07:16:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:16:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['basic_compositor_video']}, 07:16:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:16:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['a11yr', 07:16:26 INFO - 'ts_paint', 07:16:26 INFO - 'tpaint', 07:16:26 INFO - 'sessionrestore', 07:16:26 INFO - 'sessionrestore_no_auto_restore', 07:16:26 INFO - 'tabpaint']}, 07:16:26 INFO - 'other-e10s': {'tests': ['a11yr', 07:16:26 INFO - 'ts_paint', 07:16:26 INFO - 'tpaint', 07:16:26 INFO - 'sessionrestore', 07:16:26 INFO - 'sessionrestore_no_auto_restore', 07:16:26 INFO - 'tabpaint']}, 07:16:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:16:26 INFO - 'ts_paint', 07:16:26 INFO - 'tpaint', 07:16:26 INFO - 'sessionrestore', 07:16:26 INFO - 'sessionrestore_no_auto_restore', 07:16:26 INFO - 'tabpaint']}, 07:16:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:16:26 INFO - 'ts_paint', 07:16:26 INFO - 'tpaint', 07:16:26 INFO - 'sessionrestore', 07:16:26 INFO - 'sessionrestore_no_auto_restore', 07:16:26 INFO - 'tabpaint']}, 07:16:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['a11yr', 07:16:26 INFO - 'ts_paint', 07:16:26 INFO - 'tpaint', 07:16:26 INFO - 'sessionrestore', 07:16:26 INFO - 'sessionrestore_no_auto_restore', 07:16:26 INFO - 'tabpaint']}, 07:16:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['a11yr', 07:16:26 INFO - 'ts_paint', 07:16:26 INFO - 'tpaint', 07:16:26 INFO - 'sessionrestore', 07:16:26 INFO - 'sessionrestore_no_auto_restore', 07:16:26 INFO - 'tabpaint']}, 07:16:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['tsvgx', 07:16:26 INFO - 'tsvgr_opacity', 07:16:26 INFO - 'tart', 07:16:26 INFO - 'tscrollx', 07:16:26 INFO - 'cart']}, 07:16:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:16:26 INFO - 'tsvgr_opacity', 07:16:26 INFO - 'tart', 07:16:26 INFO - 'tscrollx', 07:16:26 INFO - 'cart']}, 07:16:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['tp5o']}, 07:16:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'tests': ['tp5o']}, 07:16:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'talos_options': ['--disable-e10s', 07:16:26 INFO - '--xperf_path', 07:16:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:16:26 INFO - 'tests': ['tp5n']}, 07:16:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'talos_options': ['--xperf_path', 07:16:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:16:26 INFO - 'tests': ['tp5n']}}, 07:16:26 INFO - 'talos.zip': {'path': '', 07:16:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:16:26 INFO - Running post-action listener: _resource_record_post_action 07:16:26 INFO - [mozharness: 2016-07-26 14:16:26.699327Z] Finished populate-webroot step (success) 07:16:26 INFO - [mozharness: 2016-07-26 14:16:26.699417Z] Running create-virtualenv step. 07:16:26 INFO - Running pre-action listener: _resource_record_pre_action 07:16:26 INFO - Running main action method: create_virtualenv 07:16:26 INFO - Creating virtualenv /builds/slave/test/build/venv 07:16:26 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 07:16:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:16:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:16:26 INFO - Using real prefix '/usr' 07:16:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:16:27 INFO - Installing distribute.............................................................................................................................................................................................done. 07:16:29 INFO - Installing pip.................done. 07:16:29 INFO - Return code: 0 07:16:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:16:29 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')]} 07:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:29 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')]} 07:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:29 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 0x26d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2997180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29953b0>, '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 0x29962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', '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 07:16:29 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 07:16:29 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 07:16:29 INFO - Using env: {'DISPLAY': ':0', 07:16:29 INFO - 'HOME': '/home/cltbld', 07:16:29 INFO - 'LANG': 'en_US.UTF-8', 07:16:29 INFO - 'LANGUAGE': 'en_US:en', 07:16:29 INFO - 'LOGNAME': 'cltbld', 07:16:29 INFO - 'MAIL': '/var/mail/cltbld', 07:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:29 INFO - 'MOZ_NO_REMOTE': '1', 07:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:29 INFO - 'NO_EM_RESTART': '1', 07:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:29 INFO - 'PWD': '/builds/slave/test', 07:16:29 INFO - 'SHELL': '/bin/bash', 07:16:29 INFO - 'SHLVL': '1', 07:16:29 INFO - 'TERM': 'linux', 07:16:29 INFO - 'TMOUT': '86400', 07:16:29 INFO - 'USER': 'cltbld', 07:16:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', 07:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:29 INFO - '_': '/tools/buildbot/bin/python'} 07:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:29 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 07:16:29 INFO - Cleaning up... 07:16:29 INFO - Return code: 0 07:16:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:16:29 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')]} 07:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:29 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')]} 07:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:29 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 0x26d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2997180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29953b0>, '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 0x29962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', '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 07:16:29 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 07:16:29 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 07:16:29 INFO - Using env: {'DISPLAY': ':0', 07:16:29 INFO - 'HOME': '/home/cltbld', 07:16:29 INFO - 'LANG': 'en_US.UTF-8', 07:16:29 INFO - 'LANGUAGE': 'en_US:en', 07:16:29 INFO - 'LOGNAME': 'cltbld', 07:16:29 INFO - 'MAIL': '/var/mail/cltbld', 07:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:29 INFO - 'MOZ_NO_REMOTE': '1', 07:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:29 INFO - 'NO_EM_RESTART': '1', 07:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:29 INFO - 'PWD': '/builds/slave/test', 07:16:29 INFO - 'SHELL': '/bin/bash', 07:16:29 INFO - 'SHLVL': '1', 07:16:29 INFO - 'TERM': 'linux', 07:16:29 INFO - 'TMOUT': '86400', 07:16:29 INFO - 'USER': 'cltbld', 07:16:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', 07:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:29 INFO - '_': '/tools/buildbot/bin/python'} 07:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:29 INFO - Downloading/unpacking psutil>=3.1.1 07:16:29 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 07:16:29 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 07:16:29 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 07:16:29 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 07:16:29 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 07:16:29 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 07:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:16:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:16:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:16:31 INFO - Installing collected packages: psutil 07:16:31 INFO - Running setup.py install for psutil 07:16:31 INFO - building 'psutil._psutil_linux' extension 07:16:31 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 07:16:31 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 07:16:31 INFO - building 'psutil._psutil_posix' extension 07:16:31 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 07:16:32 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 07:16:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:16:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:16:32 INFO - Successfully installed psutil 07:16:32 INFO - Cleaning up... 07:16:32 INFO - Return code: 0 07:16:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:16:32 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')]} 07:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:32 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')]} 07:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:32 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 0x26d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2997180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29953b0>, '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 0x29962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', '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 07:16:32 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 07:16:32 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 07:16:32 INFO - Using env: {'DISPLAY': ':0', 07:16:32 INFO - 'HOME': '/home/cltbld', 07:16:32 INFO - 'LANG': 'en_US.UTF-8', 07:16:32 INFO - 'LANGUAGE': 'en_US:en', 07:16:32 INFO - 'LOGNAME': 'cltbld', 07:16:32 INFO - 'MAIL': '/var/mail/cltbld', 07:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:32 INFO - 'MOZ_NO_REMOTE': '1', 07:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:32 INFO - 'NO_EM_RESTART': '1', 07:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:32 INFO - 'PWD': '/builds/slave/test', 07:16:32 INFO - 'SHELL': '/bin/bash', 07:16:32 INFO - 'SHLVL': '1', 07:16:32 INFO - 'TERM': 'linux', 07:16:32 INFO - 'TMOUT': '86400', 07:16:32 INFO - 'USER': 'cltbld', 07:16:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', 07:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:32 INFO - '_': '/tools/buildbot/bin/python'} 07:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:16:32 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 07:16:32 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 07:16:32 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 07:16:32 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 07:16:32 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 07:16:32 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 07:16:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:16:34 INFO - Installing collected packages: mozsystemmonitor 07:16:34 INFO - Running setup.py install for mozsystemmonitor 07:16:34 INFO - Successfully installed mozsystemmonitor 07:16:34 INFO - Cleaning up... 07:16:34 INFO - Return code: 0 07:16:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2997180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29953b0>, '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 0x29962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', '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 07:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:16:34 INFO - Using env: {'DISPLAY': ':0', 07:16:34 INFO - 'HOME': '/home/cltbld', 07:16:34 INFO - 'LANG': 'en_US.UTF-8', 07:16:34 INFO - 'LANGUAGE': 'en_US:en', 07:16:34 INFO - 'LOGNAME': 'cltbld', 07:16:34 INFO - 'MAIL': '/var/mail/cltbld', 07:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:34 INFO - 'MOZ_NO_REMOTE': '1', 07:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:34 INFO - 'NO_EM_RESTART': '1', 07:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:34 INFO - 'PWD': '/builds/slave/test', 07:16:34 INFO - 'SHELL': '/bin/bash', 07:16:34 INFO - 'SHLVL': '1', 07:16:34 INFO - 'TERM': 'linux', 07:16:34 INFO - 'TMOUT': '86400', 07:16:34 INFO - 'USER': 'cltbld', 07:16:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', 07:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:34 INFO - '_': '/tools/buildbot/bin/python'} 07:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:34 INFO - Downloading/unpacking jsonschema==2.5.1 07:16:34 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 07:16:34 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 07:16:34 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 07:16:34 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 07:16:34 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 07:16:34 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 07:16:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:16:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:16:36 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 07:16:36 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 07:16:36 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 07:16:36 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 07:16:36 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 07:16:36 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 07:16:36 INFO - Downloading functools32-3.2.3-2.tar.gz 07:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:16:36 INFO - warning: no files found matching '*.txt' 07:16:36 INFO - no previously-included directories found matching 'build' 07:16:36 INFO - no previously-included directories found matching 'dist' 07:16:36 INFO - no previously-included directories found matching '.git*' 07:16:36 INFO - Installing collected packages: jsonschema, functools32 07:16:37 INFO - Running setup.py install for functools32 07:16:37 INFO - warning: no files found matching '*.txt' 07:16:37 INFO - no previously-included directories found matching 'build' 07:16:37 INFO - no previously-included directories found matching 'dist' 07:16:37 INFO - no previously-included directories found matching '.git*' 07:16:37 INFO - Successfully installed jsonschema functools32 07:16:37 INFO - Cleaning up... 07:16:37 INFO - Return code: 0 07:16:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:16:37 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')]} 07:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:37 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')]} 07:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:37 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 0x26d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2997180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29953b0>, '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 0x29962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', '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 07:16:37 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 07:16:37 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 07:16:37 INFO - Using env: {'DISPLAY': ':0', 07:16:37 INFO - 'HOME': '/home/cltbld', 07:16:37 INFO - 'LANG': 'en_US.UTF-8', 07:16:37 INFO - 'LANGUAGE': 'en_US:en', 07:16:37 INFO - 'LOGNAME': 'cltbld', 07:16:37 INFO - 'MAIL': '/var/mail/cltbld', 07:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:37 INFO - 'MOZ_NO_REMOTE': '1', 07:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:37 INFO - 'NO_EM_RESTART': '1', 07:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:37 INFO - 'PWD': '/builds/slave/test', 07:16:37 INFO - 'SHELL': '/bin/bash', 07:16:37 INFO - 'SHLVL': '1', 07:16:37 INFO - 'TERM': 'linux', 07:16:37 INFO - 'TMOUT': '86400', 07:16:37 INFO - 'USER': 'cltbld', 07:16:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', 07:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:37 INFO - '_': '/tools/buildbot/bin/python'} 07:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:16:37 INFO - Cleaning up... 07:16:37 INFO - Return code: 0 07:16:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:16:37 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')]} 07:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:37 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')]} 07:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:37 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 0x26d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2997180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29953b0>, '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 0x29962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', '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 07:16:37 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 07:16:37 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 07:16:37 INFO - Using env: {'DISPLAY': ':0', 07:16:37 INFO - 'HOME': '/home/cltbld', 07:16:37 INFO - 'LANG': 'en_US.UTF-8', 07:16:37 INFO - 'LANGUAGE': 'en_US:en', 07:16:37 INFO - 'LOGNAME': 'cltbld', 07:16:37 INFO - 'MAIL': '/var/mail/cltbld', 07:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:37 INFO - 'MOZ_NO_REMOTE': '1', 07:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:37 INFO - 'NO_EM_RESTART': '1', 07:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:37 INFO - 'PWD': '/builds/slave/test', 07:16:37 INFO - 'SHELL': '/bin/bash', 07:16:37 INFO - 'SHLVL': '1', 07:16:37 INFO - 'TERM': 'linux', 07:16:37 INFO - 'TMOUT': '86400', 07:16:37 INFO - 'USER': 'cltbld', 07:16:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', 07:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:37 INFO - '_': '/tools/buildbot/bin/python'} 07:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:37 INFO - Downloading/unpacking blobuploader==1.2.4 07:16:37 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 07:16:37 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 07:16:37 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 07:16:37 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 07:16:37 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 07:16:37 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 07:16:39 INFO - Downloading blobuploader-1.2.4.tar.gz 07:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:16:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:16:39 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 07:16:39 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 07:16:39 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 07:16:39 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 07:16:39 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 07:16:39 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 07:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:16:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:40 INFO - Downloading docopt-0.6.1.tar.gz 07:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:16:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:16:40 INFO - Running setup.py install for blobuploader 07:16:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:16:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:16:40 INFO - Running setup.py install for requests 07:16:40 INFO - Running setup.py install for docopt 07:16:40 INFO - Successfully installed blobuploader requests docopt 07:16:40 INFO - Cleaning up... 07:16:40 INFO - Return code: 0 07:16:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:40 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 0x26d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2997180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29953b0>, '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 0x29962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', '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 07:16:40 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 07:16:40 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 07:16:40 INFO - Using env: {'DISPLAY': ':0', 07:16:40 INFO - 'HOME': '/home/cltbld', 07:16:40 INFO - 'LANG': 'en_US.UTF-8', 07:16:40 INFO - 'LANGUAGE': 'en_US:en', 07:16:40 INFO - 'LOGNAME': 'cltbld', 07:16:40 INFO - 'MAIL': '/var/mail/cltbld', 07:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:40 INFO - 'MOZ_NO_REMOTE': '1', 07:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:40 INFO - 'NO_EM_RESTART': '1', 07:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:40 INFO - 'PWD': '/builds/slave/test', 07:16:40 INFO - 'SHELL': '/bin/bash', 07:16:40 INFO - 'SHLVL': '1', 07:16:40 INFO - 'TERM': 'linux', 07:16:40 INFO - 'TMOUT': '86400', 07:16:40 INFO - 'USER': 'cltbld', 07:16:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', 07:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:40 INFO - '_': '/tools/buildbot/bin/python'} 07:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:41 INFO - Running setup.py (path:/tmp/pip-Wcd9j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:41 INFO - Running setup.py (path:/tmp/pip-nTf_eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:41 INFO - Running setup.py (path:/tmp/pip-YgiE0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:41 INFO - Running setup.py (path:/tmp/pip-ThqQGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:41 INFO - Running setup.py (path:/tmp/pip-T9vxiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:41 INFO - Running setup.py (path:/tmp/pip-tSn3KC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:41 INFO - Running setup.py (path:/tmp/pip-pxd7B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:41 INFO - Running setup.py (path:/tmp/pip-hTc3Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:41 INFO - Running setup.py (path:/tmp/pip-9bfSMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:41 INFO - Running setup.py (path:/tmp/pip-J7J40z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:41 INFO - Running setup.py (path:/tmp/pip-_BGTRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:41 INFO - Running setup.py (path:/tmp/pip-gy1qmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:42 INFO - Running setup.py (path:/tmp/pip-S3tw5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:42 INFO - Running setup.py (path:/tmp/pip-pGWpsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:42 INFO - Running setup.py (path:/tmp/pip-GZMmx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:42 INFO - Running setup.py (path:/tmp/pip-_xcZce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:42 INFO - Running setup.py (path:/tmp/pip-XRBxNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:16:42 INFO - Running setup.py install for manifestparser 07:16:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:16:42 INFO - Running setup.py install for mozcrash 07:16:42 INFO - Running setup.py install for mozdebug 07:16:42 INFO - Running setup.py install for mozdevice 07:16:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:16:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:16:42 INFO - Running setup.py install for mozfile 07:16:42 INFO - Running setup.py install for mozhttpd 07:16:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:16:42 INFO - Running setup.py install for mozinfo 07:16:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Running setup.py install for mozInstall 07:16:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Running setup.py install for mozleak 07:16:43 INFO - Running setup.py install for mozlog 07:16:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Running setup.py install for moznetwork 07:16:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Running setup.py install for mozprocess 07:16:43 INFO - Running setup.py install for mozprofile 07:16:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Running setup.py install for mozrunner 07:16:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Running setup.py install for mozscreenshot 07:16:43 INFO - Running setup.py install for moztest 07:16:44 INFO - Running setup.py install for mozversion 07:16:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:16:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:16:44 INFO - Cleaning up... 07:16:44 INFO - Return code: 0 07:16:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:44 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')]} 07:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:44 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')]} 07:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:44 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 0x26d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2997180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29953b0>, '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 0x29962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', '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 07:16:44 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 07:16:44 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 07:16:44 INFO - Using env: {'DISPLAY': ':0', 07:16:44 INFO - 'HOME': '/home/cltbld', 07:16:44 INFO - 'LANG': 'en_US.UTF-8', 07:16:44 INFO - 'LANGUAGE': 'en_US:en', 07:16:44 INFO - 'LOGNAME': 'cltbld', 07:16:44 INFO - 'MAIL': '/var/mail/cltbld', 07:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:44 INFO - 'MOZ_NO_REMOTE': '1', 07:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:44 INFO - 'NO_EM_RESTART': '1', 07:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:44 INFO - 'PWD': '/builds/slave/test', 07:16:44 INFO - 'SHELL': '/bin/bash', 07:16:44 INFO - 'SHLVL': '1', 07:16:44 INFO - 'TERM': 'linux', 07:16:44 INFO - 'TMOUT': '86400', 07:16:44 INFO - 'USER': 'cltbld', 07:16:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', 07:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:44 INFO - '_': '/tools/buildbot/bin/python'} 07:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:44 INFO - Running setup.py (path:/tmp/pip-XNUfQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:44 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)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:44 INFO - Running setup.py (path:/tmp/pip-gpaAhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:44 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)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:44 INFO - Running setup.py (path:/tmp/pip-UrIH8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:44 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)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:44 INFO - Running setup.py (path:/tmp/pip-AXBXLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:44 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)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:44 INFO - Running setup.py (path:/tmp/pip-A3owXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:44 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)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:44 INFO - Running setup.py (path:/tmp/pip-ne_nHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:44 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)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:44 INFO - Running setup.py (path:/tmp/pip-69WPNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:44 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)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:44 INFO - Running setup.py (path:/tmp/pip-RhVOOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:44 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)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:44 INFO - Running setup.py (path:/tmp/pip-W3C1N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:45 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)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:45 INFO - Running setup.py (path:/tmp/pip-4jFM8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:45 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)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:45 INFO - Running setup.py (path:/tmp/pip-jUt2kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:45 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)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:45 INFO - Running setup.py (path:/tmp/pip-N6m6GY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:45 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)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:45 INFO - Running setup.py (path:/tmp/pip-UakWxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:45 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)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:45 INFO - Running setup.py (path:/tmp/pip-tNJDv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:45 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)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:45 INFO - Running setup.py (path:/tmp/pip-hRPSVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:45 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)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:45 INFO - Running setup.py (path:/tmp/pip-GQGi5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:45 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)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:45 INFO - Running setup.py (path:/tmp/pip-XFQaRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:45 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)) 07:16:45 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)) 07:16:45 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)) 07:16:45 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)) 07:16:45 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)) 07:16:45 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)) 07:16:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:47 INFO - Downloading blessings-1.6.tar.gz 07:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:16:47 INFO - Installing collected packages: blessings 07:16:47 INFO - Running setup.py install for blessings 07:16:47 INFO - Successfully installed blessings 07:16:47 INFO - Cleaning up... 07:16:47 INFO - Return code: 0 07:16:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:16:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:47 INFO - Reading from file tmpfile_stdout 07:16:47 INFO - Current package versions: 07:16:47 INFO - argparse == 1.2.1 07:16:47 INFO - blessings == 1.6 07:16:47 INFO - blobuploader == 1.2.4 07:16:47 INFO - docopt == 0.6.1 07:16:47 INFO - functools32 == 3.2.3-2 07:16:47 INFO - jsonschema == 2.5.1 07:16:47 INFO - manifestparser == 1.1 07:16:47 INFO - mozInstall == 1.12 07:16:47 INFO - mozcrash == 0.17 07:16:47 INFO - mozdebug == 0.1 07:16:47 INFO - mozdevice == 0.48 07:16:47 INFO - mozfile == 1.2 07:16:47 INFO - mozhttpd == 0.7 07:16:47 INFO - mozinfo == 0.9 07:16:47 INFO - mozleak == 0.1 07:16:47 INFO - mozlog == 3.3 07:16:47 INFO - moznetwork == 0.27 07:16:47 INFO - mozprocess == 0.23 07:16:47 INFO - mozprofile == 0.28 07:16:47 INFO - mozrunner == 6.12 07:16:47 INFO - mozscreenshot == 0.1 07:16:47 INFO - mozsystemmonitor == 0.3 07:16:47 INFO - moztest == 0.7 07:16:47 INFO - mozversion == 1.4 07:16:47 INFO - psutil == 3.1.1 07:16:47 INFO - requests == 1.2.3 07:16:47 INFO - wsgiref == 0.1.2 07:16:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:47 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 0x26d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2997180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29953b0>, '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 0x29962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', '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 07:16:47 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 07:16:47 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 07:16:47 INFO - Using env: {'DISPLAY': ':0', 07:16:47 INFO - 'HOME': '/home/cltbld', 07:16:47 INFO - 'LANG': 'en_US.UTF-8', 07:16:47 INFO - 'LANGUAGE': 'en_US:en', 07:16:47 INFO - 'LOGNAME': 'cltbld', 07:16:47 INFO - 'MAIL': '/var/mail/cltbld', 07:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:47 INFO - 'MOZ_NO_REMOTE': '1', 07:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:47 INFO - 'NO_EM_RESTART': '1', 07:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:47 INFO - 'PWD': '/builds/slave/test', 07:16:47 INFO - 'SHELL': '/bin/bash', 07:16:47 INFO - 'SHLVL': '1', 07:16:47 INFO - 'TERM': 'linux', 07:16:47 INFO - 'TMOUT': '86400', 07:16:47 INFO - 'USER': 'cltbld', 07:16:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', 07:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:47 INFO - '_': '/tools/buildbot/bin/python'} 07:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:48 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)) 07:16:48 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)) 07:16:48 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)) 07:16:48 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)) 07:16:48 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)) 07:16:48 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)) 07:16:48 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)) 07:16:48 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)) 07:16:48 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)) 07:16:48 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)) 07:16:48 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)) 07:16:48 INFO - Cleaning up... 07:16:48 INFO - Return code: 0 07:16:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2997180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29953b0>, '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 0x29962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', '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 07:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:16:48 INFO - Using env: {'DISPLAY': ':0', 07:16:48 INFO - 'HOME': '/home/cltbld', 07:16:48 INFO - 'LANG': 'en_US.UTF-8', 07:16:48 INFO - 'LANGUAGE': 'en_US:en', 07:16:48 INFO - 'LOGNAME': 'cltbld', 07:16:48 INFO - 'MAIL': '/var/mail/cltbld', 07:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:48 INFO - 'MOZ_NO_REMOTE': '1', 07:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:48 INFO - 'NO_EM_RESTART': '1', 07:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:48 INFO - 'PWD': '/builds/slave/test', 07:16:48 INFO - 'SHELL': '/bin/bash', 07:16:48 INFO - 'SHLVL': '1', 07:16:48 INFO - 'TERM': 'linux', 07:16:48 INFO - 'TMOUT': '86400', 07:16:48 INFO - 'USER': 'cltbld', 07:16:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', 07:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:48 INFO - '_': '/tools/buildbot/bin/python'} 07:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:16:48 INFO - Cleaning up... 07:16:48 INFO - Return code: 0 07:16:48 INFO - Running post-action listener: _resource_record_post_action 07:16:48 INFO - Running post-action listener: _start_resource_monitoring 07:16:48 INFO - Starting resource monitoring. 07:16:48 INFO - [mozharness: 2016-07-26 14:16:48.487301Z] Finished create-virtualenv step (success) 07:16:48 INFO - [mozharness: 2016-07-26 14:16:48.487866Z] Running install step. 07:16:48 INFO - Running pre-action listener: _resource_record_pre_action 07:16:48 INFO - Running main action method: install 07:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:48 INFO - Reading from file tmpfile_stdout 07:16:48 INFO - Detecting whether we're running mozinstall >=1.0... 07:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:16:48 INFO - Reading from file tmpfile_stdout 07:16:48 INFO - Output received: 07:16:48 INFO - Usage: mozinstall [options] installer 07:16:48 INFO - Options: 07:16:48 INFO - -h, --help show this help message and exit 07:16:48 INFO - -d DEST, --destination=DEST 07:16:48 INFO - Directory to install application into. [default: 07:16:48 INFO - "/builds/slave/test"] 07:16:48 INFO - --app=APP Application being installed. [default: firefox] 07:16:48 INFO - mkdir: /builds/slave/test/build/application 07:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:17:06 INFO - Reading from file tmpfile_stdout 07:17:06 INFO - Output received: 07:17:06 INFO - /builds/slave/test/build/application/firefox/firefox 07:17:06 INFO - Running post-action listener: _resource_record_post_action 07:17:06 INFO - [mozharness: 2016-07-26 14:17:06.048623Z] Finished install step (success) 07:17:06 INFO - [mozharness: 2016-07-26 14:17:06.048967Z] Running run-tests step. 07:17:06 INFO - Running pre-action listener: _resource_record_pre_action 07:17:06 INFO - Running main action method: run_tests 07:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:17:06 INFO - Python 2.7.3 07:17:06 INFO - Return code: 0 07:17:06 INFO - grabbing minidump binary from tooltool 07:17: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')]} 07:17:06 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 0x29953b0>, '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 0x29962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:17:06 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 07:17:06 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 07:17:06 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 07:17:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:17:06 INFO - Return code: 0 07:17:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:17:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:17:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:17:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:17:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:17:06 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/1469530440/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 07:17:06 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/1469530440/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 07:17:06 INFO - Using env: {'DISPLAY': ':0', 07:17:06 INFO - 'HOME': '/home/cltbld', 07:17:06 INFO - 'LANG': 'en_US.UTF-8', 07:17:06 INFO - 'LANGUAGE': 'en_US:en', 07:17:06 INFO - 'LOGNAME': 'cltbld', 07:17:06 INFO - 'MAIL': '/var/mail/cltbld', 07:17:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:17:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:06 INFO - 'MOZ_NO_REMOTE': '1', 07:17:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:06 INFO - 'NO_EM_RESTART': '1', 07:17:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:06 INFO - 'PWD': '/builds/slave/test', 07:17:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:17:06 INFO - 'SHELL': '/bin/bash', 07:17:06 INFO - 'SHLVL': '1', 07:17:06 INFO - 'TERM': 'linux', 07:17:06 INFO - 'TMOUT': '86400', 07:17:06 INFO - 'USER': 'cltbld', 07:17:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469', 07:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:06 INFO - '_': '/tools/buildbot/bin/python'} 07:17:06 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/1469530440/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 07:17:06 INFO - mozversion application_buildid: 20160726035400 07:17:06 INFO - mozversion application_changeset: 39ebdb2e59f25fecf13f2ca39ea74c3e73127a56 07:17:06 INFO - mozversion application_display_name: Nightly 07:17:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:17:06 INFO - mozversion application_name: Firefox 07:17:06 INFO - mozversion application_remotingname: firefox 07:17:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:17:06 INFO - mozversion application_vendor: Mozilla 07:17:06 INFO - mozversion application_version: 50.0a1 07:17:06 INFO - mozversion platform_buildid: 20160726035400 07:17:06 INFO - mozversion platform_changeset: 39ebdb2e59f25fecf13f2ca39ea74c3e73127a56 07:17:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:17:06 INFO - mozversion platform_version: 50.0a1 07:17:06 INFO - using testdate: 1469542626 07:17:06 INFO - actual date: 1469542626 07:17:06 INFO - starting webserver on 'localhost:55084' 07:17:06 INFO - SUITE-START | Running 2 tests 07:17:06 INFO - TEST-START | dromaeo_css 07:17:06 INFO - operating with platform_type : linux_ 07:17:06 INFO - Initialising browser for dromaeo_css test... 07:17:06 INFO - TEST-INFO | started process 5133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqjw_Bt/profile http://localhost:55084/getInfo.html) 07:17:09 INFO - PROCESS | 5133 | JavaScript error: , line 0: uncaught exception: undefined 07:17:10 INFO - PROCESS | 5133 | __metrics Screen width/height:1600/1200 07:17:10 INFO - PROCESS | 5133 | colorDepth:24 07:17:10 INFO - PROCESS | 5133 | Browser inner width/height: 1024/697 07:17:10 INFO - PROCESS | 5133 | __metrics 07:17:11 ERROR - PROCESS | 5133 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:17:12 INFO - TEST-INFO | 5133: exit 0 07:17:12 INFO - Browser initialized. 07:17:12 INFO - Running cycle 1/1 for dromaeo_css test... 07:17:12 INFO - TEST-INFO | started process 5252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqjw_Bt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:24 INFO - PROCESS | 5252 | RSS: Main: 165142528 07:17:24 INFO - PROCESS | 5252 | 07:18:13 INFO - PROCESS | 5252 | 1469542693929 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] 07:20:21 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:55084/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55084/tests/dromaeo/cssquery-ext.html) 07:20:23 INFO - PROCESS | 5252 | RSS: Main: 170233856 07:20:23 INFO - PROCESS | 5252 | 07:23:25 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:55084/tests/dromaeo/cssquery-ext.html (next: http://localhost:55084/tests/dromaeo/cssquery-jquery.html) 07:23:26 INFO - PROCESS | 5252 | RSS: Main: 166047744 07:23:26 INFO - PROCESS | 5252 | 07:26:27 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:55084/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55084/tests/dromaeo/cssquery-mootools.html) 07:26:28 INFO - PROCESS | 5252 | RSS: Main: 170823680 07:26:28 INFO - PROCESS | 5252 | 07:29:30 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:55084/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55084/tests/dromaeo/cssquery-prototype.html) 07:29:30 INFO - PROCESS | 5252 | RSS: Main: 165765120 07:29:30 INFO - PROCESS | 5252 | 07:32:33 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:55084/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55084/tests/dromaeo/cssquery-yui.html) 07:32:34 INFO - PROCESS | 5252 | RSS: Main: 167272448 07:32:34 INFO - PROCESS | 5252 | 07:35:37 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:55084/tests/dromaeo/cssquery-yui.html (next: http://localhost:55084/tests/dromaeo/cssquery-dojo.html) 07:35:37 INFO - PROCESS | 5252 | RSS: Main: 171188224 07:35:37 INFO - PROCESS | 5252 | 07:35:37 INFO - PROCESS | 5252 | __start_tp_report 07:35:37 INFO - PROCESS | 5252 | _x_x_mozilla_page_load 07:35:37 INFO - PROCESS | 5252 | _x_x_mozilla_page_load_details 07:35:37 INFO - PROCESS | 5252 | |i|pagename|runs| 07:35:37 INFO - PROCESS | 5252 | |0;dojo.html;3081.8150910945337;3097.969020309796;3120.687931206878;3124.328269422074;3128.5776420183283;5376.946230537694;5378.0857254266775;5427.2673189119505;5446.673199608026;5457.918131228034;5355.571554275658;5357.1696387060065;5395.21769343445;5414.566834653228;5419.756110975006;4834.951650483503;4937.5556199942;4970.353853998975;4983.9252411213865;4993.675411098285;4972.129877271463;5024.849254522352;5070.366204224472;5074.137396642561;5102.591792656579;4850.029994001196;4883.877903052435;4901.411830580318;4928.482509336504;5033.270175824485;4927.605791536668;4936.136176169156;4968.900621987576;4968.975155124202;4994.675346102492;4902.4362198346935;4909.263610458424;4914.975425122851;4923.040007198598;4971.577415919651;5256.474352564713;5286.60350473716;5327.706976116312;5398.271233383522;5483.972580137113;5751.539876809845;5773.162891380726;5788.565857560699;5790.507806836424;5790.7104644768015;5809.854753631151;5826;5832.6792026438525;5839.299284085937;5851.970740146315;5264.236685680593;5275.472452754694;5292.44429334922;5301.390340110898;5385.299911011622;5823.2429784128635;5826.82519524415;5827.504662103769;5829.795957141565;5870.853228669232;5668;5678.346990096192;5683.460071293303;5686.175504551817;5696.3733989261145;5577.2191893135;5718.370979192286;5778;5781.913271300934;5881.911771323348;5601.579881508903;5609.9902017636405;5639.238702775073;5697.772089116472;5702.7433765480655;5655.0386434306265;5727.627704199213;5731.369549349568;5745.1382292656435;5759.65442073477;4365;4420.535843736361;4434.268345722984;4441.933370999438;4449.176902273025;3979.2240513100246;3992.6007399259843;3999.1002024544246;4024.63778259958;4028.536718277377;5538.889222215533;5638.718064096779;5668;5671.2060311556415;5680.062789639664;5585.273914391184;5739.741711622987;5759.971200143972;5889.322727886262;5901.144334071536;5531.751071201806;5541.9168712469345;5625.578081643893;5647.068233741386;5661.2923384576925;4979.103761322925;4982.327385802942;4986.551210391082;5065.898682026339;5092.541671249605;5806.738696758656;5922.3485416604135;5978.701064946736;6042.305134909454;6058.727357268934;5781.335146458211;5781.364049954585;5785.595008349375;5813.12803079533;5829.650220986754;5931.110333450017;5963.642181469126;5968.074948383008;5976.701164941823;5988.610740301867;5496.725163741717;5643.746031428677;5685.744141513559;5691.117876729114;5694.1458781183155;5782.624129431573;5812.534997200299;5814.215080964185;5817.621854579608;5868.589198756046;5624.803131890364;5639.7180140993605;5645.661260324229;5659.6887171204335;5660.349059858169;5448.210009548672;5559.555235581063;5620.3536593290655;5621.887562248814;5682.801101961411;5610.410906854885;5631.183478395692;5648.378678345297;5671.234383358194;5684.9431505684415;5681.0626246668835;5698.8290351289525;5726.914096288642;5753.683547404933;5755.1367294906095;5450.563954883679;5529.861753456195;5556.444355564411;5565.1374037024325;5636.239107720569 07:35:37 INFO - PROCESS | 5252 | |1;ext.html;569.2883895131087;585.6925114314984;595.7855172138031;599.1551911804356;600.5765935015814;42005.36991945123;44108.33837492436;44145.77927110364;47928.76035619817;47956.280655790106;45705.31442028372;46116.07767844641;46161.30758038632;46400.76799615997;46414.767926160406;8970.82058358834;9113.95443022784;9117.954410227972;9123.589438475285;9142.085791420872;8878.200961913426;8909.95545022274;8971.506567138806;9015.95492022539;9026.638934442615;8741.694040708577;8773.16654917785;8812.867806982867;8825.073367296438;8831.646734130627;9026;9035.548222588877;9044.186023257938;9062;9063.229625481841;8923.286137109015;8939.553022348922;8989.730308090768;8998;9000.144986226298;42540;42802;43003;43063.78468107671;43161.568384316066;3569.5716514018222;3689.7417180797356;3727.1986522897705;3815.294170578452;4068.3126302750547;33260.667393325995;33650.49524257138;34238.31523369544;34584;34855.1286217844;4407.471103467605;4449.510553839075;4487.6634252431195;4612.1698094343;4635.976820115911;248684;248741;249561;251202;252576;56380;56800.71599642058;56917.43082569121;57072;57123.71438142866;36764.264714705554;37708.2458350837;58533;59036;59131.70434147802;16537.83462165363;16672.33310667584;16672.49982500527;16714.4149954751;16722.24749886258;12231.510739570318;12323.75352492945;12326.198797078161;12367;12384.708828866509;18114.81885181158;18158.5460363492;18478;18531.814681853008;18637.695361324848;6802.3537763912345;6971.930280697128;7191.424686025105;7263.201047884729;7419.146798118178;911.876896618948;1008.7931973945324;1056.57736905237;1152.6369193703956;1177.2465622001926;31905.8404707975;32474.83762581172;32714.345713085604;32980.83509582437;33034.504482432785;1125.5891599566264;1131.8472006279046;1136.323887287063;1146.5012719467059;1183.5325046606542;16824.831751682326;17083.40208092711;17122.40071597513;17182.74225886613;17242.482725518254;149990.25004875124;150506;150546.24726876296;151033;151325;57577;57595;58182.7090864543;58189.4181058184;58308.7084564583;1325.2975922760759;1377.80710700502;1379.4895888521312;1391.373881753215;1400.1109295597166;30052.398952021274;31139.221519462193;31631.683683162875;31945.201369965936;32318.83840580782;49420.258696118864;49454;49733.254001189285;49835.25247121223;50011;361028;361043;361043;362966;363724;27752.167434976982;27793.16620501388;27892;28168.29579260535;28232.717672823008;47133.29300060433;47416.7629161852;47625;48903.75548122237;48936;40019.780120978234;42096.15807683768;42445.78777106095;42735.572644274405;42803.785981069894;40210.597894021856;43846.12307753891;44699.77650111729;45024.77487612541;45027.77486112549;34798.65201347954;39077;39544.40683389694;41148.38277425901;41346.58653413548;35671.82164089163;37725.81137094297;38101.142414318485;38258.234835303694;38610.227795444494;27728.44543109167;28134.71865281321;28278.15165545037;28422.289442764097;28809.56785648175 07:35:37 INFO - PROCESS | 5252 | |2;jquery.html;389.7973054011914;390.48651023903585;405.07238424009023;410.4049128763293;425.5893063194017;18356.449306520793;19509.414717558495;20101.698474522876;20255.59488810223;20618.48453788656;19064.523386915334;19346.67839859219;19662.80337196631;19692.70460943087;19821.900890495563;5582.078956972095;5716.114002329646;5719.857003574903;5734.655920644775;5769.942300577003;5562.3047119110115;5658.858528536778;5702.486776190142;5717.885642287151;5724.7137643117885;5532.474414930595;5622.465865742748;5642.379338272786;5672.34768001681;5698.059820129694;5614.242077319551;5652.74562644682;5659.717014149276;5660.801871934504;5668.68822214778;4873.8781530461665;5070.188769796815;5077.365329333833;5087.211482220262;5111.437741848394;23117.190898318648;23219;23306.533869322688;23539.29382118539;23544.29367118989;2347.354477518679;2376.465295308542;2473;2555.09294200558;2596.7143614202423;7283.4537409694485;14247.572572822832;14416.783748243784;14558.199299038548;14815.851841481555;1894.393793985925;2005.2881227164291;2011.3664195778283;2020.6867935470025;2070.4823794051485;80784.59607701923;81406;82466.9999999994;82609;84264.57867710684;10489;10573.788524229472;10616.522256498476;10642.946785266024;11026.558937642405;15150.848491515164;15163.772543411858;15177.62055948588;15195.924020379827;15213.391464341525;7378.55357700724;7781.922180778233;7935.127136015034;7969.840603187904;8245.093039765621;7578.621068946531;7626.161122276545;7841.176676449005;7921.722739704082;7943.801404964806;6439.291677915426;6443.259025212067;6524.608523488606;6535.444487218545;6625.834354141089;1924.499630096185;1985.2702534015727;1988.1152886965451;1996.5407956170163;2009.7387339645752;953.5137080089204;975.4439969217478;991.1872264742842;1019.7654539455966;1076.8815430302661;19942.20231190736;20391.592168156552;20512.282070127472;20569.89715051445;20673.586528269352;966.0822218892081;1003.3779056984716;1004.1565085328359;1017.5573625472795;1025.3954954415701;11045.39250341239;11655.650330490098;11745.29528228309;11788.882111178778;11850.703732406759;475971;482908;494493;494499;495660;78347;80031;80902;93321.0667893326;97920.51039744755;1021.2697920986382;1037.419045334615;1067.2475904487317;1070.6359837655234;1073.5437439088357;17412.73880891813;17994.730079049088;18279.725804112684;18602.44192674222;18930.242790288787;36986.63013369939;43632.12735745331;43691.56308436875;44449.77775111104;44652.55347446484;57761.13358299713;62122.689386552775;62173.689131554056;62774.37225627685;64948;7513.887291690519;7970.721024764105;8063.6774529018185;8444.619992100248;8777.91222087771;10038.447885366375;13092.345382730635;13301.135426197266;13656.04407691452;13827.930860345634;11128.499217535393;11168.385738784445;11370.602028928948;11717.296962182296;12392.256464612152;11085.334879907232;11414.48634811452;11511;11513.251638643796;11780.234284771463;11057.5024123913;11788;12202.877971220174;12391.75216495647;12579.433925473193;7319.597422141834;7783.326584784299;7804.648790804541;8086.959565202136;8101.594920253846;7766.883496747666;10587.20595955291;11146.164037697043;11676.182667213214;11826.467808948446 07:35:37 INFO - PROCESS | 5252 | |3;mootools.html;1498.213437945079;1531.724289627867;1668.5828542864283;1751.3957684598809;1804.9368272110478;7637.503562268449;8151.592420378987;8265.421420500568;8867.645294188233;8872.733817985463;8193.631286592103;8330.91669083309;8598.22615964563;8637.222649961503;8654.91345086549;2295.5523672883796;2362.5511152880986;2364.137089962169;2367.8579285242854;2370.7747763962484;2165.761766205716;2223.2663221136986;2247.6965609642652;2251.752307246202;2256.582532231534;2217.2350539064078;2263.0834512022575;2270.6594010898334;2272.988635056831;2273.6362182050875;2240.395093324801;2240.4622890506243;2246.1801442473543;2248.15694114707;2252.425631463966;2203.834712396577;2219.5006123622215;2222.2444368914485;2227.086894373299;2233.274185889576;8649.913500865037;8744.038155802857;8774.73675789721;8781;8784.824303513959;5076.64463487556;5166.147585648364;5171.534561889448;5172.094883395391;5193.63644544882;3315.651856555051;3350.731941444679;3499.772514786531;3530.5763308402898;3546.4680297955515;1223.7124275795181;1229.9644089032665;1231.6305108467425;1234.703671118934;1236.765014647223;11774.587889423914;11983.101267404892;11987.700307492383;12006.63980080599;12009.399530023551;4299.140171965557;4413.514513403523;4566.406367172246;4568.291914753218;4608.354830323758;10096.34373765703;10166.745831354276;10187.115383654047;10193.337433066827;10204.948975255225;5208.713520756395;5209.843704688866;5211.71335576547;5214.97392513035;5221.216817477332;4170.103427762985;4549.203889319356;4666.300054991711;4690.953090469052;4701.976490117596;3904.882853514399;4020.6180412861318;4027.375756757707;4082.2856000199845;4099.815508302134;1229.7294595189044;1239.0830785219052;1256.8051951947464;1261.6215135459327;1266.9873301267053;903.9819203615891;1000.2048371544639;1014.5535964175887;1028.2493779540828;1043.473046111724;6041.879162416727;6049.1833602463985;6069.180660610849;6178.320384757673;6210.130581718563;431.85773628751775;433.252639197382;439.7471453914012;460.2750667698388;461.3610149942354;4202.390653355246;4262.65898728101;4299.849505267301;4314.676399270067;4435.068635586498;10211.438370889524;10574.788504230026;10611.57553697859;10628.309159904582;10646.201534884915;10375.584976600852;10512.421816799997;10545.209109316833;10550.683479495474;10561.471926403648;7614.961925190339;8013.078495972921;8076.313513351431;8113.472624279403;8157.428979971463;6092.086187071975;6155.47678447337;6233.345498722569;6304.558680892477;6332.556721029484;9844.606215751577;9902.356346837432;9912.355696879968;9946.602135914482;10022.198224141905;9772.560234789593;10090.041446062613;10114.241431892491;10165.745856353651;10182.541785619516;7033.683484243119;7478.962605186939;7624.199459056719;7758;7859.449838511249;8501.914980850359;8520.10538893432;8555.572221388782;8564;8587.828243434971;7532.209118042746;7578.583177925047;7689.769306920802;7736;7901.328387086932;7501.3998880088375;7547.660355284135;7585.431092668182;7605.087389513294;7776.572288524186;6971.372576468142;7058.364747172779;7077.5753454792875;7080.185778635523;7082.610456424946;5162.148245539444;5240.2663627093;5302.681839089667;5328.7602057906715;5476.863078423071;5162.122439185423;5225.372955245395;5266.104762190514;5316.548093411949;5504.53211477029 07:35:37 INFO - PROCESS | 5252 | |4;prototype.html;332.03435660887544;343.4350493438294;347.89910925831504;349.3850822552307;350.3413582464964;5387.4073851876265;5462.7268636568215;5512.5865560083;5623.690697011658;5629.60592758507;5493.253373313343;5506.394296627368;5524.232245681384;5529.474699903512;5557.499825015748;4305.720128191673;4333.934990975138;4349.760763158025;4368.366586844905;4393.648508119343;4073.348264277716;4209.137126888996;4302.440682711243;4316.395704601358;4359.193549193394;4221.092465119998;4239.660827133822;4247.787610619456;4258.254805409041;4261.829526818923;4250.064985703156;4267.829286828523;4272.594103560188;4287.8284868605215;4294.742315461082;3571.571411430619;3780.489633899416;3785.4889589905288;3791.2607041626893;3805.7906815125157;5332.226827110087;5340.519353258186;5362.865928351784;5399.946000539983;5412.242286079952;4896.755162241873;4907.631927605444;4922.581580565657;4935.950640493621;4959.958408734134;5468.699221542814;5737.454941780524;5751.194832723422;5775.834062226665;5791.681457519835;4116.5060192776755;4116.711830171889;4127.938080928789;4157.896052598679;4166.187593419285;6042.283995342877;6048.304444988795;6065.211522502091;6075.665838378887;6076.240469941257;4132.73137246078;4170.874873753793;4193.748375097504;4237.470316210473;4255.893602659959;4238.915221695549;4261.680373971964;4271.67962402821;4277.893052673708;4295.334223195409;4911.386076740408;4921.26181072842;4928.211486162269;4939.580135688435;4951.183054795991;5503.697296648643;5755.942440575541;5858.94141058584;5892.823215303548;5893.292804863444;1482.6589884326665;1487.5091219897408;1488.1517535004944;1491.395984626228;1493.760998240298;929.1312622697799;949.1694767078806;955.9330846840794;972.1736523954723;975.9609615615295;5040.31955685985;5042.571381432546;5049.520295571915;5068.265101560253;5101.479978814606;5162.173367901025;5260.526552610207;5294.602904782157;5297.920531192035;5374.892502149935;5109.2080727486555;5117.513836185556;5191.195364718475;5321.148616221463;5729.369769325371;3176.2059485128716;3191.3457741163006;3192.5530425740417;3194.6485886552928;3206.8075915445147;6094.969525152346;6221.96889015552;6242.375762423721;6260.686965651699;6290.968545157245;6004.189434426384;6008.789692360747;6053.243344581927;6071.483923866521;6112.174856394418;6177.938220617826;6191.4118158774845;6192.628442293477;6194.535409844189;6199.442050215503;5775;5848.678322692293;5850.444207800252;5887.1757953885635;5964.463198312173;5807.506361959281;5840.357560668408;5858.384869588632;5868.2664666916635;5874.736931559735;5898.233229680114;6110.555777688783;6149.754009839735;6173.629582225081;6179.443850053517;4098.979505102456;4194.853180138803;4214.220369231702;4234.957650423579;4281.614654681093;6016.939830601813;6029.246344206974;6031.306399763907;6050.636961782131;6070.939290607037;5628.352739435018;5809.8547536311935;5868.618539794899;5878.29460464747;5911.201987731602;5746.13807928814;5755.53955683536;5773.653580785166;5777.826665200051;5848.64908105498;5691.971540142273;5737.225474560881;5737.282839645044;5744.770209191753;5748.425157484218;5565.833025009256;5731.942680573307;5827.271591051119;5831.241938547962;5836.708164591669;5654.755953690182;5659.377468478547;5690.459406356389;5695.686737229492;5700.095434627294 07:35:37 INFO - PROCESS | 5252 | |5;yui.html;719.7301012120455;734.8273155808386;750.5121670913907;754.1967804288436;824.6000689665515;15238.542843714678;15503.224838758046;15511.767323490143;15535.223238838054;15544.145072021034;14862.777058344107;15017.924910375461;15037.849621503809;15076.396944122249;15083.698326033473;658.40743331002;795.9641816118274;802.6508468816055;828.8756686497013;830.6013113705425;825.9793505162359;827.7144385187131;827.93790465715;828.4780588229407;829.2371018662815;875.2429148786317;876.4215617692324;879.7932485865816;882.0429833630518;884.1865483754929;872.9519876406795;874.7157173918438;875.6147295190128;875.9693410730657;877.662100091463;644.0757512968904;644.3202421445374;644.8162273752005;644.8549076457759;645.1612903225788;15060.623484412868;15231.695366092727;15303.234838258153;15385.230738463031;15446.5366039019;14574.927125364306;14592.270386480634;14651.267436628232;14662;15046.473373431878;12530.812037819349;12559.748805023939;12614.306213158272;12670.619881403572;12678.239305641599;3975.582563830785;4146.232946904832;4168.791560421967;4200.327947528381;4203.201391735561;72717.27282727158;73423.26576734218;73852;74062.62968685121;74505;10785.83821242682;10829.83755243672;11143.944280278709;11248;11988.76022479563;20169;20275.391738247876;20403.28588499425;20666.689999650018;20752.169913203605;8151.18488151192;8195.34437245019;8235.8352832943;8378.49729016261;8545.615447304886;4804.519548045238;4875.098106850244;4884.242942343943;4910.091633047898;5109.693418394908;3268.2483028903484;3362.596488421405;3368.39368913593;3379.374815659111;3387.2209391840015;523.8023330439062;614.2690198663576;632.4687262699263;634.9111124442582;638.3488841381765;603.3333166850655;696.450397864757;701.1936273285762;708.7342246657504;717.8564287142592;9199.862002069975;9213.585388657526;9437.410129413622;9501.524923753785;9694.369865958832;611.8684482836212;662.9237637671633;667.4693618573245;680.4828330468879;722.4689852958072;4730.62155027597;4783.497732738082;4882.7558622068755;4922.360093187935;5015.097282489187;110920;112805.43597282126;112973.43513282381;113640.43179784049;116947.41526292314;84941.57529212438;87388;89510.55244723865;101851.99999999852;102198.48900755448;72718.72765725556;84596.57701711575;84768.15231847725;87336.56331718301;90195.54902225448;10047.598096076368;10243.795124097625;10417.270791044553;10490;10583.417912014913;50771.74614126905;50975.49024509708;51593.74203128961;52193;52372.47627523676;44363.33454998113;44379;58444.415555843894;73499.26500734924;73525.26474735184;12132.730583909242;13425.462981480632;13537.255450950292;13734.519291824738;13967.511137110152;14726.77909831332;15256.31346589384;15623.76564351513;15801.36794528206;16098.839011609734;13940.860591394361;14036.859631403964;14935.626609334853;14943.178125203218;15019.924900375428;12345.444454999368;12434.937825310815;12441.564545241235;12570;12687.746245074863;13495.25776082325;13946.651333716332;14063.718725625635;14101.365438555085;14171.433142674177;11207.383593902414;11425.028872545927;11676.357800321064;11875.465604047666;11972.341521216069;12092.395380230777;12139.150259481752;12186.817197742219;12217.328046957502;12299.323537205182 07:35:37 INFO - PROCESS | 5252 | __end_tp_report 07:35:37 INFO - PROCESS | 5252 | __start_cc_report 07:35:37 INFO - PROCESS | 5252 | _x_x_mozilla_cycle_collect,348 07:35:37 INFO - PROCESS | 5252 | __end_cc_report 07:35:37 INFO - PROCESS | 5252 | __startTimestamp1469543737358__endTimestamp 07:35:37 INFO - PROCESS | 5252 | 07:35:37 INFO - PROCESS | 5252 | ------- Summary: start ------- 07:35:37 INFO - PROCESS | 5252 | Number of tests: 6 07:35:37 INFO - PROCESS | 5252 | 07:35:37 INFO - PROCESS | 5252 | [#0] dojo.html Cycles:165 Average:5376.40 Median:5624.80 stddev:599.47 (10.7%) stddev-sans-first:573.65 07:35:37 INFO - PROCESS | 5252 | Values: 3081.8 3098.0 3120.7 3124.3 3128.6 5376.9 5378.1 5427.3 5446.7 5457.9 5355.6 5357.2 5395.2 5414.6 5419.8 4835.0 4937.6 4970.4 4983.9 4993.7 4972.1 5024.8 5070.4 5074.1 5102.6 4850.0 4883.9 4901.4 4928.5 5033.3 4927.6 4936.1 4968.9 4969.0 4994.7 4902.4 4909.3 4915.0 4923.0 4971.6 5256.5 5286.6 5327.7 5398.3 5484.0 5751.5 5773.2 5788.6 5790.5 5790.7 5809.9 5826.0 5832.7 5839.3 5852.0 5264.2 5275.5 5292.4 5301.4 5385.3 5823.2 5826.8 5827.5 5829.8 5870.9 5668.0 5678.3 5683.5 5686.2 5696.4 5577.2 5718.4 5778.0 5781.9 5881.9 5601.6 5610.0 5639.2 5697.8 5702.7 5655.0 5727.6 5731.4 5745.1 5759.7 4365.0 4420.5 4434.3 4441.9 4449.2 3979.2 3992.6 3999.1 4024.6 4028.5 5538.9 5638.7 5668.0 5671.2 5680.1 5585.3 5739.7 5760.0 5889.3 5901.1 5531.8 5541.9 5625.6 5647.1 5661.3 4979.1 4982.3 4986.6 5065.9 5092.5 5806.7 5922.3 5978.7 6042.3 6058.7 5781.3 5781.4 5785.6 5813.1 5829.7 5931.1 5963.6 5968.1 5976.7 5988.6 5496.7 5643.7 5685.7 5691.1 5694.1 5782.6 5812.5 5814.2 5817.6 5868.6 5624.8 5639.7 5645.7 5659.7 5660.3 5448.2 5559.6 5620.4 5621.9 5682.8 5610.4 5631.2 5648.4 5671.2 5684.9 5681.1 5698.8 5726.9 5753.7 5755.1 5450.6 5529.9 5556.4 5565.1 5636.2 07:35:37 INFO - PROCESS | 5252 | 07:35:37 INFO - PROCESS | 5252 | [#1] ext.html Cycles:180 Average:44606.07 Median:22608.35 stddev:70452.68 (311.6%) stddev-sans-first:70572.73 07:35:37 INFO - PROCESS | 5252 | Values: 569.3 585.7 595.8 599.2 600.6 42005.4 44108.3 44145.8 47928.8 47956.3 45705.3 46116.1 46161.3 46400.8 46414.8 8970.8 9114.0 9118.0 9123.6 9142.1 8878.2 8910.0 8971.5 9016.0 9026.6 8741.7 8773.2 8812.9 8825.1 8831.6 9026.0 9035.5 9044.2 9062.0 9063.2 8923.3 8939.6 8989.7 8998.0 9000.1 42540.0 42802.0 43003.0 43063.8 43161.6 3569.6 3689.7 3727.2 3815.3 4068.3 33260.7 33650.5 34238.3 34584.0 34855.1 4407.5 4449.5 4487.7 4612.2 4636.0 248684.0 248741.0 249561.0 251202.0 252576.0 56380.0 56800.7 56917.4 57072.0 57123.7 36764.3 37708.2 58533.0 59036.0 59131.7 16537.8 16672.3 16672.5 16714.4 16722.2 12231.5 12323.8 12326.2 12367.0 12384.7 18114.8 18158.5 18478.0 18531.8 18637.7 6802.4 6971.9 7191.4 7263.2 7419.1 911.9 1008.8 1056.6 1152.6 1177.2 31905.8 32474.8 32714.3 32980.8 33034.5 1125.6 1131.8 1136.3 1146.5 1183.5 16824.8 17083.4 17122.4 17182.7 17242.5 149990.3 150506.0 150546.2 151033.0 151325.0 57577.0 57595.0 58182.7 58189.4 58308.7 1325.3 1377.8 1379.5 1391.4 1400.1 30052.4 31139.2 31631.7 31945.2 32318.8 49420.3 49454.0 49733.3 49835.3 50011.0 361028.0 361043.0 361043.0 362966.0 363724.0 27752.2 27793.2 27892.0 28168.3 28232.7 47133.3 47416.8 47625.0 48903.8 48936.0 40019.8 42096.2 42445.8 42735.6 42803.8 40210.6 43846.1 44699.8 45024.8 45027.8 34798.7 39077.0 39544.4 41148.4 41346.6 35671.8 37725.8 38101.1 38258.2 38610.2 27728.4 28134.7 28278.2 28422.3 28809.6 07:35:37 INFO - PROCESS | 5252 | 07:35:37 INFO - PROCESS | 5252 | [#2] jquery.html Cycles:180 Average:29103.84 Median:2424.73 stddev:80537.50 (3321.5%) stddev-sans-first:80734.57 07:35:37 INFO - PROCESS | 5252 | Values: 389.8 390.5 405.1 410.4 425.6 18356.4 19509.4 20101.7 20255.6 20618.5 19064.5 19346.7 19662.8 19692.7 19821.9 5582.1 5716.1 5719.9 5734.7 5769.9 5562.3 5658.9 5702.5 5717.9 5724.7 5532.5 5622.5 5642.4 5672.3 5698.1 5614.2 5652.7 5659.7 5660.8 5668.7 4873.9 5070.2 5077.4 5087.2 5111.4 23117.2 23219.0 23306.5 23539.3 23544.3 2347.4 2376.5 2473.0 2555.1 2596.7 7283.5 14247.6 14416.8 14558.2 14815.9 1894.4 2005.3 2011.4 2020.7 2070.5 80784.6 81406.0 82467.0 82609.0 84264.6 10489.0 10573.8 10616.5 10642.9 11026.6 15150.8 15163.8 15177.6 15195.9 15213.4 7378.6 7781.9 7935.1 7969.8 8245.1 7578.6 7626.2 7841.2 7921.7 7943.8 6439.3 6443.3 6524.6 6535.4 6625.8 1924.5 1985.3 1988.1 1996.5 2009.7 953.5 975.4 991.2 1019.8 1076.9 19942.2 20391.6 20512.3 20569.9 20673.6 966.1 1003.4 1004.2 1017.6 1025.4 11045.4 11655.7 11745.3 11788.9 11850.7 475971.0 482908.0 494493.0 494499.0 495660.0 78347.0 80031.0 80902.0 93321.1 97920.5 1021.3 1037.4 1067.2 1070.6 1073.5 17412.7 17994.7 18279.7 18602.4 18930.2 36986.6 43632.1 43691.6 44449.8 44652.6 57761.1 62122.7 62173.7 62774.4 64948.0 7513.9 7970.7 8063.7 8444.6 8777.9 10038.4 13092.3 13301.1 13656.0 13827.9 11128.5 11168.4 11370.6 11717.3 12392.3 11085.3 11414.5 11511.0 11513.3 11780.2 11057.5 11788.0 12202.9 12391.8 12579.4 7319.6 7783.3 7804.6 8087.0 8101.6 7766.9 10587.2 11146.2 11676.2 11826.5 07:35:37 INFO - PROCESS | 5252 | 07:35:37 INFO - PROCESS | 5252 | [#3] mootools.html Cycles:180 Average:5727.52 Median:4557.81 stddev:3224.58 (70.7%) stddev-sans-first:3217.97 07:35:37 INFO - PROCESS | 5252 | Values: 1498.2 1531.7 1668.6 1751.4 1804.9 7637.5 8151.6 8265.4 8867.6 8872.7 8193.6 8330.9 8598.2 8637.2 8654.9 2295.6 2362.6 2364.1 2367.9 2370.8 2165.8 2223.3 2247.7 2251.8 2256.6 2217.2 2263.1 2270.7 2273.0 2273.6 2240.4 2240.5 2246.2 2248.2 2252.4 2203.8 2219.5 2222.2 2227.1 2233.3 8649.9 8744.0 8774.7 8781.0 8784.8 5076.6 5166.1 5171.5 5172.1 5193.6 3315.7 3350.7 3499.8 3530.6 3546.5 1223.7 1230.0 1231.6 1234.7 1236.8 11774.6 11983.1 11987.7 12006.6 12009.4 4299.1 4413.5 4566.4 4568.3 4608.4 10096.3 10166.7 10187.1 10193.3 10204.9 5208.7 5209.8 5211.7 5215.0 5221.2 4170.1 4549.2 4666.3 4691.0 4702.0 3904.9 4020.6 4027.4 4082.3 4099.8 1229.7 1239.1 1256.8 1261.6 1267.0 904.0 1000.2 1014.6 1028.2 1043.5 6041.9 6049.2 6069.2 6178.3 6210.1 431.9 433.3 439.7 460.3 461.4 4202.4 4262.7 4299.8 4314.7 4435.1 10211.4 10574.8 10611.6 10628.3 10646.2 10375.6 10512.4 10545.2 10550.7 10561.5 7615.0 8013.1 8076.3 8113.5 8157.4 6092.1 6155.5 6233.3 6304.6 6332.6 9844.6 9902.4 9912.4 9946.6 10022.2 9772.6 10090.0 10114.2 10165.7 10182.5 7033.7 7479.0 7624.2 7758.0 7859.4 8501.9 8520.1 8555.6 8564.0 8587.8 7532.2 7578.6 7689.8 7736.0 7901.3 7501.4 7547.7 7585.4 7605.1 7776.6 6971.4 7058.4 7077.6 7080.2 7082.6 5162.1 5240.3 5302.7 5328.8 5476.9 5162.1 5225.4 5266.1 5316.5 5504.5 07:35:37 INFO - PROCESS | 5252 | 07:35:37 INFO - PROCESS | 5252 | [#4] prototype.html Cycles:180 Average:4838.92 Median:5465.71 stddev:1425.96 (26.1%) stddev-sans-first:1389.25 07:35:37 INFO - PROCESS | 5252 | Values: 332.0 343.4 347.9 349.4 350.3 5387.4 5462.7 5512.6 5623.7 5629.6 5493.3 5506.4 5524.2 5529.5 5557.5 4305.7 4333.9 4349.8 4368.4 4393.6 4073.3 4209.1 4302.4 4316.4 4359.2 4221.1 4239.7 4247.8 4258.3 4261.8 4250.1 4267.8 4272.6 4287.8 4294.7 3571.6 3780.5 3785.5 3791.3 3805.8 5332.2 5340.5 5362.9 5399.9 5412.2 4896.8 4907.6 4922.6 4936.0 4960.0 5468.7 5737.5 5751.2 5775.8 5791.7 4116.5 4116.7 4127.9 4157.9 4166.2 6042.3 6048.3 6065.2 6075.7 6076.2 4132.7 4170.9 4193.7 4237.5 4255.9 4238.9 4261.7 4271.7 4277.9 4295.3 4911.4 4921.3 4928.2 4939.6 4951.2 5503.7 5755.9 5858.9 5892.8 5893.3 1482.7 1487.5 1488.2 1491.4 1493.8 929.1 949.2 955.9 972.2 976.0 5040.3 5042.6 5049.5 5068.3 5101.5 5162.2 5260.5 5294.6 5297.9 5374.9 5109.2 5117.5 5191.2 5321.1 5729.4 3176.2 3191.3 3192.6 3194.6 3206.8 6095.0 6222.0 6242.4 6260.7 6291.0 6004.2 6008.8 6053.2 6071.5 6112.2 6177.9 6191.4 6192.6 6194.5 6199.4 5775.0 5848.7 5850.4 5887.2 5964.5 5807.5 5840.4 5858.4 5868.3 5874.7 5898.2 6110.6 6149.8 6173.6 6179.4 4099.0 4194.9 4214.2 4235.0 4281.6 6016.9 6029.2 6031.3 6050.6 6070.9 5628.4 5809.9 5868.6 5878.3 5911.2 5746.1 5755.5 5773.7 5777.8 5848.6 5692.0 5737.2 5737.3 5744.8 5748.4 5565.8 5731.9 5827.3 5831.2 5836.7 5654.8 5659.4 5690.5 5695.7 5700.1 07:35:37 INFO - PROCESS | 5252 | 07:35:37 INFO - PROCESS | 5252 | [#5] yui.html Cycles:180 Average:20144.73 Median:4201.76 stddev:28481.26 (677.8%) stddev-sans-first:28523.81 07:35:37 INFO - PROCESS | 5252 | Values: 719.7 734.8 750.5 754.2 824.6 15238.5 15503.2 15511.8 15535.2 15544.1 14862.8 15017.9 15037.8 15076.4 15083.7 658.4 796.0 802.7 828.9 830.6 826.0 827.7 827.9 828.5 829.2 875.2 876.4 879.8 882.0 884.2 873.0 874.7 875.6 876.0 877.7 644.1 644.3 644.8 644.9 645.2 15060.6 15231.7 15303.2 15385.2 15446.5 14574.9 14592.3 14651.3 14662.0 15046.5 12530.8 12559.7 12614.3 12670.6 12678.2 3975.6 4146.2 4168.8 4200.3 4203.2 72717.3 73423.3 73852.0 74062.6 74505.0 10785.8 10829.8 11143.9 11248.0 11988.8 20169.0 20275.4 20403.3 20666.7 20752.2 8151.2 8195.3 8235.8 8378.5 8545.6 4804.5 4875.1 4884.2 4910.1 5109.7 3268.2 3362.6 3368.4 3379.4 3387.2 523.8 614.3 632.5 634.9 638.3 603.3 696.5 701.2 708.7 717.9 9199.9 9213.6 9437.4 9501.5 9694.4 611.9 662.9 667.5 680.5 722.5 4730.6 4783.5 4882.8 4922.4 5015.1 110920.0 112805.4 112973.4 113640.4 116947.4 84941.6 87388.0 89510.6 101852.0 102198.5 72718.7 84596.6 84768.2 87336.6 90195.5 10047.6 10243.8 10417.3 10490.0 10583.4 50771.7 50975.5 51593.7 52193.0 52372.5 44363.3 44379.0 58444.4 73499.3 73525.3 12132.7 13425.5 13537.3 13734.5 13967.5 14726.8 15256.3 15623.8 15801.4 16098.8 13940.9 14036.9 14935.6 14943.2 15019.9 12345.4 12434.9 12441.6 12570.0 12687.7 13495.3 13946.7 14063.7 14101.4 14171.4 11207.4 11425.0 11676.4 11875.5 11972.3 12092.4 12139.2 12186.8 12217.3 12299.3 07:35:37 INFO - PROCESS | 5252 | -------- Summary: end -------- 07:35:37 INFO - PROCESS | 5252 | 07:35:38 INFO - TEST-INFO | 5252: exit 0 07:35:38 INFO - TEST-OK | dromaeo_css | took 1111800ms 07:35:38 INFO - TEST-START | kraken 07:35:38 INFO - operating with platform_type : linux_ 07:35:38 INFO - Initialising browser for kraken test... 07:35:38 INFO - TEST-INFO | started process 5503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprs2b0O/profile http://localhost:55084/getInfo.html) 07:35:41 INFO - PROCESS | 5503 | JavaScript error: , line 0: uncaught exception: undefined 07:35:42 INFO - PROCESS | 5503 | __metrics Screen width/height:1600/1200 07:35:42 INFO - PROCESS | 5503 | colorDepth:24 07:35:42 INFO - PROCESS | 5503 | Browser inner width/height: 1024/697 07:35:42 INFO - PROCESS | 5503 | __metrics 07:35:43 ERROR - PROCESS | 5503 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:35:44 INFO - TEST-INFO | 5503: exit 0 07:35:44 INFO - Browser initialized. 07:35:44 INFO - Running cycle 1/1 for kraken test... 07:35:44 INFO - TEST-INFO | started process 5624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprs2b0O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:56 INFO - PROCESS | 5624 | RSS: Main: 165019648 07:35:56 INFO - PROCESS | 5624 | 07:35:58 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55084/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:59 INFO - PROCESS | 5624 | RSS: Main: 170201088 07:35:59 INFO - PROCESS | 5624 | 07:36:02 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55084/tests/kraken/driver.html?testName=audio-dft) 07:36:02 INFO - PROCESS | 5624 | RSS: Main: 168869888 07:36:02 INFO - PROCESS | 5624 | 07:36:05 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55084/tests/kraken/driver.html?testName=audio-fft) 07:36:06 INFO - PROCESS | 5624 | RSS: Main: 164646912 07:36:06 INFO - PROCESS | 5624 | 07:36:08 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55084/tests/kraken/driver.html?testName=audio-oscillator) 07:36:09 INFO - PROCESS | 5624 | RSS: Main: 166428672 07:36:09 INFO - PROCESS | 5624 | 07:36:11 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55084/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:36:12 INFO - PROCESS | 5624 | RSS: Main: 166477824 07:36:12 INFO - PROCESS | 5624 | 07:36:15 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55084/tests/kraken/driver.html?testName=imaging-darkroom) 07:36:15 INFO - PROCESS | 5624 | RSS: Main: 166137856 07:36:15 INFO - PROCESS | 5624 | 07:36:19 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55084/tests/kraken/driver.html?testName=imaging-desaturate) 07:36:19 INFO - PROCESS | 5624 | RSS: Main: 167469056 07:36:19 INFO - PROCESS | 5624 | 07:36:22 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55084/tests/kraken/driver.html?testName=json-parse-financial) 07:36:23 INFO - PROCESS | 5624 | RSS: Main: 167239680 07:36:23 INFO - PROCESS | 5624 | 07:36:24 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55084/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:36:25 INFO - PROCESS | 5624 | RSS: Main: 167223296 07:36:25 INFO - PROCESS | 5624 | 07:36:27 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55084/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:36:27 INFO - PROCESS | 5624 | RSS: Main: 166535168 07:36:27 INFO - PROCESS | 5624 | 07:36:29 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55084/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:36:30 INFO - PROCESS | 5624 | RSS: Main: 168165376 07:36:30 INFO - PROCESS | 5624 | 07:36:33 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:36:33 INFO - PROCESS | 5624 | RSS: Main: 167604224 07:36:33 INFO - PROCESS | 5624 | 07:36:36 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:36:37 INFO - PROCESS | 5624 | RSS: Main: 167706624 07:36:37 INFO - PROCESS | 5624 | 07:36:38 INFO - PROCESS | 5624 | Cycle 1(1): loaded http://localhost:55084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55084/tests/kraken/driver.html?testName=ai-astar) 07:36:39 INFO - PROCESS | 5624 | RSS: Main: 168775680 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | __start_tp_report 07:36:39 INFO - PROCESS | 5624 | _x_x_mozilla_page_load 07:36:39 INFO - PROCESS | 5624 | _x_x_mozilla_page_load_details 07:36:39 INFO - PROCESS | 5624 | |i|pagename|runs| 07:36:39 INFO - PROCESS | 5624 | |0;ai-astar;104;114;107;114;113;113;113;111;111;112 07:36:39 INFO - PROCESS | 5624 | |1;audio-beat-detection;145;117;146;183;126;149;154;120;181;117 07:36:39 INFO - PROCESS | 5624 | |2;audio-dft;163;164;162;164;162;166;173;163;162;162 07:36:39 INFO - PROCESS | 5624 | |3;audio-fft;74;74;77;175;77;76;77;78;185;76 07:36:39 INFO - PROCESS | 5624 | |4;audio-oscillator;84;84;157;85;85;84;141;85;84;151 07:36:39 INFO - PROCESS | 5624 | |5;imaging-gaussian-blur;118;118;117;118;118;118;117;118;118;117 07:36:39 INFO - PROCESS | 5624 | |6;imaging-darkroom;147;149;147;148;147;148;148;147;147;147 07:36:39 INFO - PROCESS | 5624 | |7;imaging-desaturate;96;97;95;96;95;96;96;97;96;96 07:36:39 INFO - PROCESS | 5624 | |8;json-parse-financial;52;52;57;53;52;52;55;54;52;54 07:36:39 INFO - PROCESS | 5624 | |9;json-stringify-tinderbox;63;62;63;63;63;62;63;62;63;63 07:36:39 INFO - PROCESS | 5624 | |10;stanford-crypto-aes;79;77;76;86;82;77;76;76;83;76 07:36:39 INFO - PROCESS | 5624 | |11;stanford-crypto-ccm;123;131;130;124;122;130;124;123;177;127 07:36:39 INFO - PROCESS | 5624 | |12;stanford-crypto-pbkdf2;156;156;160;159;164;158;156;158;159;154 07:36:39 INFO - PROCESS | 5624 | |13;stanford-crypto-sha256-iterative;63;65;63;64;62;68;63;62;64;69 07:36:39 INFO - PROCESS | 5624 | __end_tp_report 07:36:39 INFO - PROCESS | 5624 | __start_cc_report 07:36:39 INFO - PROCESS | 5624 | _x_x_mozilla_cycle_collect,878 07:36:39 INFO - PROCESS | 5624 | __end_cc_report 07:36:39 INFO - PROCESS | 5624 | __startTimestamp1469543799156__endTimestamp 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | ------- Summary: start ------- 07:36:39 INFO - PROCESS | 5624 | Number of tests: 14 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:3.26 (2.9%) stddev-sans-first:2.18 07:36:39 INFO - PROCESS | 5624 | Values: 104.0 114.0 107.0 114.0 113.0 113.0 113.0 111.0 111.0 112.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:147.50 stddev:24.44 (16.6%) stddev-sans-first:25.92 07:36:39 INFO - PROCESS | 5624 | Values: 145.0 117.0 146.0 183.0 126.0 149.0 154.0 120.0 181.0 117.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.38 (2.1%) stddev-sans-first:3.56 07:36:39 INFO - PROCESS | 5624 | Values: 163.0 164.0 162.0 164.0 162.0 166.0 173.0 163.0 162.0 162.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#3] audio-fft Cycles:10 Average:96.90 Median:76.50 stddev:43.88 (57.4%) stddev-sans-first:45.75 07:36:39 INFO - PROCESS | 5624 | Values: 74.0 74.0 77.0 175.0 77.0 76.0 77.0 78.0 185.0 76.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:84.00 stddev:31.75 (37.8%) stddev-sans-first:32.84 07:36:39 INFO - PROCESS | 5624 | Values: 84.0 84.0 157.0 85.0 85.0 84.0 141.0 85.0 84.0 151.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:36:39 INFO - PROCESS | 5624 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:36:39 INFO - PROCESS | 5624 | Values: 147.0 149.0 147.0 148.0 147.0 148.0 148.0 147.0 147.0 147.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 07:36:39 INFO - PROCESS | 5624 | Values: 96.0 97.0 95.0 96.0 95.0 96.0 96.0 97.0 96.0 96.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:1.70 (3.2%) stddev-sans-first:1.74 07:36:39 INFO - PROCESS | 5624 | Values: 52.0 52.0 57.0 53.0 52.0 52.0 55.0 54.0 52.0 54.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 07:36:39 INFO - PROCESS | 5624 | Values: 63.0 62.0 63.0 63.0 63.0 62.0 63.0 62.0 63.0 63.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:3.61 (4.6%) stddev-sans-first:3.83 07:36:39 INFO - PROCESS | 5624 | Values: 79.0 77.0 76.0 86.0 82.0 77.0 76.0 76.0 83.0 76.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:128.50 stddev:16.47 (12.8%) stddev-sans-first:17.20 07:36:39 INFO - PROCESS | 5624 | Values: 123.0 131.0 130.0 124.0 122.0 130.0 124.0 123.0 177.0 127.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.50 stddev:2.79 (1.8%) stddev-sans-first:2.86 07:36:39 INFO - PROCESS | 5624 | Values: 156.0 156.0 160.0 159.0 164.0 158.0 156.0 158.0 159.0 154.0 07:36:39 INFO - PROCESS | 5624 | 07:36:39 INFO - PROCESS | 5624 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:2.41 (3.8%) stddev-sans-first:2.51 07:36:39 INFO - PROCESS | 5624 | Values: 63.0 65.0 63.0 64.0 62.0 68.0 63.0 62.0 64.0 69.0 07:36:39 INFO - PROCESS | 5624 | -------- Summary: end -------- 07:36:39 INFO - PROCESS | 5624 | 07:36:40 INFO - TEST-INFO | 5624: exit 0 07:36:40 INFO - TEST-OK | kraken | took 62048ms 07:36:40 INFO - SUITE-END | took 1173s 07:36:40 INFO - Completed test suite (00:19:33) 07:36:40 INFO - javascript benchmark 07:36:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7239.644817660428, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.8150910945337, 3097.969020309796, 3120.687931206878, 3124.328269422074, 3128.5776420183283, 5376.946230537694, 5378.0857254266775, 5427.2673189119505, 5446.673199608026, 5457.918131228034, 5355.571554275658, 5357.1696387060065, 5395.21769343445, 5414.566834653228, 5419.756110975006, 4834.951650483503, 4937.5556199942, 4970.353853998975, 4983.9252411213865, 4993.675411098285, 4972.129877271463, 5024.849254522352, 5070.366204224472, 5074.137396642561, 5102.591792656579, 4850.029994001196, 4883.877903052435, 4901.411830580318, 4928.482509336504, 5033.270175824485, 4927.605791536668, 4936.136176169156, 4968.900621987576, 4968.975155124202, 4994.675346102492, 4902.4362198346935, 4909.263610458424, 4914.975425122851, 4923.040007198598, 4971.577415919651, 5256.474352564713, 5286.60350473716, 5327.706976116312, 5398.271233383522, 5483.972580137113, 5751.539876809845, 5773.162891380726, 5788.565857560699, 5790.507806836424, 5790.7104644768015, 5809.854753631151, 5826.0, 5832.6792026438525, 5839.299284085937, 5851.970740146315, 5264.236685680593, 5275.472452754694, 5292.44429334922, 5301.390340110898, 5385.299911011622, 5823.2429784128635, 5826.82519524415, 5827.504662103769, 5829.795957141565, 5870.853228669232, 5668.0, 5678.346990096192, 5683.460071293303, 5686.175504551817, 5696.3733989261145, 5577.2191893135, 5718.370979192286, 5778.0, 5781.913271300934, 5881.911771323348, 5601.579881508903, 5609.9902017636405, 5639.238702775073, 5697.772089116472, 5702.7433765480655, 5655.0386434306265, 5727.627704199213, 5731.369549349568, 5745.1382292656435, 5759.65442073477, 4365.0, 4420.535843736361, 4434.268345722984, 4441.933370999438, 4449.176902273025, 3979.2240513100246, 3992.6007399259843, 3999.1002024544246, 4024.63778259958, 4028.536718277377, 5538.889222215533, 5638.718064096779, 5668.0, 5671.2060311556415, 5680.062789639664, 5585.273914391184, 5739.741711622987, 5759.971200143972, 5889.322727886262, 5901.144334071536, 5531.751071201806, 5541.9168712469345, 5625.578081643893, 5647.068233741386, 5661.2923384576925, 4979.103761322925, 4982.327385802942, 4986.551210391082, 5065.898682026339, 5092.541671249605, 5806.738696758656, 5922.3485416604135, 5978.701064946736, 6042.305134909454, 6058.727357268934, 5781.335146458211, 5781.364049954585, 5785.595008349375, 5813.12803079533, 5829.650220986754, 5931.110333450017, 5963.642181469126, 5968.074948383008, 5976.701164941823, 5988.610740301867, 5496.725163741717, 5643.746031428677, 5685.744141513559, 5691.117876729114, 5694.1458781183155, 5782.624129431573, 5812.534997200299, 5814.215080964185, 5817.621854579608, 5868.589198756046, 5624.803131890364, 5639.7180140993605, 5645.661260324229, 5659.6887171204335, 5660.349059858169, 5448.210009548672, 5559.555235581063, 5620.3536593290655, 5621.887562248814, 5682.801101961411, 5610.410906854885, 5631.183478395692, 5648.378678345297, 5671.234383358194, 5684.9431505684415, 5681.0626246668835, 5698.8290351289525, 5726.914096288642, 5753.683547404933, 5755.1367294906095, 5450.563954883679, 5529.861753456195, 5556.444355564411, 5565.1374037024325, 5636.239107720569], "value": 5336.316004074759, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.2883895131087, 585.6925114314984, 595.7855172138031, 599.1551911804356, 600.5765935015814, 42005.36991945123, 44108.33837492436, 44145.77927110364, 47928.76035619817, 47956.280655790106, 45705.31442028372, 46116.07767844641, 46161.30758038632, 46400.76799615997, 46414.767926160406, 8970.82058358834, 9113.95443022784, 9117.954410227972, 9123.589438475285, 9142.085791420872, 8878.200961913426, 8909.95545022274, 8971.506567138806, 9015.95492022539, 9026.638934442615, 8741.694040708577, 8773.16654917785, 8812.867806982867, 8825.073367296438, 8831.646734130627, 9026.0, 9035.548222588877, 9044.186023257938, 9062.0, 9063.229625481841, 8923.286137109015, 8939.553022348922, 8989.730308090768, 8998.0, 9000.144986226298, 42540.0, 42802.0, 43003.0, 43063.78468107671, 43161.568384316066, 3569.5716514018222, 3689.7417180797356, 3727.1986522897705, 3815.294170578452, 4068.3126302750547, 33260.667393325995, 33650.49524257138, 34238.31523369544, 34584.0, 34855.1286217844, 4407.471103467605, 4449.510553839075, 4487.6634252431195, 4612.1698094343, 4635.976820115911, 248684.0, 248741.0, 249561.0, 251202.0, 252576.0, 56380.0, 56800.71599642058, 56917.43082569121, 57072.0, 57123.71438142866, 36764.264714705554, 37708.2458350837, 58533.0, 59036.0, 59131.70434147802, 16537.83462165363, 16672.33310667584, 16672.49982500527, 16714.4149954751, 16722.24749886258, 12231.510739570318, 12323.75352492945, 12326.198797078161, 12367.0, 12384.708828866509, 18114.81885181158, 18158.5460363492, 18478.0, 18531.814681853008, 18637.695361324848, 6802.3537763912345, 6971.930280697128, 7191.424686025105, 7263.201047884729, 7419.146798118178, 911.876896618948, 1008.7931973945324, 1056.57736905237, 1152.6369193703956, 1177.2465622001926, 31905.8404707975, 32474.83762581172, 32714.345713085604, 32980.83509582437, 33034.504482432785, 1125.5891599566264, 1131.8472006279046, 1136.323887287063, 1146.5012719467059, 1183.5325046606542, 16824.831751682326, 17083.40208092711, 17122.40071597513, 17182.74225886613, 17242.482725518254, 149990.25004875124, 150506.0, 150546.24726876296, 151033.0, 151325.0, 57577.0, 57595.0, 58182.7090864543, 58189.4181058184, 58308.7084564583, 1325.2975922760759, 1377.80710700502, 1379.4895888521312, 1391.373881753215, 1400.1109295597166, 30052.398952021274, 31139.221519462193, 31631.683683162875, 31945.201369965936, 32318.83840580782, 49420.258696118864, 49454.0, 49733.254001189285, 49835.25247121223, 50011.0, 361028.0, 361043.0, 361043.0, 362966.0, 363724.0, 27752.167434976982, 27793.16620501388, 27892.0, 28168.29579260535, 28232.717672823008, 47133.29300060433, 47416.7629161852, 47625.0, 48903.75548122237, 48936.0, 40019.780120978234, 42096.15807683768, 42445.78777106095, 42735.572644274405, 42803.785981069894, 40210.597894021856, 43846.12307753891, 44699.77650111729, 45024.77487612541, 45027.77486112549, 34798.65201347954, 39077.0, 39544.40683389694, 41148.38277425901, 41346.58653413548, 35671.82164089163, 37725.81137094297, 38101.142414318485, 38258.234835303694, 38610.227795444494, 27728.44543109167, 28134.71865281321, 28278.15165545037, 28422.289442764097, 28809.56785648175], "value": 19218.793530974475, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.7973054011914, 390.48651023903585, 405.07238424009023, 410.4049128763293, 425.5893063194017, 18356.449306520793, 19509.414717558495, 20101.698474522876, 20255.59488810223, 20618.48453788656, 19064.523386915334, 19346.67839859219, 19662.80337196631, 19692.70460943087, 19821.900890495563, 5582.078956972095, 5716.114002329646, 5719.857003574903, 5734.655920644775, 5769.942300577003, 5562.3047119110115, 5658.858528536778, 5702.486776190142, 5717.885642287151, 5724.7137643117885, 5532.474414930595, 5622.465865742748, 5642.379338272786, 5672.34768001681, 5698.059820129694, 5614.242077319551, 5652.74562644682, 5659.717014149276, 5660.801871934504, 5668.68822214778, 4873.8781530461665, 5070.188769796815, 5077.365329333833, 5087.211482220262, 5111.437741848394, 23117.190898318648, 23219.0, 23306.533869322688, 23539.29382118539, 23544.29367118989, 2347.354477518679, 2376.465295308542, 2473.0, 2555.09294200558, 2596.7143614202423, 7283.4537409694485, 14247.572572822832, 14416.783748243784, 14558.199299038548, 14815.851841481555, 1894.393793985925, 2005.2881227164291, 2011.3664195778283, 2020.6867935470025, 2070.4823794051485, 80784.59607701923, 81406.0, 82466.9999999994, 82609.0, 84264.57867710684, 10489.0, 10573.788524229472, 10616.522256498476, 10642.946785266024, 11026.558937642405, 15150.848491515164, 15163.772543411858, 15177.62055948588, 15195.924020379827, 15213.391464341525, 7378.55357700724, 7781.922180778233, 7935.127136015034, 7969.840603187904, 8245.093039765621, 7578.621068946531, 7626.161122276545, 7841.176676449005, 7921.722739704082, 7943.801404964806, 6439.291677915426, 6443.259025212067, 6524.608523488606, 6535.444487218545, 6625.834354141089, 1924.499630096185, 1985.2702534015727, 1988.1152886965451, 1996.5407956170163, 2009.7387339645752, 953.5137080089204, 975.4439969217478, 991.1872264742842, 1019.7654539455966, 1076.8815430302661, 19942.20231190736, 20391.592168156552, 20512.282070127472, 20569.89715051445, 20673.586528269352, 966.0822218892081, 1003.3779056984716, 1004.1565085328359, 1017.5573625472795, 1025.3954954415701, 11045.39250341239, 11655.650330490098, 11745.29528228309, 11788.882111178778, 11850.703732406759, 475971.0, 482908.0, 494493.0, 494499.0, 495660.0, 78347.0, 80031.0, 80902.0, 93321.0667893326, 97920.51039744755, 1021.2697920986382, 1037.419045334615, 1067.2475904487317, 1070.6359837655234, 1073.5437439088357, 17412.73880891813, 17994.730079049088, 18279.725804112684, 18602.44192674222, 18930.242790288787, 36986.63013369939, 43632.12735745331, 43691.56308436875, 44449.77775111104, 44652.55347446484, 57761.13358299713, 62122.689386552775, 62173.689131554056, 62774.37225627685, 64948.0, 7513.887291690519, 7970.721024764105, 8063.6774529018185, 8444.619992100248, 8777.91222087771, 10038.447885366375, 13092.345382730635, 13301.135426197266, 13656.04407691452, 13827.930860345634, 11128.499217535393, 11168.385738784445, 11370.602028928948, 11717.296962182296, 12392.256464612152, 11085.334879907232, 11414.48634811452, 11511.0, 11513.251638643796, 11780.234284771463, 11057.5024123913, 11788.0, 12202.877971220174, 12391.75216495647, 12579.433925473193, 7319.597422141834, 7783.326584784299, 7804.648790804541, 8086.959565202136, 8101.594920253846, 7766.883496747666, 10587.20595955291, 11146.164037697043, 11676.182667213214, 11826.467808948446], "value": 9355.090303235167, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.213437945079, 1531.724289627867, 1668.5828542864283, 1751.3957684598809, 1804.9368272110478, 7637.503562268449, 8151.592420378987, 8265.421420500568, 8867.645294188233, 8872.733817985463, 8193.631286592103, 8330.91669083309, 8598.22615964563, 8637.222649961503, 8654.91345086549, 2295.5523672883796, 2362.5511152880986, 2364.137089962169, 2367.8579285242854, 2370.7747763962484, 2165.761766205716, 2223.2663221136986, 2247.6965609642652, 2251.752307246202, 2256.582532231534, 2217.2350539064078, 2263.0834512022575, 2270.6594010898334, 2272.988635056831, 2273.6362182050875, 2240.395093324801, 2240.4622890506243, 2246.1801442473543, 2248.15694114707, 2252.425631463966, 2203.834712396577, 2219.5006123622215, 2222.2444368914485, 2227.086894373299, 2233.274185889576, 8649.913500865037, 8744.038155802857, 8774.73675789721, 8781.0, 8784.824303513959, 5076.64463487556, 5166.147585648364, 5171.534561889448, 5172.094883395391, 5193.63644544882, 3315.651856555051, 3350.731941444679, 3499.772514786531, 3530.5763308402898, 3546.4680297955515, 1223.7124275795181, 1229.9644089032665, 1231.6305108467425, 1234.703671118934, 1236.765014647223, 11774.587889423914, 11983.101267404892, 11987.700307492383, 12006.63980080599, 12009.399530023551, 4299.140171965557, 4413.514513403523, 4566.406367172246, 4568.291914753218, 4608.354830323758, 10096.34373765703, 10166.745831354276, 10187.115383654047, 10193.337433066827, 10204.948975255225, 5208.713520756395, 5209.843704688866, 5211.71335576547, 5214.97392513035, 5221.216817477332, 4170.103427762985, 4549.203889319356, 4666.300054991711, 4690.953090469052, 4701.976490117596, 3904.882853514399, 4020.6180412861318, 4027.375756757707, 4082.2856000199845, 4099.815508302134, 1229.7294595189044, 1239.0830785219052, 1256.8051951947464, 1261.6215135459327, 1266.9873301267053, 903.9819203615891, 1000.2048371544639, 1014.5535964175887, 1028.2493779540828, 1043.473046111724, 6041.879162416727, 6049.1833602463985, 6069.180660610849, 6178.320384757673, 6210.130581718563, 431.85773628751775, 433.252639197382, 439.7471453914012, 460.2750667698388, 461.3610149942354, 4202.390653355246, 4262.65898728101, 4299.849505267301, 4314.676399270067, 4435.068635586498, 10211.438370889524, 10574.788504230026, 10611.57553697859, 10628.309159904582, 10646.201534884915, 10375.584976600852, 10512.421816799997, 10545.209109316833, 10550.683479495474, 10561.471926403648, 7614.961925190339, 8013.078495972921, 8076.313513351431, 8113.472624279403, 8157.428979971463, 6092.086187071975, 6155.47678447337, 6233.345498722569, 6304.558680892477, 6332.556721029484, 9844.606215751577, 9902.356346837432, 9912.355696879968, 9946.602135914482, 10022.198224141905, 9772.560234789593, 10090.041446062613, 10114.241431892491, 10165.745856353651, 10182.541785619516, 7033.683484243119, 7478.962605186939, 7624.199459056719, 7758.0, 7859.449838511249, 8501.914980850359, 8520.10538893432, 8555.572221388782, 8564.0, 8587.828243434971, 7532.209118042746, 7578.583177925047, 7689.769306920802, 7736.0, 7901.328387086932, 7501.3998880088375, 7547.660355284135, 7585.431092668182, 7605.087389513294, 7776.572288524186, 6971.372576468142, 7058.364747172779, 7077.5753454792875, 7080.185778635523, 7082.610456424946, 5162.148245539444, 5240.2663627093, 5302.681839089667, 5328.7602057906715, 5476.863078423071, 5162.122439185423, 5225.372955245395, 5266.104762190514, 5316.548093411949, 5504.53211477029], "value": 4530.204649319786, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.03435660887544, 343.4350493438294, 347.89910925831504, 349.3850822552307, 350.3413582464964, 5387.4073851876265, 5462.7268636568215, 5512.5865560083, 5623.690697011658, 5629.60592758507, 5493.253373313343, 5506.394296627368, 5524.232245681384, 5529.474699903512, 5557.499825015748, 4305.720128191673, 4333.934990975138, 4349.760763158025, 4368.366586844905, 4393.648508119343, 4073.348264277716, 4209.137126888996, 4302.440682711243, 4316.395704601358, 4359.193549193394, 4221.092465119998, 4239.660827133822, 4247.787610619456, 4258.254805409041, 4261.829526818923, 4250.064985703156, 4267.829286828523, 4272.594103560188, 4287.8284868605215, 4294.742315461082, 3571.571411430619, 3780.489633899416, 3785.4889589905288, 3791.2607041626893, 3805.7906815125157, 5332.226827110087, 5340.519353258186, 5362.865928351784, 5399.946000539983, 5412.242286079952, 4896.755162241873, 4907.631927605444, 4922.581580565657, 4935.950640493621, 4959.958408734134, 5468.699221542814, 5737.454941780524, 5751.194832723422, 5775.834062226665, 5791.681457519835, 4116.5060192776755, 4116.711830171889, 4127.938080928789, 4157.896052598679, 4166.187593419285, 6042.283995342877, 6048.304444988795, 6065.211522502091, 6075.665838378887, 6076.240469941257, 4132.73137246078, 4170.874873753793, 4193.748375097504, 4237.470316210473, 4255.893602659959, 4238.915221695549, 4261.680373971964, 4271.67962402821, 4277.893052673708, 4295.334223195409, 4911.386076740408, 4921.26181072842, 4928.211486162269, 4939.580135688435, 4951.183054795991, 5503.697296648643, 5755.942440575541, 5858.94141058584, 5892.823215303548, 5893.292804863444, 1482.6589884326665, 1487.5091219897408, 1488.1517535004944, 1491.395984626228, 1493.760998240298, 929.1312622697799, 949.1694767078806, 955.9330846840794, 972.1736523954723, 975.9609615615295, 5040.31955685985, 5042.571381432546, 5049.520295571915, 5068.265101560253, 5101.479978814606, 5162.173367901025, 5260.526552610207, 5294.602904782157, 5297.920531192035, 5374.892502149935, 5109.2080727486555, 5117.513836185556, 5191.195364718475, 5321.148616221463, 5729.369769325371, 3176.2059485128716, 3191.3457741163006, 3192.5530425740417, 3194.6485886552928, 3206.8075915445147, 6094.969525152346, 6221.96889015552, 6242.375762423721, 6260.686965651699, 6290.968545157245, 6004.189434426384, 6008.789692360747, 6053.243344581927, 6071.483923866521, 6112.174856394418, 6177.938220617826, 6191.4118158774845, 6192.628442293477, 6194.535409844189, 6199.442050215503, 5775.0, 5848.678322692293, 5850.444207800252, 5887.1757953885635, 5964.463198312173, 5807.506361959281, 5840.357560668408, 5858.384869588632, 5868.2664666916635, 5874.736931559735, 5898.233229680114, 6110.555777688783, 6149.754009839735, 6173.629582225081, 6179.443850053517, 4098.979505102456, 4194.853180138803, 4214.220369231702, 4234.957650423579, 4281.614654681093, 6016.939830601813, 6029.246344206974, 6031.306399763907, 6050.636961782131, 6070.939290607037, 5628.352739435018, 5809.8547536311935, 5868.618539794899, 5878.29460464747, 5911.201987731602, 5746.13807928814, 5755.53955683536, 5773.653580785166, 5777.826665200051, 5848.64908105498, 5691.971540142273, 5737.225474560881, 5737.282839645044, 5744.770209191753, 5748.425157484218, 5565.833025009256, 5731.942680573307, 5827.271591051119, 5831.241938547962, 5836.708164591669, 5654.755953690182, 5659.377468478547, 5690.459406356389, 5695.686737229492, 5700.095434627294], "value": 4384.64326947436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.7301012120455, 734.8273155808386, 750.5121670913907, 754.1967804288436, 824.6000689665515, 15238.542843714678, 15503.224838758046, 15511.767323490143, 15535.223238838054, 15544.145072021034, 14862.777058344107, 15017.924910375461, 15037.849621503809, 15076.396944122249, 15083.698326033473, 658.40743331002, 795.9641816118274, 802.6508468816055, 828.8756686497013, 830.6013113705425, 825.9793505162359, 827.7144385187131, 827.93790465715, 828.4780588229407, 829.2371018662815, 875.2429148786317, 876.4215617692324, 879.7932485865816, 882.0429833630518, 884.1865483754929, 872.9519876406795, 874.7157173918438, 875.6147295190128, 875.9693410730657, 877.662100091463, 644.0757512968904, 644.3202421445374, 644.8162273752005, 644.8549076457759, 645.1612903225788, 15060.623484412868, 15231.695366092727, 15303.234838258153, 15385.230738463031, 15446.5366039019, 14574.927125364306, 14592.270386480634, 14651.267436628232, 14662.0, 15046.473373431878, 12530.812037819349, 12559.748805023939, 12614.306213158272, 12670.619881403572, 12678.239305641599, 3975.582563830785, 4146.232946904832, 4168.791560421967, 4200.327947528381, 4203.201391735561, 72717.27282727158, 73423.26576734218, 73852.0, 74062.62968685121, 74505.0, 10785.83821242682, 10829.83755243672, 11143.944280278709, 11248.0, 11988.76022479563, 20169.0, 20275.391738247876, 20403.28588499425, 20666.689999650018, 20752.169913203605, 8151.18488151192, 8195.34437245019, 8235.8352832943, 8378.49729016261, 8545.615447304886, 4804.519548045238, 4875.098106850244, 4884.242942343943, 4910.091633047898, 5109.693418394908, 3268.2483028903484, 3362.596488421405, 3368.39368913593, 3379.374815659111, 3387.2209391840015, 523.8023330439062, 614.2690198663576, 632.4687262699263, 634.9111124442582, 638.3488841381765, 603.3333166850655, 696.450397864757, 701.1936273285762, 708.7342246657504, 717.8564287142592, 9199.862002069975, 9213.585388657526, 9437.410129413622, 9501.524923753785, 9694.369865958832, 611.8684482836212, 662.9237637671633, 667.4693618573245, 680.4828330468879, 722.4689852958072, 4730.62155027597, 4783.497732738082, 4882.7558622068755, 4922.360093187935, 5015.097282489187, 110920.0, 112805.43597282126, 112973.43513282381, 113640.43179784049, 116947.41526292314, 84941.57529212438, 87388.0, 89510.55244723865, 101851.99999999852, 102198.48900755448, 72718.72765725556, 84596.57701711575, 84768.15231847725, 87336.56331718301, 90195.54902225448, 10047.598096076368, 10243.795124097625, 10417.270791044553, 10490.0, 10583.417912014913, 50771.74614126905, 50975.49024509708, 51593.74203128961, 52193.0, 52372.47627523676, 44363.33454998113, 44379.0, 58444.415555843894, 73499.26500734924, 73525.26474735184, 12132.730583909242, 13425.462981480632, 13537.255450950292, 13734.519291824738, 13967.511137110152, 14726.77909831332, 15256.31346589384, 15623.76564351513, 15801.36794528206, 16098.839011609734, 13940.860591394361, 14036.859631403964, 14935.626609334853, 14943.178125203218, 15019.924900375428, 12345.444454999368, 12434.937825310815, 12441.564545241235, 12570.0, 12687.746245074863, 13495.25776082325, 13946.651333716332, 14063.718725625635, 14101.365438555085, 14171.433142674177, 11207.383593902414, 11425.028872545927, 11676.357800321064, 11875.465604047666, 11972.341521216069, 12092.395380230777, 12139.150259481752, 12186.817197742219, 12217.328046957502, 12299.323537205182], "value": 7554.277930154416, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 107.0, 114.0, 113.0, 113.0, 113.0, 111.0, 111.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 146.0, 183.0, 126.0, 149.0, 154.0, 120.0, 181.0, 117.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 164.0, 162.0, 166.0, 173.0, 163.0, 162.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 175.0, 77.0, 76.0, 77.0, 78.0, 185.0, 76.0], "value": 96.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 157.0, 85.0, 85.0, 84.0, 141.0, 85.0, 84.0, 151.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 57.0, 53.0, 52.0, 52.0, 55.0, 54.0, 52.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 76.0, 86.0, 82.0, 77.0, 76.0, 76.0, 83.0, 76.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 131.0, 130.0, 124.0, 122.0, 130.0, 124.0, 123.0, 177.0, 127.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 160.0, 159.0, 164.0, 158.0, 156.0, 158.0, 159.0, 154.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 64.0, 62.0, 68.0, 63.0, 62.0, 64.0, 69.0], "value": 64.3, "unit": "score"}]}]} 07:36:40 INFO - Return code: 0 07:36:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:36:40 ERROR - # TBPL SUCCESS # 07:36:40 INFO - Running post-action listener: _resource_record_post_action 07:36:40 INFO - [mozharness: 2016-07-26 14:36:40.441594Z] Finished run-tests step (success) 07:36:40 INFO - Running post-run listener: _resource_record_post_run 07:36:40 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 556339200; Read time: 0; Write time: 773540 07:36:40 INFO - TinderboxPrint: CPU usage
13.4% 07:36:40 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:36:40 INFO - TinderboxPrint: I/O write bytes / time
556,339,200 / 773,540 07:36:40 INFO - TinderboxPrint: CPU idle
8,231.6 (86.6%) 07:36:40 INFO - TinderboxPrint: CPU user
1,213.0 (12.8%) 07:36:40 INFO - TinderboxPrint: Swap in / out
0 / 0 07:36:40 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 261529600; Read time: 0; Write time: 431184 07:36:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 294809600; Read time: 0; Write time: 342356 07:36:41 INFO - Running post-run listener: _upload_blobber_files 07:36:41 INFO - Blob upload gear active. 07:36:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:36:41 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 07:36:41 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'] 07:36:41 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 07:36:41 INFO - (blobuploader) - INFO - Open directory for files ... 07:36:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:36:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:36:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:42 INFO - (blobuploader) - INFO - Done attempting. 07:36:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:36:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:36:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:55 INFO - (blobuploader) - INFO - Done attempting. 07:36:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:36:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:36:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:56 INFO - (blobuploader) - INFO - Done attempting. 07:36:56 INFO - (blobuploader) - INFO - Iteration through files over. 07:36:56 INFO - Return code: 0 07:36:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:36:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:36:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25755595260e5fbeaabd0ab1b26f048c3ed149d42849d964c77bb98b1809527537cc083185aee84d435762a285d89e37fe854a50213661cf3098a9e69d01cc90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78f1766a89c21c50bf90be5d989173b0466795a461c859a76fdad585c3645300efa1b9457abcf50d1c34bc8be73290a6d610e7f4d69dc2f55781f10eaff57597", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1317693c3fce5d9c815a368b0e9f150059b3c27c50d4158a495ce777c1bd48175632bbfbc412bfd4ee1ba5fbb645a4cab0441831840b4486f77c3155ee266a5b"} 07:36:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:36:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:36:56 INFO - Contents: 07:36:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25755595260e5fbeaabd0ab1b26f048c3ed149d42849d964c77bb98b1809527537cc083185aee84d435762a285d89e37fe854a50213661cf3098a9e69d01cc90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78f1766a89c21c50bf90be5d989173b0466795a461c859a76fdad585c3645300efa1b9457abcf50d1c34bc8be73290a6d610e7f4d69dc2f55781f10eaff57597", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1317693c3fce5d9c815a368b0e9f150059b3c27c50d4158a495ce777c1bd48175632bbfbc412bfd4ee1ba5fbb645a4cab0441831840b4486f77c3155ee266a5b"} 07:36:56 INFO - Running post-run listener: copy_logs_to_upload_dir 07:36:56 INFO - Copying logs to upload dir... 07:36:56 INFO - mkdir: /builds/slave/test/build/upload/logs 07:36:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.068344 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-26 07:36:56.004942) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 07:36:56.008679) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469 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/25755595260e5fbeaabd0ab1b26f048c3ed149d42849d964c77bb98b1809527537cc083185aee84d435762a285d89e37fe854a50213661cf3098a9e69d01cc90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78f1766a89c21c50bf90be5d989173b0466795a461c859a76fdad585c3645300efa1b9457abcf50d1c34bc8be73290a6d610e7f4d69dc2f55781f10eaff57597", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1317693c3fce5d9c815a368b0e9f150059b3c27c50d4158a495ce777c1bd48175632bbfbc412bfd4ee1ba5fbb645a4cab0441831840b4486f77c3155ee266a5b"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1469530440/firefox-50.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/25755595260e5fbeaabd0ab1b26f048c3ed149d42849d964c77bb98b1809527537cc083185aee84d435762a285d89e37fe854a50213661cf3098a9e69d01cc90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78f1766a89c21c50bf90be5d989173b0466795a461c859a76fdad585c3645300efa1b9457abcf50d1c34bc8be73290a6d610e7f4d69dc2f55781f10eaff57597", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1317693c3fce5d9c815a368b0e9f150059b3c27c50d4158a495ce777c1bd48175632bbfbc412bfd4ee1ba5fbb645a4cab0441831840b4486f77c3155ee266a5b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 07:36:56.033597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 07:36:56.033920) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1469542578.310572-1838419469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 07:36:56.117089) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 07:36:56.117408) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 07:36:56.117714) ========= ========= Total master_lag: 0.14 =========